LUCI Scheduler :: chromium :: win-official

Status: SUCCEEDED

Triggered by: -

Duration: 3 hours

Actions:

Definition (rev 61da5958bb1bf61dc6dab9a9ab14fa46798b5d0f)

buildbucket: <
  server: "cr-buildbucket.appspot.com"
  bucket: "luci.chromium.ci"
  builder: "win-official"
>

Incoming triggers

cac3b83936ecc01552ea9b2fd546526f2caa6d23 (5 years ago)
66909ca8f30c1f9684fcc4909684e3aac5b74dbb (5 years ago)
5b87b3bf8ff8d0821f3f959f8d4d8c1cf20fe65d (5 years ago)
cf4751a50b0471fa0878b35de8c144bdad3e1ff4 (5 years ago)
94f624e52a876e873e72d16b1fe31ec360559175 (5 years ago)
2674c97d6102cdc9700cce0e1b0fe5f11360c3d7 (5 years ago)
98828a08df169f048baeccd328c3d637fa21478c (5 years ago)
0003c81f95d2f83a8c5cb7c62fb1d996a5082ccd (5 years ago)
faaf0c3b306322438da329c492abecc217d5bdae (5 years ago)
ae31098c26f2587a83cde699c43bc9752b3711de (5 years ago)
235e783e5ec36d40d8e554065956f03bb38f2ed5 (5 years ago)
96afe1207a340a49ebb04d67e7dccc7bf317d833 (5 years ago)
59520c2d23721b9a24a910de5d3ed2afab12472c (5 years ago)
5a73a11c67abc3b749e94008f044900b9dd84353 (5 years ago)
c107f73c7ebb32533dc7a93319a99db8404b9cfa (5 years ago)
48d3329ebb29ee3852f3e8a8b4e7b043322b06b2 (5 years ago)
8a1046230dbf8ca5ffacdf6d48e604a798f1c862 (5 years ago)
0cde3fb1474e0f781abcbb2d99bf470bb7a2684c (5 years ago)
9e67ffbbdbf676246d34b12314f14a9fe4e8015c (5 years ago)
c4ef92e09070426869f5e638ca037b8f441c42fb (5 years ago)
86a7dff6a32bc495498994756e9855404f66764c (5 years ago)
a98e835704e1c63fc7266e7ec6fabfd180334727 (5 years ago)
050b602088ecfc4fc447174b6f5ccb423efb266d (5 years ago)
45515f38ff120fd4ac1d741a220d0e6c99979c99 (5 years ago)
e2ed67929dc6b0dc5143ade12e64476196faac2b (5 years ago)
f906c6c1194a339d3ed420e2442a69b6c8ed98a3 (5 years ago)
6b36edb79a66a021486f4f69a7dd5757de644b52 (5 years ago)
36f428b4d22d6fd4f01250d1d1e68ea2c4d31cb4 (5 years ago)
0ff6cfd2ae2f17dd8f99ae09f04b0fb24fd2a09f (5 years ago)

Incoming properties

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

Incoming tags

buildset:commit/git/0ff6cfd2ae2f17dd8f99ae09f04b0fb24fd2a09f
buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0ff6cfd2ae2f17dd8f99ae09f04b0fb24fd2a09f
gitiles_ref:refs/heads/master

Debug log (UTC)

