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

Definition (rev 835dd06986af6863f902c628becb4df908d0fc20)

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

Incoming triggers

Incoming properties

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

Incoming tags

  • buildset:commit/git/56a6918ec9bdabcb87bb87d4950e61d1d8ef5a33
  • buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/56a6918ec9bdabcb87bb87d4950e61d1d8ef5a33
  • gitiles_ref:refs/heads/master

Debug log (UTC)

[00:27:02.714] New invocation is queued and will start shortly
[00:27:03.762] Starting the invocation (attempt 1)
[00:27:03.820] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:27:03.824] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:27:03.824] Buildbucket request:
{
  "bucket": "luci.chromium.ci",
  "client_operation_id": "9021882682065495136",
  "parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"56a6918ec9bdabcb87bb87d4950e61d1d8ef5a33\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:win-official",
    "scheduler_invocation_id:9021882682065495136",
    "scheduler_job_id:chromium/win-official",
    "user_agent:luci-scheduler",
    "buildset:commit/git/56a6918ec9bdabcb87bb87d4950e61d1d8ef5a33",
    "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/56a6918ec9bdabcb87bb87d4950e61d1d8ef5a33",
    "gitiles_ref:refs/heads/master"
  ]
}
[00:27:04.501] Buildbucket response:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "created_by": "project:chromium",
    "created_ts": "1612225623923685",
    "id": "8856452620127924224",
    "parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"56a6918ec9bdabcb87bb87d4950e61d1d8ef5a33\"}}",
    "project": "chromium",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1612225624325715",
    "tags": [
      "build_address:luci.chromium.ci/win-official/1515",
      "builder:win-official",
      "buildset:commit/git/56a6918ec9bdabcb87bb87d4950e61d1d8ef5a33",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/56a6918ec9bdabcb87bb87d4950e61d1d8ef5a33",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9021882682065495136",
      "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/8856452620127924224/+/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": "1612225624326077",
    "url": "https://ci.chromium.org/b/8856452620127924224",
    "utcnow_ts": "1612225624482812"
  }
}
[00:27:04.501] Task URL: https://ci.chromium.org/b/8856452620127924224
[00:27:04.501] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:2:0) after 1m0s
[00:27:58.444] Received PubSub notification, asking Buildbucket for the build status
[00:27:58.560] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:04.515] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:2:0)
[00:28:04.515] Timer tick, asking Buildbucket for the build status
[00:28:04.593] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:04.593] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:4:0) after 1m0s
[00:29:04.690] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:4:0)
[00:29:04.690] Timer tick, asking Buildbucket for the build status
[00:29:04.782] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:04.782] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:5:0) after 1m0s
[00:30:04.839] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:5:0)
[00:30:04.839] Timer tick, asking Buildbucket for the build status
[00:30:05.420] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:05.420] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:6:0) after 1m0s
[00:31:05.520] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:6:0)
[00:31:05.520] Timer tick, asking Buildbucket for the build status
[00:31:05.614] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:05.614] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:7:0) after 1m0s
[00:32:05.663] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:7:0)
[00:32:05.663] Timer tick, asking Buildbucket for the build status
[00:32:05.761] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:05.761] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:8:0) after 1m0s
[00:33:05.808] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:8:0)
[00:33:05.808] Timer tick, asking Buildbucket for the build status
[00:33:05.922] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:05.922] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:9:0) after 1m0s
[00:34:06.013] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:9:0)
[00:34:06.013] Timer tick, asking Buildbucket for the build status
[00:34:06.226] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:06.226] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:10:0) after 1m0s
[00:35:06.258] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:10:0)
[00:35:06.258] Timer tick, asking Buildbucket for the build status
[00:35:06.340] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:06.340] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:11:0) after 1m0s
[00:36:06.313] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:11:0)
[00:36:06.313] Timer tick, asking Buildbucket for the build status
[00:36:06.405] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:06.405] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:12:0) after 1m0s
[00:37:06.500] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:12:0)
[00:37:06.500] Timer tick, asking Buildbucket for the build status
[00:37:06.662] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:06.662] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:13:0) after 1m0s
[00:38:06.733] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:13:0)
[00:38:06.733] Timer tick, asking Buildbucket for the build status
[00:38:06.919] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:06.919] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:14:0) after 1m0s
[00:39:06.982] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:14:0)
[00:39:06.983] Timer tick, asking Buildbucket for the build status
[00:39:07.060] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:07.060] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:15:0) after 1m0s
[00:40:07.287] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:15:0)
[00:40:07.287] Timer tick, asking Buildbucket for the build status
[00:40:07.383] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:07.383] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:16:0) after 1m0s
[00:41:07.587] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:16:0)
[00:41:07.587] Timer tick, asking Buildbucket for the build status
[00:41:07.719] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:07.719] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:17:0) after 1m0s
[00:42:07.927] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:17:0)
[00:42:07.927] Timer tick, asking Buildbucket for the build status
[00:42:08.053] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:08.053] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:18:0) after 1m0s
[00:43:08.236] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:18:0)
[00:43:08.236] Timer tick, asking Buildbucket for the build status
[00:43:08.428] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:08.428] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:19:0) after 1m0s
[00:44:08.473] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:19:0)
[00:44:08.474] Timer tick, asking Buildbucket for the build status
[00:44:09.455] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:09.455] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:20:0) after 1m0s
[00:45:09.527] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:20:0)
[00:45:09.527] Timer tick, asking Buildbucket for the build status
[00:45:09.593] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:09.593] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:21:0) after 1m0s
[00:46:09.629] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:21:0)
[00:46:09.629] Timer tick, asking Buildbucket for the build status
[00:46:09.769] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:09.769] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:22:0) after 1m0s
[00:47:09.790] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:22:0)
[00:47:09.790] Timer tick, asking Buildbucket for the build status
[00:47:09.995] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:09.995] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:23:0) after 1m0s
[00:48:09.992] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:23:0)
[00:48:09.992] Timer tick, asking Buildbucket for the build status
[00:48:10.204] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:10.204] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:24:0) after 1m0s
[00:49:10.245] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:24:0)
[00:49:10.245] Timer tick, asking Buildbucket for the build status
[00:49:10.325] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:10.325] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:25:0) after 1m0s
[00:50:10.340] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:25:0)
[00:50:10.340] Timer tick, asking Buildbucket for the build status
[00:50:10.405] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:10.405] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:26:0) after 1m0s
[00:51:10.541] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:26:0)
[00:51:10.541] Timer tick, asking Buildbucket for the build status
[00:51:10.902] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:10.902] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:27:0) after 1m0s
[00:52:10.900] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:27:0)
[00:52:10.900] Timer tick, asking Buildbucket for the build status
[00:52:11.033] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:11.033] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:28:0) after 1m0s
[00:53:11.125] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:28:0)
[00:53:11.125] Timer tick, asking Buildbucket for the build status
[00:53:11.262] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:11.262] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:29:0) after 1m0s
[00:54:11.299] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:29:0)
[00:54:11.299] Timer tick, asking Buildbucket for the build status
[00:54:11.509] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:11.509] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:30:0) after 1m0s
[00:55:11.543] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:30:0)
[00:55:11.543] Timer tick, asking Buildbucket for the build status
[00:55:11.620] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:11.620] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:31:0) after 1m0s
[00:56:11.681] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:31:0)
[00:56:11.681] Timer tick, asking Buildbucket for the build status
[00:56:11.774] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:11.774] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:32:0) after 1m0s
[00:57:11.837] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:32:0)
[00:57:11.837] Timer tick, asking Buildbucket for the build status
[00:57:12.137] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:12.137] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:33:0) after 1m0s
[00:58:12.223] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:33:0)
[00:58:12.223] Timer tick, asking Buildbucket for the build status
[00:58:12.427] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:12.427] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:34:0) after 1m0s
[00:59:12.453] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:34:0)
[00:59:12.453] Timer tick, asking Buildbucket for the build status
[00:59:12.535] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:12.535] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:35:0) after 1m0s
[01:00:12.604] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:35:0)
[01:00:12.604] Timer tick, asking Buildbucket for the build status
[01:00:12.860] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:12.860] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:36:0) after 1m0s
[01:01:13.944] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:36:0)
[01:01:13.944] Timer tick, asking Buildbucket for the build status
[01:01:14.040] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:14.040] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:37:0) after 1m0s
[01:02:14.117] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:37:0)
[01:02:14.117] Timer tick, asking Buildbucket for the build status
[01:02:14.242] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:14.242] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:38:0) after 1m0s
[01:03:14.441] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:38:0)
[01:03:14.441] Timer tick, asking Buildbucket for the build status
[01:03:14.622] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:14.622] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:39:0) after 1m0s
[01:04:14.642] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:39:0)
[01:04:14.642] Timer tick, asking Buildbucket for the build status
[01:04:14.763] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:14.763] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:40:0) after 1m0s
[01:05:14.868] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:40:0)
[01:05:14.868] Timer tick, asking Buildbucket for the build status
[01:05:14.945] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:14.945] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:41:0) after 1m0s
[01:06:14.946] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:41:0)
[01:06:14.946] Timer tick, asking Buildbucket for the build status
[01:06:15.225] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:15.225] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:42:0) after 1m0s
[01:07:15.323] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:42:0)
[01:07:15.323] Timer tick, asking Buildbucket for the build status
[01:07:15.453] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:15.453] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:43:0) after 1m0s
[01:08:15.528] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:43:0)
[01:08:15.528] Timer tick, asking Buildbucket for the build status
[01:08:15.913] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:15.913] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:44:0) after 1m0s
[01:09:16.015] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:44:0)
[01:09:16.015] Timer tick, asking Buildbucket for the build status
[01:09:16.415] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:16.415] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:45:0) after 1m0s
[01:10:16.538] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:45:0)
[01:10:16.538] Timer tick, asking Buildbucket for the build status
[01:10:17.026] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:17.026] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:46:0) after 1m0s
[01:11:17.129] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:46:0)
[01:11:17.129] Timer tick, asking Buildbucket for the build status
[01:11:17.344] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:17.344] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:47:0) after 1m0s
[01:12:17.397] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:47:0)
[01:12:17.397] Timer tick, asking Buildbucket for the build status
[01:12:17.925] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:17.925] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:48:0) after 1m0s
[01:13:17.951] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:48:0)
[01:13:17.951] Timer tick, asking Buildbucket for the build status
[01:13:18.027] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:18.027] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:49:0) after 1m0s
[01:14:18.270] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:49:0)
[01:14:18.270] Timer tick, asking Buildbucket for the build status
[01:14:18.651] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:18.651] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:50:0) after 1m0s
[01:15:18.857] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:50:0)
[01:15:18.857] Timer tick, asking Buildbucket for the build status
[01:15:18.941] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:18.941] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:51:0) after 1m0s
[01:16:19.187] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:51:0)
[01:16:19.187] Timer tick, asking Buildbucket for the build status
[01:16:19.257] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:19.257] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:52:0) after 1m0s
[01:17:19.559] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:52:0)
[01:17:19.559] Timer tick, asking Buildbucket for the build status
[01:17:19.705] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:19.705] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:53:0) after 1m0s
[01:18:19.914] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:53:0)
[01:18:19.914] Timer tick, asking Buildbucket for the build status
[01:18:19.976] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:19.977] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:54:0) after 1m0s
[01:19:20.067] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:54:0)
[01:19:20.067] Timer tick, asking Buildbucket for the build status
[01:19:20.150] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:20.150] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:55:0) after 1m0s
[01:20:20.247] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:55:0)
[01:20:20.247] Timer tick, asking Buildbucket for the build status
[01:20:20.306] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:20.306] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:56:0) after 1m0s
[01:21:20.372] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:56:0)
[01:21:20.372] Timer tick, asking Buildbucket for the build status
[01:21:20.453] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:20.453] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:57:0) after 1m0s
[01:22:20.510] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:57:0)
[01:22:20.510] Timer tick, asking Buildbucket for the build status
[01:22:20.622] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:20.622] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:58:0) after 1m0s
[01:23:20.822] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:58:0)
[01:23:20.822] Timer tick, asking Buildbucket for the build status
[01:23:20.913] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:20.913] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:59:0) after 1m0s
[01:24:21.054] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:59:0)
[01:24:21.054] Timer tick, asking Buildbucket for the build status
[01:24:21.133] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:21.133] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:60:0) after 1m0s
[01:25:21.338] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:60:0)
[01:25:21.338] Timer tick, asking Buildbucket for the build status
[01:25:21.410] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:21.410] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:61:0) after 1m0s
[01:26:21.494] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:61:0)
[01:26:21.494] Timer tick, asking Buildbucket for the build status
[01:26:21.559] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:21.559] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:62:0) after 1m0s
[01:27:22.086] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:62:0)
[01:27:22.086] Timer tick, asking Buildbucket for the build status
[01:27:22.192] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:22.192] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:63:0) after 1m0s
[01:28:22.342] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:63:0)
[01:28:22.342] Timer tick, asking Buildbucket for the build status
[01:28:22.623] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:22.623] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:64:0) after 1m0s
[01:29:22.744] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:64:0)
[01:29:22.744] Timer tick, asking Buildbucket for the build status
[01:29:22.816] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:22.816] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:65:0) after 1m0s
[01:30:23.023] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:65:0)
[01:30:23.023] Timer tick, asking Buildbucket for the build status
[01:30:23.151] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:23.151] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:66:0) after 1m0s
[01:31:23.258] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:66:0)
[01:31:23.258] Timer tick, asking Buildbucket for the build status
[01:31:23.365] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:23.365] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:67:0) after 1m0s
[01:32:23.408] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:67:0)
[01:32:23.408] Timer tick, asking Buildbucket for the build status
[01:32:23.506] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:23.506] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:68:0) after 1m0s
[01:33:23.664] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:68:0)
[01:33:23.664] Timer tick, asking Buildbucket for the build status
[01:33:23.740] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:23.740] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:69:0) after 1m0s
[01:34:23.808] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:69:0)
[01:34:23.808] Timer tick, asking Buildbucket for the build status
[01:34:23.905] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:23.905] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:70:0) after 1m0s
[01:35:23.899] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:70:0)
[01:35:23.899] Timer tick, asking Buildbucket for the build status
[01:35:23.958] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:23.958] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:71:0) after 1m0s
[01:36:24.083] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:71:0)
[01:36:24.083] Timer tick, asking Buildbucket for the build status
[01:36:24.154] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:24.154] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:72:0) after 1m0s
[01:37:24.185] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:72:0)
[01:37:24.185] Timer tick, asking Buildbucket for the build status
[01:37:24.508] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:24.508] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:73:0) after 1m0s
[01:38:24.659] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:73:0)
[01:38:24.659] Timer tick, asking Buildbucket for the build status
[01:38:24.779] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:24.779] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:74:0) after 1m0s
[01:39:24.805] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:74:0)
[01:39:24.805] Timer tick, asking Buildbucket for the build status
[01:39:24.907] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:24.907] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:75:0) after 1m0s
[01:40:24.986] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:75:0)
[01:40:24.986] Timer tick, asking Buildbucket for the build status
[01:40:25.043] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:25.044] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:76:0) after 1m0s
[01:41:25.071] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:76:0)
[01:41:25.071] Timer tick, asking Buildbucket for the build status
[01:41:25.707] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:25.707] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:77:0) after 1m0s
[01:42:25.820] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:77:0)
[01:42:25.820] Timer tick, asking Buildbucket for the build status
[01:42:26.083] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:26.083] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:78:0) after 1m0s
[01:43:26.116] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:78:0)
[01:43:26.116] Timer tick, asking Buildbucket for the build status
[01:43:26.196] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:26.196] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:79:0) after 1m0s
[01:44:26.222] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:79:0)
[01:44:26.222] Timer tick, asking Buildbucket for the build status
[01:44:26.427] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:26.427] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:80:0) after 1m0s
[01:45:26.498] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:80:0)
[01:45:26.498] Timer tick, asking Buildbucket for the build status
[01:45:26.555] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:26.555] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:81:0) after 1m0s
[01:46:26.705] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:81:0)
[01:46:26.705] Timer tick, asking Buildbucket for the build status
[01:46:26.877] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:26.877] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:82:0) after 1m0s
[01:47:27.048] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:82:0)
[01:47:27.048] Timer tick, asking Buildbucket for the build status
[01:47:27.175] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:27.175] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:83:0) after 1m0s
[01:48:28.985] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:83:0)
[01:48:28.985] Timer tick, asking Buildbucket for the build status
[01:48:29.045] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:29.045] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:84:0) after 1m0s
[01:49:29.473] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:84:0)
[01:49:29.473] Timer tick, asking Buildbucket for the build status
[01:49:29.921] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:29.921] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:85:0) after 1m0s
[01:50:30.103] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:85:0)
[01:50:30.103] Timer tick, asking Buildbucket for the build status
[01:50:30.211] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:30.211] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:86:0) after 1m0s
[01:51:30.518] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:86:0)
[01:51:30.518] Timer tick, asking Buildbucket for the build status
[01:51:30.702] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:30.702] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:87:0) after 1m0s
[01:52:30.982] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:87:0)
[01:52:30.982] Timer tick, asking Buildbucket for the build status
[01:52:31.086] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:31.086] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:88:0) after 1m0s
[01:53:31.275] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:88:0)
[01:53:31.275] Timer tick, asking Buildbucket for the build status
[01:53:31.340] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:31.340] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:89:0) after 1m0s
[01:54:31.595] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:89:0)
[01:54:31.595] Timer tick, asking Buildbucket for the build status
[01:54:31.864] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:31.864] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:90:0) after 1m0s
[01:55:31.966] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:90:0)
[01:55:31.966] Timer tick, asking Buildbucket for the build status
[01:55:32.108] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:32.109] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:91:0) after 1m0s
[01:56:32.275] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:91:0)
[01:56:32.275] Timer tick, asking Buildbucket for the build status
[01:56:32.339] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:32.339] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:92:0) after 1m0s
[01:57:32.401] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:92:0)
[01:57:32.401] Timer tick, asking Buildbucket for the build status
[01:57:32.567] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:32.567] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:93:0) after 1m0s
[01:58:32.728] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:93:0)
[01:58:32.728] Timer tick, asking Buildbucket for the build status
[01:58:32.807] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:32.807] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:94:0) after 1m0s
[01:59:32.942] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:94:0)
[01:59:32.942] Timer tick, asking Buildbucket for the build status
[01:59:33.013] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:33.013] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:95:0) after 1m0s
[02:00:33.277] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:95:0)
[02:00:33.277] Timer tick, asking Buildbucket for the build status
[02:00:33.372] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:33.372] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:96:0) after 1m0s
[02:01:33.562] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:96:0)
[02:01:33.562] Timer tick, asking Buildbucket for the build status
[02:01:33.715] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:33.715] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:97:0) after 1m0s
[02:02:33.834] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:97:0)
[02:02:33.834] Timer tick, asking Buildbucket for the build status
[02:02:33.963] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:33.963] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:98:0) after 1m0s
[02:03:34.145] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:98:0)
[02:03:34.145] Timer tick, asking Buildbucket for the build status
[02:03:34.206] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:34.206] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:99:0) after 1m0s
[02:04:34.319] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:99:0)
[02:04:34.319] Timer tick, asking Buildbucket for the build status
[02:04:34.461] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:34.461] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:100:0) after 1m0s
[02:05:34.553] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:100:0)
[02:05:34.553] Timer tick, asking Buildbucket for the build status
[02:05:34.606] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:34.606] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:101:0) after 1m0s
[02:06:34.672] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:101:0)
[02:06:34.672] Timer tick, asking Buildbucket for the build status
[02:06:34.732] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:34.732] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:102:0) after 1m0s
[02:07:34.941] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:102:0)
[02:07:34.941] Timer tick, asking Buildbucket for the build status
[02:07:35.066] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:35.066] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:103:0) after 1m0s
[02:08:35.109] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:103:0)
[02:08:35.109] Timer tick, asking Buildbucket for the build status
[02:08:35.646] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:35.646] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:104:0) after 1m0s
[02:09:35.653] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:104:0)
[02:09:35.653] Timer tick, asking Buildbucket for the build status
[02:09:35.714] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:35.714] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:105:0) after 1m0s
[02:10:35.777] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:105:0)
[02:10:35.777] Timer tick, asking Buildbucket for the build status
[02:10:36.018] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:36.018] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:106:0) after 1m0s
[02:11:36.162] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:106:0)
[02:11:36.162] Timer tick, asking Buildbucket for the build status
[02:11:36.228] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:36.228] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:107:0) after 1m0s
[02:12:36.512] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:107:0)
[02:12:36.512] Timer tick, asking Buildbucket for the build status
[02:12:36.828] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:36.828] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:108:0) after 1m0s
[02:13:36.957] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:108:0)
[02:13:36.957] Timer tick, asking Buildbucket for the build status
[02:13:37.012] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:37.012] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:109:0) after 1m0s
[02:14:37.009] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:109:0)
[02:14:37.009] Timer tick, asking Buildbucket for the build status
[02:14:37.076] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:37.076] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:110:0) after 1m0s
[02:15:37.187] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:110:0)
[02:15:37.187] Timer tick, asking Buildbucket for the build status
[02:15:37.449] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:37.449] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:111:0) after 1m0s
[02:16:37.463] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:111:0)
[02:16:37.463] Timer tick, asking Buildbucket for the build status
[02:16:37.523] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:37.523] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:112:0) after 1m0s
[02:17:37.541] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:112:0)
[02:17:37.541] Timer tick, asking Buildbucket for the build status
[02:17:37.645] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:37.645] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:113:0) after 1m0s
[02:18:37.753] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:113:0)
[02:18:37.753] Timer tick, asking Buildbucket for the build status
[02:18:37.818] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:37.818] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:114:0) after 1m0s
[02:19:37.881] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:114:0)
[02:19:37.881] Timer tick, asking Buildbucket for the build status
[02:19:38.215] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:38.216] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:115:0) after 1m0s
[02:20:38.282] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:115:0)
[02:20:38.282] Timer tick, asking Buildbucket for the build status
[02:20:38.485] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:38.485] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:116:0) after 1m0s
[02:21:38.522] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:116:0)
[02:21:38.522] Timer tick, asking Buildbucket for the build status
[02:21:38.597] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:38.597] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:117:0) after 1m0s
[02:22:38.643] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:117:0)
[02:22:38.643] Timer tick, asking Buildbucket for the build status
[02:22:38.744] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:38.744] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:118:0) after 1m0s
[02:23:38.772] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:118:0)
[02:23:38.772] Timer tick, asking Buildbucket for the build status
[02:23:38.946] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:38.946] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:119:0) after 1m0s
[02:24:39.002] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:119:0)
[02:24:39.002] Timer tick, asking Buildbucket for the build status
[02:24:39.078] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:39.078] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:120:0) after 1m0s
[02:25:39.117] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:120:0)
[02:25:39.117] Timer tick, asking Buildbucket for the build status
[02:25:39.183] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:39.183] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:121:0) after 1m0s
[02:26:39.310] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:121:0)
[02:26:39.310] Timer tick, asking Buildbucket for the build status
[02:26:39.385] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:39.385] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:122:0) after 1m0s
[02:27:39.475] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:122:0)
[02:27:39.475] Timer tick, asking Buildbucket for the build status
[02:27:39.623] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:39.623] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:123:0) after 1m0s
[02:28:39.657] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:123:0)
[02:28:39.657] Timer tick, asking Buildbucket for the build status
[02:28:39.712] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:39.712] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:124:0) after 1m0s
[02:29:39.752] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:124:0)
[02:29:39.752] Timer tick, asking Buildbucket for the build status
[02:29:39.820] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:39.820] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:125:0) after 1m0s
[02:30:39.863] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:125:0)
[02:30:39.863] Timer tick, asking Buildbucket for the build status
[02:30:40.060] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:40.060] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:126:0) after 1m0s
[02:31:40.094] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:126:0)
[02:31:40.094] Timer tick, asking Buildbucket for the build status
[02:31:40.236] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:40.236] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:127:0) after 1m0s
[02:32:40.259] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:127:0)
[02:32:40.259] Timer tick, asking Buildbucket for the build status
[02:32:40.390] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:40.390] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:128:0) after 1m0s
[02:33:40.549] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:128:0)
[02:33:40.549] Timer tick, asking Buildbucket for the build status
[02:33:40.773] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:40.773] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:129:0) after 1m0s
[02:34:40.851] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:129:0)
[02:34:40.851] Timer tick, asking Buildbucket for the build status
[02:34:40.960] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:40.960] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:130:0) after 1m0s
[02:35:41.251] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:130:0)
[02:35:41.251] Timer tick, asking Buildbucket for the build status
[02:35:41.346] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:41.346] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:131:0) after 1m0s
[02:36:41.470] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:131:0)
[02:36:41.470] Timer tick, asking Buildbucket for the build status
[02:36:41.550] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:41.550] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:132:0) after 1m0s
[02:37:41.670] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:132:0)
[02:37:41.670] Timer tick, asking Buildbucket for the build status
[02:37:41.800] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:41.800] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:133:0) after 1m0s
[02:38:41.931] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:133:0)
[02:38:41.931] Timer tick, asking Buildbucket for the build status
[02:38:42.031] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:42.031] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:134:0) after 1m0s
[02:39:42.143] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:134:0)
[02:39:42.143] Timer tick, asking Buildbucket for the build status
[02:39:42.324] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:42.324] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:135:0) after 1m0s
[02:40:42.573] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:135:0)
[02:40:42.573] Timer tick, asking Buildbucket for the build status
[02:40:42.658] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:42.658] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:136:0) after 1m0s
[02:41:42.881] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:136:0)
[02:41:42.881] Timer tick, asking Buildbucket for the build status
[02:41:42.959] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:42.959] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:137:0) after 1m0s
[02:42:43.003] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:137:0)
[02:42:43.003] Timer tick, asking Buildbucket for the build status
[02:42:43.297] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:43.297] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:138:0) after 1m0s
[02:43:43.323] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:138:0)
[02:43:43.323] Timer tick, asking Buildbucket for the build status
[02:43:43.459] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:43.459] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:139:0) after 1m0s
[02:44:43.550] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:139:0)
[02:44:43.550] Timer tick, asking Buildbucket for the build status
[02:44:43.619] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:43.619] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:140:0) after 1m0s
[02:45:43.682] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:140:0)
[02:45:43.682] Timer tick, asking Buildbucket for the build status
[02:45:43.937] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:43.937] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:141:0) after 1m0s
[02:46:44.017] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:141:0)
[02:46:44.017] Timer tick, asking Buildbucket for the build status
[02:46:44.198] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:44.198] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:142:0) after 1m0s
[02:47:44.336] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:142:0)
[02:47:44.336] Timer tick, asking Buildbucket for the build status
[02:47:44.478] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:44.478] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:143:0) after 1m0s
[02:48:44.510] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:143:0)
[02:48:44.510] Timer tick, asking Buildbucket for the build status
[02:48:44.825] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:44.825] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:144:0) after 1m0s
[02:49:44.853] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:144:0)
[02:49:44.853] Timer tick, asking Buildbucket for the build status
[02:49:45.149] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:45.149] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:145:0) after 1m0s
[02:50:45.176] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:145:0)
[02:50:45.176] Timer tick, asking Buildbucket for the build status
[02:50:45.325] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:45.325] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:146:0) after 1m0s
[02:51:45.325] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:146:0)
[02:51:45.325] Timer tick, asking Buildbucket for the build status
[02:51:45.519] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:45.519] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:147:0) after 1m0s
[02:52:45.596] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:147:0)
[02:52:45.596] Timer tick, asking Buildbucket for the build status
[02:52:45.899] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:45.899] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:148:0) after 1m0s
[02:53:45.908] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:148:0)
[02:53:45.908] Timer tick, asking Buildbucket for the build status
[02:53:45.988] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:45.988] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:149:0) after 1m0s
[02:54:46.123] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:149:0)
[02:54:46.123] Timer tick, asking Buildbucket for the build status
[02:54:46.196] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:46.196] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:150:0) after 1m0s
[02:55:46.293] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:150:0)
[02:55:46.293] Timer tick, asking Buildbucket for the build status
[02:55:46.383] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:46.383] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:151:0) after 1m0s
[02:56:46.417] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:151:0)
[02:56:46.417] Timer tick, asking Buildbucket for the build status
[02:56:46.471] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:46.471] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:152:0) after 1m0s
[02:57:46.495] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:152:0)
[02:57:46.495] Timer tick, asking Buildbucket for the build status
[02:57:46.653] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:46.653] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:153:0) after 1m0s
[02:58:46.678] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:153:0)
[02:58:46.678] Timer tick, asking Buildbucket for the build status
[02:58:46.762] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:46.762] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:154:0) after 1m0s
[02:59:46.793] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:154:0)
[02:59:46.793] Timer tick, asking Buildbucket for the build status
[02:59:47.126] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:47.126] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:155:0) after 1m0s
[03:00:47.181] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:155:0)
[03:00:47.181] Timer tick, asking Buildbucket for the build status
[03:00:47.271] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:47.271] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:156:0) after 1m0s
[03:01:47.309] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:156:0)
[03:01:47.309] Timer tick, asking Buildbucket for the build status
[03:01:47.405] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:47.405] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:157:0) after 1m0s
[03:02:47.480] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:157:0)
[03:02:47.480] Timer tick, asking Buildbucket for the build status
[03:02:47.734] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:47.734] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:158:0) after 1m0s
[03:03:47.758] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:158:0)
[03:03:47.758] Timer tick, asking Buildbucket for the build status
[03:03:47.810] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:47.810] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:159:0) after 1m0s
[03:04:47.836] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:159:0)
[03:04:47.836] Timer tick, asking Buildbucket for the build status
[03:04:47.891] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:47.891] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:160:0) after 1m0s
[03:05:47.919] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:160:0)
[03:05:47.919] Timer tick, asking Buildbucket for the build status
[03:05:47.973] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:47.973] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:161:0) after 1m0s
[03:06:48.013] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:161:0)
[03:06:48.013] Timer tick, asking Buildbucket for the build status
[03:06:48.241] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:48.241] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:162:0) after 1m0s
[03:07:48.287] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:162:0)
[03:07:48.287] Timer tick, asking Buildbucket for the build status
[03:07:48.457] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:48.457] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:163:0) after 1m0s
[03:08:48.488] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:163:0)
[03:08:48.488] Timer tick, asking Buildbucket for the build status
[03:08:48.560] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:48.560] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:164:0) after 1m0s
[03:09:48.616] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:164:0)
[03:09:48.616] Timer tick, asking Buildbucket for the build status
[03:09:48.684] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:48.684] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:165:0) after 1m0s
[03:10:48.762] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:165:0)
[03:10:48.762] Timer tick, asking Buildbucket for the build status
[03:10:48.818] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:48.818] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:166:0) after 1m0s
[03:11:48.867] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:166:0)
[03:11:48.867] Timer tick, asking Buildbucket for the build status
[03:11:49.000] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:49.000] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:167:0) after 1m0s
[03:12:49.072] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:167:0)
[03:12:49.072] Timer tick, asking Buildbucket for the build status
[03:12:49.232] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:49.232] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:168:0) after 1m0s
[03:13:49.303] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:168:0)
[03:13:49.303] Timer tick, asking Buildbucket for the build status
[03:13:49.393] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:49.393] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:169:0) after 1m0s
[03:14:49.516] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:169:0)
[03:14:49.516] Timer tick, asking Buildbucket for the build status
[03:14:49.856] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:49.856] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:170:0) after 1m0s
[03:15:49.922] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:170:0)
[03:15:49.922] Timer tick, asking Buildbucket for the build status
[03:15:50.074] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:50.074] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:171:0) after 1m0s
[03:16:50.201] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:171:0)
[03:16:50.201] Timer tick, asking Buildbucket for the build status
[03:16:50.333] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:50.333] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:172:0) after 1m0s
[03:17:50.363] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:172:0)
[03:17:50.363] Timer tick, asking Buildbucket for the build status
[03:17:50.493] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:50.493] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:173:0) after 1m0s
[03:18:50.527] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:173:0)
[03:18:50.527] Timer tick, asking Buildbucket for the build status
[03:18:50.725] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:50.725] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:174:0) after 1m0s
[03:19:50.787] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:174:0)
[03:19:50.787] Timer tick, asking Buildbucket for the build status
[03:19:51.108] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:51.108] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:175:0) after 1m0s
[03:20:51.115] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:175:0)
[03:20:51.115] Timer tick, asking Buildbucket for the build status
[03:20:51.215] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:51.215] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:176:0) after 1m0s
[03:21:51.289] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:176:0)
[03:21:51.289] Timer tick, asking Buildbucket for the build status
[03:21:51.354] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:51.354] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:177:0) after 1m0s
[03:22:51.411] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:177:0)
[03:22:51.411] Timer tick, asking Buildbucket for the build status
[03:22:51.636] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:51.636] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:178:0) after 1m0s
[03:23:51.721] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:178:0)
[03:23:51.721] Timer tick, asking Buildbucket for the build status
[03:23:51.789] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:51.789] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:179:0) after 1m0s
[03:24:51.844] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:179:0)
[03:24:51.844] Timer tick, asking Buildbucket for the build status
[03:24:51.900] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:51.900] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:180:0) after 1m0s
[03:25:51.927] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:180:0)
[03:25:51.927] Timer tick, asking Buildbucket for the build status
[03:25:52.030] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:52.030] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:181:0) after 1m0s
[03:26:52.124] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:181:0)
[03:26:52.124] Timer tick, asking Buildbucket for the build status
[03:26:52.182] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:52.182] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:182:0) after 1m0s
[03:27:52.211] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:182:0)
[03:27:52.211] Timer tick, asking Buildbucket for the build status
[03:27:52.301] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:52.301] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:183:0) after 1m0s
[03:28:52.329] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:183:0)
[03:28:52.329] Timer tick, asking Buildbucket for the build status
[03:28:52.642] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:52.642] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:184:0) after 1m0s
[03:29:52.687] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:184:0)
[03:29:52.687] Timer tick, asking Buildbucket for the build status
[03:29:52.819] Build 8856452620127924224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:52.819] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021882682065495136:185:0) after 1m0s
[03:30:43.215] Received PubSub notification, asking Buildbucket for the build status
[03:30:43.317] Build 8856452620127924224: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:30:43.317] Buildbucket build:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "completed_ts": "1612236642137677",
    "created_by": "project:chromium",
    "created_ts": "1612225623923685",
    "id": "8856452620127924224",
    "parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"56a6918ec9bdabcb87bb87d4950e61d1d8ef5a33\"}}",
    "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\": \"56a6918ec9bdabcb87bb87d4950e61d1d8ef5a33\", \"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-2-ksg6\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 1515, \"got_angle_revision\": \"0d175f30a81b75da39026d65637bd05a2d585f7a\", \"got_dawn_revision\": \"91e737b8f16a69600f6a391fff127facbdf9e7e0\", \"got_nacl_revision\": \"952e81813a66902714b68f34b51073c5d1ba6c94\", \"got_revision\": \"56a6918ec9bdabcb87bb87d4950e61d1d8ef5a33\", \"got_revision_cp\": \"refs/heads/master@{#849329}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"51045556acd0fe0a1b687ef00725a57f0f19a91b\", \"got_v8_revision\": \"5bc36e7aec3d7acdb0cb6bca02c0788d5993abbc\", \"got_v8_revision_cp\": \"refs/heads/9.0.106@{#1}\", \"got_webrtc_revision\": \"e7c79fd3d66e0f6c54c027f880a8b1682ebae58a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33124}\", \"mirrored_builders\": [\"tryserver.chromium:win-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"56a6918ec9bdabcb87bb87d4950e61d1d8ef5a33\"}, \"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-2-ksg6\"], \"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": "1612225677440416",
    "status": "COMPLETED",
    "status_changed_ts": "1612236642527721",
    "tags": [
      "build_address:luci.chromium.ci/win-official/1515",
      "builder:win-official",
      "buildset:commit/git/56a6918ec9bdabcb87bb87d4950e61d1d8ef5a33",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/56a6918ec9bdabcb87bb87d4950e61d1d8ef5a33",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9021882682065495136",
      "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/8856452620127924224/+/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:5178f45109bb7e10",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1612236642625773",
    "url": "https://ci.chromium.org/b/8856452620127924224",
    "utcnow_ts": "1612236643305249"
  }
}
[03:30:43.317] Invocation finished in 3h3m40.626147199s with status SUCCEEDED