[12:57:47.005] New invocation is queued and will start shortly
[12:57:48.074] Starting the invocation (attempt 1)
[12:57:48.109] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:57:48.109] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:57:48.109] Buildbucket request:
{
  "bucket": "luci.chromium.ci",
  "client_operation_id": "9022197837561743632",
  "parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"0ff6cfd2ae2f17dd8f99ae09f04b0fb24fd2a09f\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:win-official",
    "scheduler_invocation_id:9022197837561743632",
    "scheduler_job_id:chromium/win-official",
    "user_agent:luci-scheduler",
    "buildset:commit/git/0ff6cfd2ae2f17dd8f99ae09f04b0fb24fd2a09f",
    "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0ff6cfd2ae2f17dd8f99ae09f04b0fb24fd2a09f",
    "gitiles_ref:refs/heads/master"
  ]
}
[12:57:48.808] Buildbucket response:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "created_by": "project:chromium",
    "created_ts": "1611925068229766",
    "id": "8856767775614961600",
    "parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0ff6cfd2ae2f17dd8f99ae09f04b0fb24fd2a09f\"}}",
    "project": "chromium",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1611925068641882",
    "tags": [
      "build_address:luci.chromium.ci/win-official/1492",
      "builder:win-official",
      "buildset:commit/git/0ff6cfd2ae2f17dd8f99ae09f04b0fb24fd2a09f",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0ff6cfd2ae2f17dd8f99ae09f04b0fb24fd2a09f",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9022197837561743632",
      "scheduler_job_id:chromium/win-official",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8856767775614961600/+/annotations",
      "swarming_tag:luci_project:chromium",
      "swarming_tag:recipe_name:chromium",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_task_id:",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1611925068641989",
    "url": "https://ci.chromium.org/b/8856767775614961600",
    "utcnow_ts": "1611925068800259"
  }
}
[12:57:48.808] Task URL: https://ci.chromium.org/b/8856767775614961600
[12:57:48.808] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:2:0) after 1m0s
[12:58:48.877] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:2:0)
[12:58:48.877] Timer tick, asking Buildbucket for the build status
[12:58:49.300] Build 8856767775614961600: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:58:49.300] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:3:0) after 1m0s
[12:59:49.354] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:3:0)
[12:59:49.354] Timer tick, asking Buildbucket for the build status
[12:59:49.420] Build 8856767775614961600: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:59:49.420] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:4:0) after 1m0s
[13:00:25.689] Received PubSub notification, asking Buildbucket for the build status
[13:00:25.794] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:49.440] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:4:0)
[13:00:49.440] Timer tick, asking Buildbucket for the build status
[13:00:49.648] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:49.648] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:6:0) after 1m0s
[13:01:49.711] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:6:0)
[13:01:49.711] Timer tick, asking Buildbucket for the build status
[13:01:49.854] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:49.854] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:7:0) after 1m0s
[13:02:49.919] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:7:0)
[13:02:49.919] Timer tick, asking Buildbucket for the build status
[13:02:50.414] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:50.414] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:8:0) after 1m0s
[13:03:50.443] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:8:0)
[13:03:50.443] Timer tick, asking Buildbucket for the build status
[13:03:50.509] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:50.509] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:9:0) after 1m0s
[13:04:50.526] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:9:0)
[13:04:50.526] Timer tick, asking Buildbucket for the build status
[13:04:50.618] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:50.618] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:10:0) after 1m0s
[13:05:50.675] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:10:0)
[13:05:50.675] Timer tick, asking Buildbucket for the build status
[13:05:50.760] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:50.760] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:11:0) after 1m0s
[13:06:50.834] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:11:0)
[13:06:50.834] Timer tick, asking Buildbucket for the build status
[13:06:50.920] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:50.920] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:12:0) after 1m0s
[13:07:51.000] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:12:0)
[13:07:51.000] Timer tick, asking Buildbucket for the build status
[13:07:51.113] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:51.113] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:13:0) after 1m0s
[13:08:51.141] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:13:0)
[13:08:51.141] Timer tick, asking Buildbucket for the build status
[13:08:51.342] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:51.342] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:14:0) after 1m0s
[13:09:51.403] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:14:0)
[13:09:51.403] Timer tick, asking Buildbucket for the build status
[13:09:51.466] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:51.466] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:15:0) after 1m0s
[13:10:51.539] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:15:0)
[13:10:51.539] Timer tick, asking Buildbucket for the build status
[13:10:51.645] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:51.645] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:16:0) after 1m0s
[13:11:51.703] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:16:0)
[13:11:51.703] Timer tick, asking Buildbucket for the build status
[13:11:51.793] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:51.793] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:17:0) after 1m0s
[13:12:51.912] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:17:0)
[13:12:51.912] Timer tick, asking Buildbucket for the build status
[13:12:52.043] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:52.043] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:18:0) after 1m0s
[13:13:52.068] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:18:0)
[13:13:52.068] Timer tick, asking Buildbucket for the build status
[13:13:52.144] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:52.144] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:19:0) after 1m0s
[13:14:52.152] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:19:0)
[13:14:52.152] Timer tick, asking Buildbucket for the build status
[13:14:52.425] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:52.425] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:20:0) after 1m0s
[13:15:52.507] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:20:0)
[13:15:52.507] Timer tick, asking Buildbucket for the build status
[13:15:52.815] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:52.815] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:21:0) after 1m0s
[13:16:52.889] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:21:0)
[13:16:52.889] Timer tick, asking Buildbucket for the build status
[13:16:53.038] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:53.038] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:22:0) after 1m0s
[13:17:53.067] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:22:0)
[13:17:53.067] Timer tick, asking Buildbucket for the build status
[13:17:53.161] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:53.161] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:23:0) after 1m0s
[13:18:53.266] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:23:0)
[13:18:53.266] Timer tick, asking Buildbucket for the build status
[13:18:53.501] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:53.501] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:24:0) after 1m0s
[13:19:53.593] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:24:0)
[13:19:53.593] Timer tick, asking Buildbucket for the build status
[13:19:53.662] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:53.662] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:25:0) after 1m0s
[13:20:53.736] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:25:0)
[13:20:53.736] Timer tick, asking Buildbucket for the build status
[13:20:53.807] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:53.807] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:26:0) after 1m0s
[13:21:53.827] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:26:0)
[13:21:53.827] Timer tick, asking Buildbucket for the build status
[13:21:53.884] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:53.884] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:27:0) after 1m0s
[13:22:53.950] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:27:0)
[13:22:53.950] Timer tick, asking Buildbucket for the build status
[13:22:54.065] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:54.065] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:28:0) after 1m0s
[13:23:54.076] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:28:0)
[13:23:54.076] Timer tick, asking Buildbucket for the build status
[13:23:54.131] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:54.131] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:29:0) after 1m0s
[13:24:54.192] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:29:0)
[13:24:54.192] Timer tick, asking Buildbucket for the build status
[13:24:54.289] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:54.289] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:30:0) after 1m0s
[13:25:54.312] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:30:0)
[13:25:54.312] Timer tick, asking Buildbucket for the build status
[13:25:54.606] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:54.606] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:31:0) after 1m0s
[13:26:54.671] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:31:0)
[13:26:54.671] Timer tick, asking Buildbucket for the build status
[13:26:54.768] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:54.768] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:32:0) after 1m0s
[13:27:54.806] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:32:0)
[13:27:54.806] Timer tick, asking Buildbucket for the build status
[13:27:54.920] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:54.920] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:33:0) after 1m0s
[13:28:54.944] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:33:0)
[13:28:54.944] Timer tick, asking Buildbucket for the build status
[13:28:55.004] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:55.004] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:34:0) after 1m0s
[13:29:55.026] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:34:0)
[13:29:55.026] Timer tick, asking Buildbucket for the build status
[13:29:55.610] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:55.610] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:35:0) after 1m0s
[13:30:55.707] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:35:0)
[13:30:55.707] Timer tick, asking Buildbucket for the build status
[13:30:55.782] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:55.782] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:36:0) after 1m0s
[13:31:55.909] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:36:0)
[13:31:55.909] Timer tick, asking Buildbucket for the build status
[13:31:55.971] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:55.971] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:37:0) after 1m0s
[13:32:56.180] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:37:0)
[13:32:56.180] Timer tick, asking Buildbucket for the build status
[13:32:56.284] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:56.284] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:38:0) after 1m0s
[13:33:56.346] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:38:0)
[13:33:56.346] Timer tick, asking Buildbucket for the build status
[13:33:56.418] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:56.418] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:39:0) after 1m0s
[13:34:56.507] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:39:0)
[13:34:56.507] Timer tick, asking Buildbucket for the build status
[13:34:56.619] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:56.619] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:40:0) after 1m0s
[13:35:56.613] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:40:0)
[13:35:56.613] Timer tick, asking Buildbucket for the build status
[13:35:56.954] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:56.954] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:41:0) after 1m0s
[13:36:57.087] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:41:0)
[13:36:57.087] Timer tick, asking Buildbucket for the build status
[13:36:57.192] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:57.192] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:42:0) after 1m0s
[13:37:57.249] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:42:0)
[13:37:57.249] Timer tick, asking Buildbucket for the build status
[13:37:57.337] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:57.337] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:43:0) after 1m0s
[13:38:57.428] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:43:0)
[13:38:57.428] Timer tick, asking Buildbucket for the build status
[13:38:57.549] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:57.549] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:44:0) after 1m0s
[13:39:57.712] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:44:0)
[13:39:57.712] Timer tick, asking Buildbucket for the build status
[13:39:57.874] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:57.874] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:45:0) after 1m0s
[13:40:57.983] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:45:0)
[13:40:57.983] Timer tick, asking Buildbucket for the build status
[13:40:58.057] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:58.057] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:46:0) after 1m0s
[13:41:58.080] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:46:0)
[13:41:58.080] Timer tick, asking Buildbucket for the build status
[13:41:58.158] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:58.158] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:47:0) after 1m0s
[13:42:58.275] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:47:0)
[13:42:58.275] Timer tick, asking Buildbucket for the build status
[13:42:58.415] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:58.415] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:48:0) after 1m0s
[13:43:58.521] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:48:0)
[13:43:58.521] Timer tick, asking Buildbucket for the build status
[13:43:58.587] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:58.587] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:49:0) after 1m0s
[13:44:58.620] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:49:0)
[13:44:58.620] Timer tick, asking Buildbucket for the build status
[13:44:58.694] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:58.695] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:50:0) after 1m0s
[13:45:58.849] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:50:0)
[13:45:58.849] Timer tick, asking Buildbucket for the build status
[13:45:58.913] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:58.913] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:51:0) after 1m0s
[13:46:58.961] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:51:0)
[13:46:58.961] Timer tick, asking Buildbucket for the build status
[13:46:59.261] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:59.261] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:52:0) after 1m0s
[13:47:59.407] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:52:0)
[13:47:59.407] Timer tick, asking Buildbucket for the build status
[13:47:59.896] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:59.896] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:53:0) after 1m0s
[13:48:59.961] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:53:0)
[13:48:59.961] Timer tick, asking Buildbucket for the build status
[13:49:00.077] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:00.077] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:54:0) after 1m0s
[13:50:00.166] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:54:0)
[13:50:00.166] Timer tick, asking Buildbucket for the build status
[13:50:00.323] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:00.323] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:55:0) after 1m0s
[13:51:00.332] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:55:0)
[13:51:00.332] Timer tick, asking Buildbucket for the build status
[13:51:00.543] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:00.543] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:56:0) after 1m0s
[13:52:00.522] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:56:0)
[13:52:00.522] Timer tick, asking Buildbucket for the build status
[13:52:00.793] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:00.793] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:57:0) after 1m0s
[13:53:01.242] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:57:0)
[13:53:01.242] Timer tick, asking Buildbucket for the build status
[13:53:01.449] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:01.449] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:58:0) after 1m0s
[13:54:01.577] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:58:0)
[13:54:01.578] Timer tick, asking Buildbucket for the build status
[13:54:01.804] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:01.804] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:59:0) after 1m0s
[13:55:01.999] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:59:0)
[13:55:01.999] Timer tick, asking Buildbucket for the build status
[13:55:02.082] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:02.082] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:60:0) after 1m0s
[13:56:02.089] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:60:0)
[13:56:02.089] Timer tick, asking Buildbucket for the build status
[13:56:02.565] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:02.565] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:61:0) after 1m0s
[13:57:02.709] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:61:0)
[13:57:02.709] Timer tick, asking Buildbucket for the build status
[13:57:02.830] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:02.830] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:62:0) after 1m0s
[13:58:02.877] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:62:0)
[13:58:02.877] Timer tick, asking Buildbucket for the build status
[13:58:02.992] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:02.992] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:63:0) after 1m0s
[13:59:03.083] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:63:0)
[13:59:03.084] Timer tick, asking Buildbucket for the build status
[13:59:03.195] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:03.195] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:64:0) after 1m0s
[14:00:03.305] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:64:0)
[14:00:03.305] Timer tick, asking Buildbucket for the build status
[14:00:03.704] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:03.704] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:65:0) after 1m0s
[14:01:03.740] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:65:0)
[14:01:03.740] Timer tick, asking Buildbucket for the build status
[14:01:03.880] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:03.880] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:66:0) after 1m0s
[14:02:03.861] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:66:0)
[14:02:03.861] Timer tick, asking Buildbucket for the build status
[14:02:04.014] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:04.014] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:67:0) after 1m0s
[14:03:04.044] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:67:0)
[14:03:04.044] Timer tick, asking Buildbucket for the build status
[14:03:04.179] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:04.179] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:68:0) after 1m0s
[14:04:04.255] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:68:0)
[14:04:04.255] Timer tick, asking Buildbucket for the build status
[14:04:04.524] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:04.524] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:69:0) after 1m0s
[14:05:04.557] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:69:0)
[14:05:04.557] Timer tick, asking Buildbucket for the build status
[14:05:04.632] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:04.632] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:70:0) after 1m0s
[14:06:04.719] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:70:0)
[14:06:04.719] Timer tick, asking Buildbucket for the build status
[14:06:04.780] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:04.781] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:71:0) after 1m0s
[14:07:04.836] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:71:0)
[14:07:04.836] Timer tick, asking Buildbucket for the build status
[14:07:05.017] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:05.017] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:72:0) after 1m0s
[14:08:05.177] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:72:0)
[14:08:05.177] Timer tick, asking Buildbucket for the build status
[14:08:05.308] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:05.308] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:73:0) after 1m0s
[14:09:05.422] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:73:0)
[14:09:05.422] Timer tick, asking Buildbucket for the build status
[14:09:05.631] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:05.631] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:74:0) after 1m0s
[14:10:05.699] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:74:0)
[14:10:05.699] Timer tick, asking Buildbucket for the build status
[14:10:05.765] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:05.765] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:75:0) after 1m0s
[14:11:06.262] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:75:0)
[14:11:06.262] Timer tick, asking Buildbucket for the build status
[14:11:06.409] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:06.409] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:76:0) after 1m0s
[14:12:06.476] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:76:0)
[14:12:06.476] Timer tick, asking Buildbucket for the build status
[14:12:06.540] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:06.540] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:77:0) after 1m0s
[14:13:06.614] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:77:0)
[14:13:06.614] Timer tick, asking Buildbucket for the build status
[14:13:06.735] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:06.735] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:78:0) after 1m0s
[14:14:06.799] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:78:0)
[14:14:06.799] Timer tick, asking Buildbucket for the build status
[14:14:06.868] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:06.868] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:79:0) after 1m0s
[14:15:06.916] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:79:0)
[14:15:06.916] Timer tick, asking Buildbucket for the build status
[14:15:06.966] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:06.966] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:80:0) after 1m0s
[14:16:07.213] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:80:0)
[14:16:07.213] Timer tick, asking Buildbucket for the build status
[14:16:07.287] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:07.287] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:81:0) after 1m0s
[14:17:07.344] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:81:0)
[14:17:07.344] Timer tick, asking Buildbucket for the build status
[14:17:07.408] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:07.408] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:82:0) after 1m0s
[14:18:07.488] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:82:0)
[14:18:07.488] Timer tick, asking Buildbucket for the build status
[14:18:08.425] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:08.425] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:83:0) after 1m0s
[14:19:08.499] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:83:0)
[14:19:08.499] Timer tick, asking Buildbucket for the build status
[14:19:08.596] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:08.596] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:84:0) after 1m0s
[14:20:08.737] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:84:0)
[14:20:08.737] Timer tick, asking Buildbucket for the build status
[14:20:08.804] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:08.804] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:85:0) after 1m0s
[14:21:08.939] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:85:0)
[14:21:08.939] Timer tick, asking Buildbucket for the build status
[14:21:08.997] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:08.997] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:86:0) after 1m0s
[14:22:09.162] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:86:0)
[14:22:09.162] Timer tick, asking Buildbucket for the build status
[14:22:09.229] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:09.229] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:87:0) after 1m0s
[14:23:09.230] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:87:0)
[14:23:09.230] Timer tick, asking Buildbucket for the build status
[14:23:09.342] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:09.342] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:88:0) after 1m0s
[14:24:09.597] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:88:0)
[14:24:09.597] Timer tick, asking Buildbucket for the build status
[14:24:09.654] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:09.654] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:89:0) after 1m0s
[14:25:09.739] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:89:0)
[14:25:09.739] Timer tick, asking Buildbucket for the build status
[14:25:09.923] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:09.923] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:90:0) after 1m0s
[14:26:10.037] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:90:0)
[14:26:10.037] Timer tick, asking Buildbucket for the build status
[14:26:10.129] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:10.129] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:91:0) after 1m0s
[14:27:10.425] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:91:0)
[14:27:10.425] Timer tick, asking Buildbucket for the build status
[14:27:10.728] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:10.728] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:92:0) after 1m0s
[14:28:10.848] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:92:0)
[14:28:10.848] Timer tick, asking Buildbucket for the build status
[14:28:10.936] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:10.936] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:93:0) after 1m0s
[14:29:11.025] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:93:0)
[14:29:11.025] Timer tick, asking Buildbucket for the build status
[14:29:11.078] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:11.078] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:94:0) after 1m0s
[14:30:11.200] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:94:0)
[14:30:11.200] Timer tick, asking Buildbucket for the build status
[14:30:11.267] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:11.267] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:95:0) after 1m0s
[14:31:11.345] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:95:0)
[14:31:11.345] Timer tick, asking Buildbucket for the build status
[14:31:11.404] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:11.404] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:96:0) after 1m0s
[14:32:11.516] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:96:0)
[14:32:11.516] Timer tick, asking Buildbucket for the build status
[14:32:11.593] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:11.593] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:97:0) after 1m0s
[14:33:12.100] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:97:0)
[14:33:12.100] Timer tick, asking Buildbucket for the build status
[14:33:12.446] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:12.446] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:98:0) after 1m0s
[14:34:12.718] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:98:0)
[14:34:12.718] Timer tick, asking Buildbucket for the build status
[14:34:12.841] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:12.841] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:99:0) after 1m0s
[14:35:13.033] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:99:0)
[14:35:13.033] Timer tick, asking Buildbucket for the build status
[14:35:13.096] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:13.096] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:100:0) after 1m0s
[14:36:13.246] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:100:0)
[14:36:13.246] Timer tick, asking Buildbucket for the build status
[14:36:13.350] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:13.350] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:101:0) after 1m0s
[14:37:13.623] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:101:0)
[14:37:13.623] Timer tick, asking Buildbucket for the build status
[14:37:13.812] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:13.812] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:102:0) after 1m0s
[14:38:13.892] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:102:0)
[14:38:13.892] Timer tick, asking Buildbucket for the build status
[14:38:15.055] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:15.055] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:103:0) after 1m0s
[14:39:15.182] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:103:0)
[14:39:15.182] Timer tick, asking Buildbucket for the build status
[14:39:15.240] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:15.240] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:104:0) after 1m0s
[14:40:15.382] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:104:0)
[14:40:15.382] Timer tick, asking Buildbucket for the build status
[14:40:15.808] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:15.808] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:105:0) after 1m0s
[14:41:16.131] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:105:0)
[14:41:16.131] Timer tick, asking Buildbucket for the build status
[14:41:16.612] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:16.612] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:106:0) after 1m0s
[14:42:16.759] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:106:0)
[14:42:16.759] Timer tick, asking Buildbucket for the build status
[14:42:16.847] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:16.847] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:107:0) after 1m0s
[14:43:17.113] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:107:0)
[14:43:17.113] Timer tick, asking Buildbucket for the build status
[14:43:17.248] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:17.248] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:108:0) after 1m0s
[14:44:17.361] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:108:0)
[14:44:17.361] Timer tick, asking Buildbucket for the build status
[14:44:17.439] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:17.439] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:109:0) after 1m0s
[14:45:17.536] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:109:0)
[14:45:17.536] Timer tick, asking Buildbucket for the build status
[14:45:17.613] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:17.613] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:110:0) after 1m0s
[14:46:17.715] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:110:0)
[14:46:17.715] Timer tick, asking Buildbucket for the build status
[14:46:17.863] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:17.863] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:111:0) after 1m0s
[14:47:17.908] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:111:0)
[14:47:17.908] Timer tick, asking Buildbucket for the build status
[14:47:18.141] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:18.141] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:112:0) after 1m0s
[14:48:18.252] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:112:0)
[14:48:18.252] Timer tick, asking Buildbucket for the build status
[14:48:18.379] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:18.379] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:113:0) after 1m0s
[14:49:18.528] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:113:0)
[14:49:18.528] Timer tick, asking Buildbucket for the build status
[14:49:18.587] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:18.587] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:114:0) after 1m0s
[14:50:18.624] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:114:0)
[14:50:18.624] Timer tick, asking Buildbucket for the build status
[14:50:18.683] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:18.683] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:115:0) after 1m0s
[14:51:18.998] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:115:0)
[14:51:18.998] Timer tick, asking Buildbucket for the build status
[14:51:19.067] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:19.067] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:116:0) after 1m0s
[14:52:19.203] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:116:0)
[14:52:19.203] Timer tick, asking Buildbucket for the build status
[14:52:19.309] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:19.309] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:117:0) after 1m0s
[14:53:19.401] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:117:0)
[14:53:19.401] Timer tick, asking Buildbucket for the build status
[14:53:19.512] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:19.512] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:118:0) after 1m0s
[14:54:19.559] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:118:0)
[14:54:19.559] Timer tick, asking Buildbucket for the build status
[14:54:19.623] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:19.623] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:119:0) after 1m0s
[14:55:19.705] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:119:0)
[14:55:19.705] Timer tick, asking Buildbucket for the build status
[14:55:19.817] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:19.817] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:120:0) after 1m0s
[14:56:19.901] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:120:0)
[14:56:19.901] Timer tick, asking Buildbucket for the build status
[14:56:20.117] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:20.117] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:121:0) after 1m0s
[14:57:20.263] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:121:0)
[14:57:20.263] Timer tick, asking Buildbucket for the build status
[14:57:20.335] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:20.335] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:122:0) after 1m0s
[14:58:20.381] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:122:0)
[14:58:20.381] Timer tick, asking Buildbucket for the build status
[14:58:20.605] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:20.605] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:123:0) after 1m0s
[14:59:20.768] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:123:0)
[14:59:20.768] Timer tick, asking Buildbucket for the build status
[14:59:20.845] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:20.845] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:124:0) after 1m0s
[15:00:20.955] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:124:0)
[15:00:20.955] Timer tick, asking Buildbucket for the build status
[15:00:21.025] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:21.025] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:125:0) after 1m0s
[15:01:21.085] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:125:0)
[15:01:21.085] Timer tick, asking Buildbucket for the build status
[15:01:21.472] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:21.472] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:126:0) after 1m0s
[15:02:21.578] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:126:0)
[15:02:21.578] Timer tick, asking Buildbucket for the build status
[15:02:21.663] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:21.663] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:127:0) after 1m0s
[15:03:21.780] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:127:0)
[15:03:21.780] Timer tick, asking Buildbucket for the build status
[15:03:22.377] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:22.377] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:128:0) after 1m0s
[15:04:22.432] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:128:0)
[15:04:22.432] Timer tick, asking Buildbucket for the build status
[15:04:22.550] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:22.550] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:129:0) after 1m0s
[15:05:22.608] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:129:0)
[15:05:22.608] Timer tick, asking Buildbucket for the build status
[15:05:22.692] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:22.692] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:130:0) after 1m0s
[15:06:22.759] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:130:0)
[15:06:22.759] Timer tick, asking Buildbucket for the build status
[15:06:23.068] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:23.068] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:131:0) after 1m0s
[15:07:23.112] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:131:0)
[15:07:23.112] Timer tick, asking Buildbucket for the build status
[15:07:23.211] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:23.211] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:132:0) after 1m0s
[15:08:23.236] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:132:0)
[15:08:23.236] Timer tick, asking Buildbucket for the build status
[15:08:23.425] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:23.425] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:133:0) after 1m0s
[15:09:23.555] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:133:0)
[15:09:23.555] Timer tick, asking Buildbucket for the build status
[15:09:23.622] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:23.622] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:134:0) after 1m0s
[15:10:23.819] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:134:0)
[15:10:23.819] Timer tick, asking Buildbucket for the build status
[15:10:23.996] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:23.996] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:135:0) after 1m0s
[15:11:24.091] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:135:0)
[15:11:24.091] Timer tick, asking Buildbucket for the build status
[15:11:24.155] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:24.155] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:136:0) after 1m0s
[15:12:24.231] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:136:0)
[15:12:24.231] Timer tick, asking Buildbucket for the build status
[15:12:25.010] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:25.010] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:137:0) after 1m0s
[15:13:25.424] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:137:0)
[15:13:25.424] Timer tick, asking Buildbucket for the build status
[15:13:25.669] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:25.669] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:138:0) after 1m0s
[15:14:25.995] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:138:0)
[15:14:25.995] Timer tick, asking Buildbucket for the build status
[15:14:26.143] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:26.143] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:139:0) after 1m0s
[15:15:26.300] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:139:0)
[15:15:26.300] Timer tick, asking Buildbucket for the build status
[15:15:26.418] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:26.418] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:140:0) after 1m0s
[15:16:26.638] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:140:0)
[15:16:26.638] Timer tick, asking Buildbucket for the build status
[15:16:26.859] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:26.859] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:141:0) after 1m0s
[15:17:27.064] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:141:0)
[15:17:27.064] Timer tick, asking Buildbucket for the build status
[15:17:27.131] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:27.131] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:142:0) after 1m0s
[15:18:27.393] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:142:0)
[15:18:27.393] Timer tick, asking Buildbucket for the build status
[15:18:27.526] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:27.526] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:143:0) after 1m0s
[15:19:27.646] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:143:0)
[15:19:27.646] Timer tick, asking Buildbucket for the build status
[15:19:27.713] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:27.713] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:144:0) after 1m0s
[15:20:27.946] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:144:0)
[15:20:27.946] Timer tick, asking Buildbucket for the build status
[15:20:28.045] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:28.045] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:145:0) after 1m0s
[15:21:28.124] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:145:0)
[15:21:28.124] Timer tick, asking Buildbucket for the build status
[15:21:28.538] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:28.538] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:146:0) after 1m0s
[15:22:28.649] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:146:0)
[15:22:28.649] Timer tick, asking Buildbucket for the build status
[15:22:28.701] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:28.703] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:147:0) after 1m0s
[15:23:28.752] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:147:0)
[15:23:28.752] Timer tick, asking Buildbucket for the build status
[15:23:28.860] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:28.860] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:148:0) after 1m0s
[15:24:28.898] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:148:0)
[15:24:28.898] Timer tick, asking Buildbucket for the build status
[15:24:29.102] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:29.102] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:149:0) after 1m0s
[15:25:29.137] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:149:0)
[15:25:29.137] Timer tick, asking Buildbucket for the build status
[15:25:29.212] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:29.212] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:150:0) after 1m0s
[15:26:29.282] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:150:0)
[15:26:29.282] Timer tick, asking Buildbucket for the build status
[15:26:29.342] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:29.342] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:151:0) after 1m0s
[15:27:29.498] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:151:0)
[15:27:29.498] Timer tick, asking Buildbucket for the build status
[15:27:29.565] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:29.565] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:152:0) after 1m0s
[15:28:29.614] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:152:0)
[15:28:29.614] Timer tick, asking Buildbucket for the build status
[15:28:29.697] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:29.697] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:153:0) after 1m0s
[15:29:29.882] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:153:0)
[15:29:29.882] Timer tick, asking Buildbucket for the build status
[15:29:30.374] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:30.374] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:154:0) after 1m0s
[15:30:30.403] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:154:0)
[15:30:30.403] Timer tick, asking Buildbucket for the build status
[15:30:30.594] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:30.594] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:155:0) after 1m0s
[15:31:30.723] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:155:0)
[15:31:30.723] Timer tick, asking Buildbucket for the build status
[15:31:30.800] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:30.800] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:156:0) after 1m0s
[15:32:30.951] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:156:0)
[15:32:30.951] Timer tick, asking Buildbucket for the build status
[15:32:31.007] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:31.007] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:157:0) after 1m0s
[15:33:31.164] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:157:0)
[15:33:31.164] Timer tick, asking Buildbucket for the build status
[15:33:31.275] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:31.275] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:158:0) after 1m0s
[15:34:31.345] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:158:0)
[15:34:31.345] Timer tick, asking Buildbucket for the build status
[15:34:31.449] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:31.449] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:159:0) after 1m0s
[15:35:31.469] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:159:0)
[15:35:31.469] Timer tick, asking Buildbucket for the build status
[15:35:31.556] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:31.556] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:160:0) after 1m0s
[15:36:31.660] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:160:0)
[15:36:31.660] Timer tick, asking Buildbucket for the build status
[15:36:31.759] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:31.759] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:161:0) after 1m0s
[15:37:31.786] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:161:0)
[15:37:31.786] Timer tick, asking Buildbucket for the build status
[15:37:32.497] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:32.497] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:162:0) after 1m0s
[15:38:32.600] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:162:0)
[15:38:32.600] Timer tick, asking Buildbucket for the build status
[15:38:32.771] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:32.771] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:163:0) after 1m0s
[15:39:32.778] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:163:0)
[15:39:32.778] Timer tick, asking Buildbucket for the build status
[15:39:32.971] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:32.971] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:164:0) after 1m0s
[15:40:33.042] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:164:0)
[15:40:33.042] Timer tick, asking Buildbucket for the build status
[15:40:33.477] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:33.477] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:165:0) after 1m0s
[15:41:33.550] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:165:0)
[15:41:33.550] Timer tick, asking Buildbucket for the build status
[15:41:33.672] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:33.672] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:166:0) after 1m0s
[15:42:33.702] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:166:0)
[15:42:33.702] Timer tick, asking Buildbucket for the build status
[15:42:33.767] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:33.767] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:167:0) after 1m0s
[15:43:33.821] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:167:0)
[15:43:33.821] Timer tick, asking Buildbucket for the build status
[15:43:33.937] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:33.937] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:168:0) after 1m0s
[15:44:33.976] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:168:0)
[15:44:33.976] Timer tick, asking Buildbucket for the build status
[15:44:34.031] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:34.031] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:169:0) after 1m0s
[15:45:34.066] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:169:0)
[15:45:34.067] Timer tick, asking Buildbucket for the build status
[15:45:34.175] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:34.175] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:170:0) after 1m0s
[15:46:34.274] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:170:0)
[15:46:34.274] Timer tick, asking Buildbucket for the build status
[15:46:34.359] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:34.359] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:171:0) after 1m0s
[15:47:34.579] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:171:0)
[15:47:34.579] Timer tick, asking Buildbucket for the build status
[15:47:34.749] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:34.749] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:172:0) after 1m0s
[15:48:34.787] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:172:0)
[15:48:34.787] Timer tick, asking Buildbucket for the build status
[15:48:35.462] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:35.462] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:173:0) after 1m0s
[15:49:35.518] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:173:0)
[15:49:35.518] Timer tick, asking Buildbucket for the build status
[15:49:35.573] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:35.573] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:174:0) after 1m0s
[15:50:35.595] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:174:0)
[15:50:35.595] Timer tick, asking Buildbucket for the build status
[15:50:35.728] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:35.728] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:175:0) after 1m0s
[15:51:35.822] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:175:0)
[15:51:35.822] Timer tick, asking Buildbucket for the build status
[15:51:35.970] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:35.970] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:176:0) after 1m0s
[15:52:36.014] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:176:0)
[15:52:36.014] Timer tick, asking Buildbucket for the build status
[15:52:36.417] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:36.417] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:177:0) after 1m0s
[15:53:36.463] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:177:0)
[15:53:36.463] Timer tick, asking Buildbucket for the build status
[15:53:36.624] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:36.624] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:178:0) after 1m0s
[15:54:36.650] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:178:0)
[15:54:36.650] Timer tick, asking Buildbucket for the build status
[15:54:36.717] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:36.717] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:179:0) after 1m0s
[15:55:36.746] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:179:0)
[15:55:36.746] Timer tick, asking Buildbucket for the build status
[15:55:36.816] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:36.816] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:180:0) after 1m0s
[15:56:36.903] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:180:0)
[15:56:36.903] Timer tick, asking Buildbucket for the build status
[15:56:36.981] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:36.982] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:181:0) after 1m0s
[15:57:37.118] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:181:0)
[15:57:37.118] Timer tick, asking Buildbucket for the build status
[15:57:37.178] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:37.178] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:182:0) after 1m0s
[15:58:37.258] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:182:0)
[15:58:37.259] Timer tick, asking Buildbucket for the build status
[15:58:37.349] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:37.349] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:183:0) after 1m0s
[15:59:37.487] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:183:0)
[15:59:37.487] Timer tick, asking Buildbucket for the build status
[15:59:37.544] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:37.544] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:184:0) after 1m0s
[16:00:37.653] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:184:0)
[16:00:37.653] Timer tick, asking Buildbucket for the build status
[16:00:37.768] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:37.768] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:185:0) after 1m0s
[16:01:37.801] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:185:0)
[16:01:37.801] Timer tick, asking Buildbucket for the build status
[16:01:38.019] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:38.019] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:186:0) after 1m0s
[16:02:38.240] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:186:0)
[16:02:38.240] Timer tick, asking Buildbucket for the build status
[16:02:38.618] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:38.618] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:187:0) after 1m0s
[16:03:38.703] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:187:0)
[16:03:38.703] Timer tick, asking Buildbucket for the build status
[16:03:38.799] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:38.799] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:188:0) after 1m0s
[16:04:38.940] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:188:0)
[16:04:38.940] Timer tick, asking Buildbucket for the build status
[16:04:39.008] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:39.008] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:189:0) after 1m0s
[16:05:39.023] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:189:0)
[16:05:39.023] Timer tick, asking Buildbucket for the build status
[16:05:39.216] Build 8856767775614961600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:39.216] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022197837561743632:190:0) after 1m0s
[16:06:33.581] Received PubSub notification, asking Buildbucket for the build status
[16:06:33.732] Build 8856767775614961600: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:06:33.733] Buildbucket build:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "completed_ts": "1611936392554071",
    "created_by": "project:chromium",
    "created_ts": "1611925068229766",
    "id": "8856767775614961600",
    "parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0ff6cfd2ae2f17dd8f99ae09f04b0fb24fd2a09f\"}}",
    "project": "chromium",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"0ff6cfd2ae2f17dd8f99ae09f04b0fb24fd2a09f\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"win-dbg-0-89yk\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 1492, \"got_angle_revision\": \"e419222d82cff7286ccc368932bf0fbb5d31d9e9\", \"got_dawn_revision\": \"c1d3a66bd217395a501543b09c6d2c25e9d2e22e\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"0ff6cfd2ae2f17dd8f99ae09f04b0fb24fd2a09f\", \"got_revision_cp\": \"refs/heads/master@{#848482}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"3e9b79ff42de0f5547809354de89e24c7a439e39\", \"got_v8_revision\": \"89b433d7c3defd04809fba9deb6f8885160044a4\", \"got_v8_revision_cp\": \"refs/heads/9.0.100@{#1}\", \"got_webrtc_revision\": \"54b925cfc2cd7c2f8f83e8e484f281aa87b92dfc\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33090}\", \"mirrored_builders\": [\"tryserver.chromium:win-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0ff6cfd2ae2f17dd8f99ae09f04b0fb24fd2a09f\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_9b3ebe5fd1c5be87380c40d216747346a59b28cf26de183f0e8e2b32e944d3c8_v2\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-0-89yk\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5673-2413400\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1611925224566914",
    "status": "COMPLETED",
    "status_changed_ts": "1611936392887951",
    "tags": [
      "build_address:luci.chromium.ci/win-official/1492",
      "builder:win-official",
      "buildset:commit/git/0ff6cfd2ae2f17dd8f99ae09f04b0fb24fd2a09f",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0ff6cfd2ae2f17dd8f99ae09f04b0fb24fd2a09f",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9022197837561743632",
      "scheduler_job_id:chromium/win-official",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8856767775614961600/+/annotations",
      "swarming_tag:luci_project:chromium",
      "swarming_tag:os:Windows",
      "swarming_tag:recipe_name:chromium",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_task_id:51670a2576a93d10",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1611936392912014",
    "url": "https://ci.chromium.org/b/8856767775614961600",
    "utcnow_ts": "1611936393718953"
  }
}
[16:06:33.734] Invocation finished in 3h8m46.744849282s with status SUCCEEDED