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

Incoming properties

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

Incoming tags

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

Debug log (UTC)

[09:10:28.427] New invocation is queued and will start shortly
[09:10:29.640] Starting the invocation (attempt 1)
[09:10:29.698] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:10:29.698] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:10:29.698] Buildbucket request:
{
  "bucket": "luci.chromium.ci",
  "client_operation_id": "9030184671700265184",
  "parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"f6f2dc20178b6a31955b66d04e6bd6e0eacd1945\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:win-official",
    "scheduler_invocation_id:9030184671700265184",
    "scheduler_job_id:chromium/win-official",
    "user_agent:luci-scheduler",
    "buildset:commit/git/f6f2dc20178b6a31955b66d04e6bd6e0eacd1945",
    "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f6f2dc20178b6a31955b66d04e6bd6e0eacd1945",
    "gitiles_ref:refs/heads/master"
  ]
}
[09:10:31.179] Buildbucket response:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "created_by": "project:chromium",
    "created_ts": "1604308229958829",
    "id": "8864754609421952352",
    "parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f6f2dc20178b6a31955b66d04e6bd6e0eacd1945\"}}",
    "project": "chromium",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1604308230728556",
    "tags": [
      "build_address:luci.chromium.ci/win-official/946",
      "builder:win-official",
      "buildset:commit/git/f6f2dc20178b6a31955b66d04e6bd6e0eacd1945",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f6f2dc20178b6a31955b66d04e6bd6e0eacd1945",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9030184671700265184",
      "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/8864754609421952352/+/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": "1604308230728718",
    "url": "https://ci.chromium.org/b/8864754609421952352",
    "utcnow_ts": "1604308231165097"
  }
}
[09:10:31.179] Task URL: https://ci.chromium.org/b/8864754609421952352
[09:10:31.179] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:2:0) after 1m0s
[09:11:03.266] Received PubSub notification, asking Buildbucket for the build status
[09:11:03.369] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:31.218] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:2:0)
[09:11:31.218] Timer tick, asking Buildbucket for the build status
[09:11:31.300] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:31.300] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:4:0) after 1m0s
[09:12:31.365] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:4:0)
[09:12:31.365] Timer tick, asking Buildbucket for the build status
[09:12:31.456] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:31.456] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:5:0) after 1m0s
[09:13:31.506] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:5:0)
[09:13:31.506] Timer tick, asking Buildbucket for the build status
[09:13:31.599] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:31.599] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:6:0) after 1m0s
[09:14:31.615] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:6:0)
[09:14:31.615] Timer tick, asking Buildbucket for the build status
[09:14:31.688] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:31.688] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:7:0) after 1m0s
[09:15:31.707] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:7:0)
[09:15:31.707] Timer tick, asking Buildbucket for the build status
[09:15:32.399] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:32.399] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:8:0) after 1m0s
[09:16:32.450] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:8:0)
[09:16:32.450] Timer tick, asking Buildbucket for the build status
[09:16:33.537] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:33.537] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:9:0) after 1m0s
[09:17:33.610] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:9:0)
[09:17:33.610] Timer tick, asking Buildbucket for the build status
[09:17:33.712] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:33.712] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:10:0) after 1m0s
[09:18:33.856] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:10:0)
[09:18:33.856] Timer tick, asking Buildbucket for the build status
[09:18:33.961] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:33.961] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:11:0) after 1m0s
[09:19:34.036] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:11:0)
[09:19:34.036] Timer tick, asking Buildbucket for the build status
[09:19:34.146] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:34.146] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:12:0) after 1m0s
[09:20:34.175] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:12:0)
[09:20:34.175] Timer tick, asking Buildbucket for the build status
[09:20:34.366] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:34.366] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:13:0) after 1m0s
[09:21:34.590] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:13:0)
[09:21:34.590] Timer tick, asking Buildbucket for the build status
[09:21:34.682] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:34.682] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:14:0) after 1m0s
[09:22:34.798] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:14:0)
[09:22:34.798] Timer tick, asking Buildbucket for the build status
[09:22:34.942] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:34.942] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:15:0) after 1m0s
[09:23:35.206] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:15:0)
[09:23:35.206] Timer tick, asking Buildbucket for the build status
[09:23:35.288] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:35.288] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:16:0) after 1m0s
[09:24:35.551] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:16:0)
[09:24:35.551] Timer tick, asking Buildbucket for the build status
[09:24:35.661] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:35.661] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:17:0) after 1m0s
[09:25:35.793] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:17:0)
[09:25:35.793] Timer tick, asking Buildbucket for the build status
[09:25:37.180] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:37.181] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:18:0) after 1m0s
[09:26:37.291] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:18:0)
[09:26:37.292] Timer tick, asking Buildbucket for the build status
[09:26:37.844] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:37.844] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:19:0) after 1m0s
[09:27:37.887] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:19:0)
[09:27:37.887] Timer tick, asking Buildbucket for the build status
[09:27:38.414] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:38.414] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:20:0) after 1m0s
[09:28:38.548] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:20:0)
[09:28:38.548] Timer tick, asking Buildbucket for the build status
[09:28:38.703] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:38.703] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:21:0) after 1m0s
[09:29:38.734] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:21:0)
[09:29:38.734] Timer tick, asking Buildbucket for the build status
[09:29:38.848] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:38.848] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:22:0) after 1m0s
[09:30:38.873] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:22:0)
[09:30:38.873] Timer tick, asking Buildbucket for the build status
[09:30:38.988] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:38.989] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:23:0) after 1m0s
[09:31:39.062] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:23:0)
[09:31:39.062] Timer tick, asking Buildbucket for the build status
[09:31:39.143] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:39.143] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:24:0) after 1m0s
[09:32:39.137] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:24:0)
[09:32:39.137] Timer tick, asking Buildbucket for the build status
[09:32:39.205] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:39.205] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:25:0) after 1m0s
[09:33:39.876] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:25:0)
[09:33:39.876] Timer tick, asking Buildbucket for the build status
[09:33:39.943] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:39.943] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:26:0) after 1m0s
[09:34:40.074] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:26:0)
[09:34:40.074] Timer tick, asking Buildbucket for the build status
[09:34:40.138] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:40.138] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:27:0) after 1m0s
[09:35:40.299] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:27:0)
[09:35:40.299] Timer tick, asking Buildbucket for the build status
[09:35:40.419] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:40.419] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:28:0) after 1m0s
[09:36:40.443] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:28:0)
[09:36:40.443] Timer tick, asking Buildbucket for the build status
[09:36:40.528] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:40.528] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:29:0) after 1m0s
[09:37:40.721] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:29:0)
[09:37:40.722] Timer tick, asking Buildbucket for the build status
[09:37:41.048] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:41.048] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:30:0) after 1m0s
[09:38:41.251] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:30:0)
[09:38:41.251] Timer tick, asking Buildbucket for the build status
[09:38:41.366] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:41.366] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:31:0) after 1m0s
[09:39:41.474] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:31:0)
[09:39:41.474] Timer tick, asking Buildbucket for the build status
[09:39:41.606] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:41.606] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:32:0) after 1m0s
[09:40:41.752] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:32:0)
[09:40:41.752] Timer tick, asking Buildbucket for the build status
[09:40:41.982] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:41.982] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:33:0) after 1m0s
[09:41:42.027] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:33:0)
[09:41:42.027] Timer tick, asking Buildbucket for the build status
[09:41:42.747] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:42.747] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:34:0) after 1m0s
[09:42:42.770] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:34:0)
[09:42:42.770] Timer tick, asking Buildbucket for the build status
[09:42:43.696] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:43.696] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:35:0) after 1m0s
[09:43:43.777] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:35:0)
[09:43:43.777] Timer tick, asking Buildbucket for the build status
[09:43:43.855] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:43.855] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:36:0) after 1m0s
[09:44:44.000] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:36:0)
[09:44:44.000] Timer tick, asking Buildbucket for the build status
[09:44:44.077] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:44.078] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:37:0) after 1m0s
[09:45:44.118] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:37:0)
[09:45:44.118] Timer tick, asking Buildbucket for the build status
[09:45:44.242] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:44.242] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:38:0) after 1m0s
[09:46:44.260] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:38:0)
[09:46:44.260] Timer tick, asking Buildbucket for the build status
[09:46:44.337] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:44.337] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:39:0) after 1m0s
[09:47:44.397] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:39:0)
[09:47:44.397] Timer tick, asking Buildbucket for the build status
[09:47:44.583] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:44.583] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:40:0) after 1m0s
[09:48:44.653] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:40:0)
[09:48:44.653] Timer tick, asking Buildbucket for the build status
[09:48:44.718] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:44.718] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:41:0) after 1m0s
[09:49:44.778] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:41:0)
[09:49:44.778] Timer tick, asking Buildbucket for the build status
[09:49:44.847] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:44.847] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:42:0) after 1m0s
[09:50:44.964] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:42:0)
[09:50:44.964] Timer tick, asking Buildbucket for the build status
[09:50:45.472] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:45.472] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:43:0) after 1m0s
[09:51:45.519] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:43:0)
[09:51:45.519] Timer tick, asking Buildbucket for the build status
[09:51:45.599] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:45.599] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:44:0) after 1m0s
[09:52:47.401] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:44:0)
[09:52:47.401] Timer tick, asking Buildbucket for the build status
[09:52:47.664] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:47.664] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:45:0) after 1m0s
[09:53:48.168] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:45:0)
[09:53:48.168] Timer tick, asking Buildbucket for the build status
[09:53:48.347] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:48.347] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:46:0) after 1m0s
[09:54:48.506] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:46:0)
[09:54:48.506] Timer tick, asking Buildbucket for the build status
[09:54:48.570] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:48.570] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:47:0) after 1m0s
[09:55:48.691] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:47:0)
[09:55:48.691] Timer tick, asking Buildbucket for the build status
[09:55:48.980] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:48.980] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:48:0) after 1m0s
[09:56:49.131] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:48:0)
[09:56:49.131] Timer tick, asking Buildbucket for the build status
[09:56:49.520] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:49.520] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:49:0) after 1m0s
[09:57:49.610] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:49:0)
[09:57:49.610] Timer tick, asking Buildbucket for the build status
[09:57:51.548] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:51.548] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:50:0) after 1m0s
[09:58:52.216] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:50:0)
[09:58:52.216] Timer tick, asking Buildbucket for the build status
[09:58:52.302] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:52.302] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:51:0) after 1m0s
[09:59:52.588] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:51:0)
[09:59:52.588] Timer tick, asking Buildbucket for the build status
[09:59:52.659] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:52.659] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:52:0) after 1m0s
[10:00:52.855] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:52:0)
[10:00:52.855] Timer tick, asking Buildbucket for the build status
[10:00:53.018] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:53.018] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:53:0) after 1m0s
[10:01:53.053] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:53:0)
[10:01:53.053] Timer tick, asking Buildbucket for the build status
[10:01:53.123] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:53.123] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:54:0) after 1m0s
[10:02:53.157] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:54:0)
[10:02:53.157] Timer tick, asking Buildbucket for the build status
[10:02:53.236] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:53.236] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:55:0) after 1m0s
[10:03:53.354] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:55:0)
[10:03:53.354] Timer tick, asking Buildbucket for the build status
[10:03:53.467] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:53.467] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:56:0) after 1m0s
[10:04:53.561] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:56:0)
[10:04:53.561] Timer tick, asking Buildbucket for the build status
[10:04:53.628] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:53.628] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:57:0) after 1m0s
[10:05:53.685] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:57:0)
[10:05:53.685] Timer tick, asking Buildbucket for the build status
[10:05:53.910] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:53.910] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:58:0) after 1m0s
[10:06:53.996] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:58:0)
[10:06:53.996] Timer tick, asking Buildbucket for the build status
[10:06:54.077] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:54.077] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:59:0) after 1m0s
[10:07:54.173] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:59:0)
[10:07:54.173] Timer tick, asking Buildbucket for the build status
[10:07:54.247] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:54.247] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:60:0) after 1m0s
[10:08:54.230] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:60:0)
[10:08:54.230] Timer tick, asking Buildbucket for the build status
[10:08:54.284] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:54.284] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:61:0) after 1m0s
[10:09:54.331] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:61:0)
[10:09:54.331] Timer tick, asking Buildbucket for the build status
[10:09:54.419] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:54.419] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:62:0) after 1m0s
[10:10:54.477] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:62:0)
[10:10:54.477] Timer tick, asking Buildbucket for the build status
[10:10:54.594] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:54.594] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:63:0) after 1m0s
[10:11:54.611] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:63:0)
[10:11:54.611] Timer tick, asking Buildbucket for the build status
[10:11:54.677] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:54.677] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:64:0) after 1m0s
[10:12:54.709] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:64:0)
[10:12:54.709] Timer tick, asking Buildbucket for the build status
[10:12:54.790] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:54.790] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:65:0) after 1m0s
[10:13:54.840] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:65:0)
[10:13:54.840] Timer tick, asking Buildbucket for the build status
[10:13:54.905] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:54.905] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:66:0) after 1m0s
[10:14:54.983] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:66:0)
[10:14:54.983] Timer tick, asking Buildbucket for the build status
[10:14:55.058] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:55.058] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:67:0) after 1m0s
[10:15:55.097] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:67:0)
[10:15:55.097] Timer tick, asking Buildbucket for the build status
[10:15:55.209] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:55.209] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:68:0) after 1m0s
[10:16:55.208] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:68:0)
[10:16:55.208] Timer tick, asking Buildbucket for the build status
[10:16:55.285] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:55.285] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:69:0) after 1m0s
[10:17:55.357] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:69:0)
[10:17:55.357] Timer tick, asking Buildbucket for the build status
[10:17:55.563] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:55.563] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:70:0) after 1m0s
[10:18:55.621] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:70:0)
[10:18:55.621] Timer tick, asking Buildbucket for the build status
[10:18:55.760] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:55.760] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:71:0) after 1m0s
[10:19:56.573] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:71:0)
[10:19:56.573] Timer tick, asking Buildbucket for the build status
[10:19:56.703] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:56.703] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:72:0) after 1m0s
[10:20:56.873] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:72:0)
[10:20:56.873] Timer tick, asking Buildbucket for the build status
[10:20:56.998] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:56.998] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:73:0) after 1m0s
[10:21:57.148] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:73:0)
[10:21:57.148] Timer tick, asking Buildbucket for the build status
[10:21:57.207] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:57.207] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:74:0) after 1m0s
[10:22:57.366] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:74:0)
[10:22:57.366] Timer tick, asking Buildbucket for the build status
[10:22:57.440] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:57.440] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:75:0) after 1m0s
[10:23:57.636] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:75:0)
[10:23:57.636] Timer tick, asking Buildbucket for the build status
[10:23:57.713] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:57.713] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:76:0) after 1m0s
[10:24:57.936] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:76:0)
[10:24:57.936] Timer tick, asking Buildbucket for the build status
[10:24:58.098] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:58.098] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:77:0) after 1m0s
[10:25:58.088] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:77:0)
[10:25:58.088] Timer tick, asking Buildbucket for the build status
[10:25:58.229] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:58.229] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:78:0) after 1m0s
[10:26:58.252] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:78:0)
[10:26:58.252] Timer tick, asking Buildbucket for the build status
[10:26:58.314] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:58.314] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:79:0) after 1m0s
[10:27:58.342] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:79:0)
[10:27:58.342] Timer tick, asking Buildbucket for the build status
[10:27:58.512] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:58.512] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:80:0) after 1m0s
[10:28:58.538] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:80:0)
[10:28:58.538] Timer tick, asking Buildbucket for the build status
[10:28:58.609] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:58.609] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:81:0) after 1m0s
[10:29:58.634] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:81:0)
[10:29:58.634] Timer tick, asking Buildbucket for the build status
[10:29:58.705] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:58.705] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:82:0) after 1m0s
[10:30:58.750] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:82:0)
[10:30:58.750] Timer tick, asking Buildbucket for the build status
[10:30:58.880] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:58.881] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:83:0) after 1m0s
[10:31:58.905] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:83:0)
[10:31:58.905] Timer tick, asking Buildbucket for the build status
[10:31:59.043] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:59.043] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:84:0) after 1m0s
[10:32:59.076] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:84:0)
[10:32:59.076] Timer tick, asking Buildbucket for the build status
[10:32:59.163] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:59.164] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:85:0) after 1m0s
[10:33:59.304] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:85:0)
[10:33:59.304] Timer tick, asking Buildbucket for the build status
[10:33:59.365] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:59.365] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:86:0) after 1m0s
[10:34:59.400] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:86:0)
[10:34:59.400] Timer tick, asking Buildbucket for the build status
[10:34:59.522] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:59.522] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:87:0) after 1m0s
[10:35:59.548] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:87:0)
[10:35:59.548] Timer tick, asking Buildbucket for the build status
[10:35:59.706] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:59.707] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:88:0) after 1m0s
[10:36:59.699] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:88:0)
[10:36:59.699] Timer tick, asking Buildbucket for the build status
[10:36:59.771] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:59.771] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:89:0) after 1m0s
[10:37:59.826] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:89:0)
[10:37:59.826] Timer tick, asking Buildbucket for the build status
[10:37:59.883] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:59.883] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:90:0) after 1m0s
[10:38:59.985] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:90:0)
[10:38:59.985] Timer tick, asking Buildbucket for the build status
[10:39:00.215] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:00.215] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:91:0) after 1m0s
[10:40:00.329] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:91:0)
[10:40:00.329] Timer tick, asking Buildbucket for the build status
[10:40:00.570] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:00.570] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:92:0) after 1m0s
[10:41:01.905] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:92:0)
[10:41:01.905] Timer tick, asking Buildbucket for the build status
[10:41:02.191] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:02.191] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:93:0) after 1m0s
[10:42:02.267] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:93:0)
[10:42:02.267] Timer tick, asking Buildbucket for the build status
[10:42:02.324] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:02.324] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:94:0) after 1m0s
[10:43:02.418] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:94:0)
[10:43:02.418] Timer tick, asking Buildbucket for the build status
[10:43:02.484] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:02.484] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:95:0) after 1m0s
[10:44:02.527] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:95:0)
[10:44:02.527] Timer tick, asking Buildbucket for the build status
[10:44:02.602] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:02.602] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:96:0) after 1m0s
[10:45:02.710] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:96:0)
[10:45:02.710] Timer tick, asking Buildbucket for the build status
[10:45:02.790] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:02.790] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:97:0) after 1m0s
[10:46:03.046] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:97:0)
[10:46:03.046] Timer tick, asking Buildbucket for the build status
[10:46:03.171] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:03.171] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:98:0) after 1m0s
[10:47:03.351] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:98:0)
[10:47:03.351] Timer tick, asking Buildbucket for the build status
[10:47:03.433] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:03.434] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:99:0) after 1m0s
[10:48:03.568] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:99:0)
[10:48:03.568] Timer tick, asking Buildbucket for the build status
[10:48:03.837] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:03.837] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:100:0) after 1m0s
[10:49:03.877] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:100:0)
[10:49:03.877] Timer tick, asking Buildbucket for the build status
[10:49:03.944] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:03.944] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:101:0) after 1m0s
[10:50:04.059] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:101:0)
[10:50:04.059] Timer tick, asking Buildbucket for the build status
[10:50:04.127] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:04.127] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:102:0) after 1m0s
[10:51:04.216] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:102:0)
[10:51:04.216] Timer tick, asking Buildbucket for the build status
[10:51:04.398] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:04.398] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:103:0) after 1m0s
[10:52:04.445] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:103:0)
[10:52:04.445] Timer tick, asking Buildbucket for the build status
[10:52:04.624] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:04.624] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:104:0) after 1m0s
[10:53:04.670] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:104:0)
[10:53:04.670] Timer tick, asking Buildbucket for the build status
[10:53:04.753] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:04.753] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:105:0) after 1m0s
[10:54:04.878] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:105:0)
[10:54:04.878] Timer tick, asking Buildbucket for the build status
[10:54:05.059] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:05.059] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:106:0) after 1m0s
[10:55:05.134] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:106:0)
[10:55:05.134] Timer tick, asking Buildbucket for the build status
[10:55:05.211] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:05.211] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:107:0) after 1m0s
[10:56:05.252] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:107:0)
[10:56:05.252] Timer tick, asking Buildbucket for the build status
[10:56:05.398] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:05.399] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:108:0) after 1m0s
[10:57:05.397] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:108:0)
[10:57:05.397] Timer tick, asking Buildbucket for the build status
[10:57:05.452] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:05.452] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:109:0) after 1m0s
[10:58:05.447] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:109:0)
[10:58:05.447] Timer tick, asking Buildbucket for the build status
[10:58:05.515] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:05.515] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:110:0) after 1m0s
[10:59:05.551] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:110:0)
[10:59:05.551] Timer tick, asking Buildbucket for the build status
[10:59:05.610] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:05.610] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:111:0) after 1m0s
[11:00:05.694] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:111:0)
[11:00:05.694] Timer tick, asking Buildbucket for the build status
[11:00:05.973] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:05.973] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:112:0) after 1m0s
[11:01:06.028] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:112:0)
[11:01:06.028] Timer tick, asking Buildbucket for the build status
[11:01:06.711] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:06.711] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:113:0) after 1m0s
[11:02:06.779] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:113:0)
[11:02:06.779] Timer tick, asking Buildbucket for the build status
[11:02:06.851] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:06.851] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:114:0) after 1m0s
[11:03:06.863] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:114:0)
[11:03:06.863] Timer tick, asking Buildbucket for the build status
[11:03:06.936] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:06.936] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:115:0) after 1m0s
[11:04:07.149] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:115:0)
[11:04:07.149] Timer tick, asking Buildbucket for the build status
[11:04:07.292] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:07.293] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:116:0) after 1m0s
[11:05:07.518] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:116:0)
[11:05:07.518] Timer tick, asking Buildbucket for the build status
[11:05:07.691] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:07.691] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:117:0) after 1m0s
[11:06:07.726] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:117:0)
[11:06:07.726] Timer tick, asking Buildbucket for the build status
[11:06:08.164] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:08.164] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:118:0) after 1m0s
[11:07:08.208] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:118:0)
[11:07:08.208] Timer tick, asking Buildbucket for the build status
[11:07:08.277] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:08.277] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:119:0) after 1m0s
[11:08:08.437] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:119:0)
[11:08:08.437] Timer tick, asking Buildbucket for the build status
[11:08:08.580] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:08.580] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:120:0) after 1m0s
[11:09:08.684] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:120:0)
[11:09:08.684] Timer tick, asking Buildbucket for the build status
[11:09:08.788] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:08.788] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:121:0) after 1m0s
[11:10:08.853] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:121:0)
[11:10:08.853] Timer tick, asking Buildbucket for the build status
[11:10:09.283] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:09.283] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:122:0) after 1m0s
[11:11:09.458] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:122:0)
[11:11:09.458] Timer tick, asking Buildbucket for the build status
[11:11:09.597] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:09.597] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:123:0) after 1m0s
[11:12:09.653] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:123:0)
[11:12:09.653] Timer tick, asking Buildbucket for the build status
[11:12:09.747] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:09.747] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:124:0) after 1m0s
[11:13:09.804] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:124:0)
[11:13:09.804] Timer tick, asking Buildbucket for the build status
[11:13:09.886] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:09.886] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:125:0) after 1m0s
[11:14:09.986] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:125:0)
[11:14:09.986] Timer tick, asking Buildbucket for the build status
[11:14:10.088] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:10.088] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:126:0) after 1m0s
[11:15:10.134] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:126:0)
[11:15:10.134] Timer tick, asking Buildbucket for the build status
[11:15:10.225] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:10.225] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:127:0) after 1m0s
[11:16:10.334] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:127:0)
[11:16:10.334] Timer tick, asking Buildbucket for the build status
[11:16:10.432] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:10.432] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:128:0) after 1m0s
[11:17:10.526] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:128:0)
[11:17:10.526] Timer tick, asking Buildbucket for the build status
[11:17:10.634] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:10.634] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:129:0) after 1m0s
[11:18:10.652] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:129:0)
[11:18:10.652] Timer tick, asking Buildbucket for the build status
[11:18:10.726] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:10.726] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:130:0) after 1m0s
[11:19:10.798] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:130:0)
[11:19:10.798] Timer tick, asking Buildbucket for the build status
[11:19:10.853] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:10.853] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:131:0) after 1m0s
[11:20:10.914] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:131:0)
[11:20:10.914] Timer tick, asking Buildbucket for the build status
[11:20:10.973] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:10.973] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:132:0) after 1m0s
[11:21:11.012] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:132:0)
[11:21:11.012] Timer tick, asking Buildbucket for the build status
[11:21:11.130] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:11.131] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:133:0) after 1m0s
[11:22:11.169] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:133:0)
[11:22:11.169] Timer tick, asking Buildbucket for the build status
[11:22:11.378] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:11.378] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:134:0) after 1m0s
[11:23:11.441] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:134:0)
[11:23:11.441] Timer tick, asking Buildbucket for the build status
[11:23:11.514] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:11.515] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:135:0) after 1m0s
[11:24:11.526] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:135:0)
[11:24:11.526] Timer tick, asking Buildbucket for the build status
[11:24:11.591] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:11.591] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:136:0) after 1m0s
[11:25:11.663] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:136:0)
[11:25:11.663] Timer tick, asking Buildbucket for the build status
[11:25:11.995] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:11.995] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:137:0) after 1m0s
[11:26:12.156] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:137:0)
[11:26:12.156] Timer tick, asking Buildbucket for the build status
[11:26:12.373] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:12.373] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:138:0) after 1m0s
[11:27:12.391] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:138:0)
[11:27:12.391] Timer tick, asking Buildbucket for the build status
[11:27:12.462] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:12.462] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:139:0) after 1m0s
[11:28:12.549] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:139:0)
[11:28:12.549] Timer tick, asking Buildbucket for the build status
[11:28:12.615] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:12.615] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:140:0) after 1m0s
[11:29:12.706] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:140:0)
[11:29:12.706] Timer tick, asking Buildbucket for the build status
[11:29:12.789] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:12.789] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:141:0) after 1m0s
[11:30:12.863] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:141:0)
[11:30:12.863] Timer tick, asking Buildbucket for the build status
[11:30:13.036] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:13.036] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:142:0) after 1m0s
[11:31:13.112] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:142:0)
[11:31:13.112] Timer tick, asking Buildbucket for the build status
[11:31:13.253] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:13.253] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:143:0) after 1m0s
[11:32:13.273] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:143:0)
[11:32:13.273] Timer tick, asking Buildbucket for the build status
[11:32:13.453] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:13.453] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:144:0) after 1m0s
[11:33:13.453] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:144:0)
[11:33:13.453] Timer tick, asking Buildbucket for the build status
[11:33:13.713] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:13.713] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:145:0) after 1m0s
[11:34:13.705] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:145:0)
[11:34:13.705] Timer tick, asking Buildbucket for the build status
[11:34:13.766] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:13.766] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:146:0) after 1m0s
[11:35:13.866] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:146:0)
[11:35:13.866] Timer tick, asking Buildbucket for the build status
[11:35:13.943] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:13.943] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:147:0) after 1m0s
[11:36:13.982] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:147:0)
[11:36:13.982] Timer tick, asking Buildbucket for the build status
[11:36:14.484] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:14.484] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:148:0) after 1m0s
[11:37:14.579] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:148:0)
[11:37:14.579] Timer tick, asking Buildbucket for the build status
[11:37:14.653] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:14.653] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:149:0) after 1m0s
[11:38:14.716] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:149:0)
[11:38:14.717] Timer tick, asking Buildbucket for the build status
[11:38:14.800] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:14.800] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:150:0) after 1m0s
[11:39:14.859] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:150:0)
[11:39:14.859] Timer tick, asking Buildbucket for the build status
[11:39:14.926] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:14.926] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:151:0) after 1m0s
[11:40:15.016] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:151:0)
[11:40:15.016] Timer tick, asking Buildbucket for the build status
[11:40:15.088] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:15.088] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:152:0) after 1m0s
[11:41:15.153] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:152:0)
[11:41:15.153] Timer tick, asking Buildbucket for the build status
[11:41:15.255] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:15.255] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:153:0) after 1m0s
[11:42:15.303] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:153:0)
[11:42:15.303] Timer tick, asking Buildbucket for the build status
[11:42:15.373] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:15.373] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:154:0) after 1m0s
[11:43:15.440] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:154:0)
[11:43:15.440] Timer tick, asking Buildbucket for the build status
[11:43:15.675] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:15.675] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:155:0) after 1m0s
[11:44:15.734] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:155:0)
[11:44:15.734] Timer tick, asking Buildbucket for the build status
[11:44:15.866] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:15.866] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:156:0) after 1m0s
[11:45:15.900] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:156:0)
[11:45:15.900] Timer tick, asking Buildbucket for the build status
[11:45:16.014] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:16.014] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:157:0) after 1m0s
[11:46:16.125] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:157:0)
[11:46:16.125] Timer tick, asking Buildbucket for the build status
[11:46:16.231] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:16.231] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:158:0) after 1m0s
[11:47:16.267] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:158:0)
[11:47:16.267] Timer tick, asking Buildbucket for the build status
[11:47:16.369] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:16.369] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:159:0) after 1m0s
[11:48:16.379] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:159:0)
[11:48:16.379] Timer tick, asking Buildbucket for the build status
[11:48:16.535] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:16.535] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:160:0) after 1m0s
[11:49:16.572] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:160:0)
[11:49:16.572] Timer tick, asking Buildbucket for the build status
[11:49:16.626] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:16.626] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:161:0) after 1m0s
[11:50:16.722] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:161:0)
[11:50:16.722] Timer tick, asking Buildbucket for the build status
[11:50:16.859] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:16.859] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:162:0) after 1m0s
[11:51:16.891] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:162:0)
[11:51:16.891] Timer tick, asking Buildbucket for the build status
[11:51:17.002] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:17.002] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:163:0) after 1m0s
[11:52:17.096] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:163:0)
[11:52:17.096] Timer tick, asking Buildbucket for the build status
[11:52:17.165] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:17.165] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:164:0) after 1m0s
[11:53:17.226] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:164:0)
[11:53:17.226] Timer tick, asking Buildbucket for the build status
[11:53:17.303] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:17.303] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:165:0) after 1m0s
[11:54:17.336] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:165:0)
[11:54:17.336] Timer tick, asking Buildbucket for the build status
[11:54:17.421] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:17.421] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:166:0) after 1m0s
[11:55:17.448] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:166:0)
[11:55:17.448] Timer tick, asking Buildbucket for the build status
[11:55:17.509] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:17.509] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:167:0) after 1m0s
[11:56:17.610] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:167:0)
[11:56:17.610] Timer tick, asking Buildbucket for the build status
[11:56:17.947] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:17.947] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:168:0) after 1m0s
[11:57:17.994] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:168:0)
[11:57:17.994] Timer tick, asking Buildbucket for the build status
[11:57:18.104] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:18.105] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:169:0) after 1m0s
[11:58:18.200] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:169:0)
[11:58:18.200] Timer tick, asking Buildbucket for the build status
[11:58:18.280] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:18.280] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:170:0) after 1m0s
[11:59:18.332] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:170:0)
[11:59:18.332] Timer tick, asking Buildbucket for the build status
[11:59:18.440] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:18.440] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:171:0) after 1m0s
[12:00:18.501] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:171:0)
[12:00:18.501] Timer tick, asking Buildbucket for the build status
[12:00:18.589] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:18.589] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:172:0) after 1m0s
[12:01:18.642] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:172:0)
[12:01:18.642] Timer tick, asking Buildbucket for the build status
[12:01:18.760] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:18.760] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:173:0) after 1m0s
[12:02:18.841] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:173:0)
[12:02:18.841] Timer tick, asking Buildbucket for the build status
[12:02:19.107] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:19.107] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:174:0) after 1m0s
[12:03:19.136] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:174:0)
[12:03:19.136] Timer tick, asking Buildbucket for the build status
[12:03:19.211] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:19.211] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:175:0) after 1m0s
[12:04:19.245] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:175:0)
[12:04:19.245] Timer tick, asking Buildbucket for the build status
[12:04:19.389] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:19.389] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:176:0) after 1m0s
[12:05:19.487] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:176:0)
[12:05:19.487] Timer tick, asking Buildbucket for the build status
[12:05:19.581] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:19.581] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:177:0) after 1m0s
[12:06:19.662] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:177:0)
[12:06:19.662] Timer tick, asking Buildbucket for the build status
[12:06:19.793] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:19.793] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:178:0) after 1m0s
[12:07:19.829] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:178:0)
[12:07:19.829] Timer tick, asking Buildbucket for the build status
[12:07:19.983] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:19.983] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:179:0) after 1m0s
[12:08:20.017] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:179:0)
[12:08:20.017] Timer tick, asking Buildbucket for the build status
[12:08:20.175] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:20.175] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:180:0) after 1m0s
[12:09:20.260] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:180:0)
[12:09:20.260] Timer tick, asking Buildbucket for the build status
[12:09:20.345] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:20.345] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:181:0) after 1m0s
[12:10:20.413] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:181:0)
[12:10:20.413] Timer tick, asking Buildbucket for the build status
[12:10:20.552] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:20.552] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:182:0) after 1m0s
[12:11:20.631] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:182:0)
[12:11:20.631] Timer tick, asking Buildbucket for the build status
[12:11:20.753] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:20.753] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:183:0) after 1m0s
[12:12:20.819] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:183:0)
[12:12:20.819] Timer tick, asking Buildbucket for the build status
[12:12:20.891] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:20.891] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:184:0) after 1m0s
[12:13:20.996] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:184:0)
[12:13:20.996] Timer tick, asking Buildbucket for the build status
[12:13:21.089] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:21.089] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:185:0) after 1m0s
[12:14:21.123] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:185:0)
[12:14:21.123] Timer tick, asking Buildbucket for the build status
[12:14:21.219] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:21.219] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:186:0) after 1m0s
[12:15:21.331] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:186:0)
[12:15:21.331] Timer tick, asking Buildbucket for the build status
[12:15:21.395] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:21.395] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:187:0) after 1m0s
[12:16:21.451] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:187:0)
[12:16:21.451] Timer tick, asking Buildbucket for the build status
[12:16:21.592] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:21.592] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:188:0) after 1m0s
[12:17:21.715] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:188:0)
[12:17:21.715] Timer tick, asking Buildbucket for the build status
[12:17:21.837] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:21.837] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:189:0) after 1m0s
[12:18:21.884] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:189:0)
[12:18:21.884] Timer tick, asking Buildbucket for the build status
[12:18:21.966] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:21.966] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:190:0) after 1m0s
[12:19:22.060] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:190:0)
[12:19:22.060] Timer tick, asking Buildbucket for the build status
[12:19:22.135] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:22.135] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:191:0) after 1m0s
[12:20:22.253] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:191:0)
[12:20:22.253] Timer tick, asking Buildbucket for the build status
[12:20:22.374] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:22.374] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:192:0) after 1m0s
[12:21:22.479] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:192:0)
[12:21:22.479] Timer tick, asking Buildbucket for the build status
[12:21:22.881] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:22.881] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:193:0) after 1m0s
[12:22:23.026] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:193:0)
[12:22:23.026] Timer tick, asking Buildbucket for the build status
[12:22:23.599] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:23.599] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:194:0) after 1m0s
[12:23:23.639] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:194:0)
[12:23:23.639] Timer tick, asking Buildbucket for the build status
[12:23:23.725] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:23.725] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:195:0) after 1m0s
[12:24:23.802] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:195:0)
[12:24:23.802] Timer tick, asking Buildbucket for the build status
[12:24:23.859] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:23.859] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:196:0) after 1m0s
[12:25:23.933] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:196:0)
[12:25:23.933] Timer tick, asking Buildbucket for the build status
[12:25:24.018] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:24.018] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:197:0) after 1m0s
[12:26:24.105] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:197:0)
[12:26:24.105] Timer tick, asking Buildbucket for the build status
[12:26:24.206] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:24.206] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:198:0) after 1m0s
[12:27:24.355] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:198:0)
[12:27:24.355] Timer tick, asking Buildbucket for the build status
[12:27:24.481] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:24.481] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:199:0) after 1m0s
[12:28:24.526] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:199:0)
[12:28:24.526] Timer tick, asking Buildbucket for the build status
[12:28:24.648] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:24.648] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:200:0) after 1m0s
[12:29:24.696] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:200:0)
[12:29:24.696] Timer tick, asking Buildbucket for the build status
[12:29:24.759] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:24.759] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:201:0) after 1m0s
[12:30:24.933] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:201:0)
[12:30:24.933] Timer tick, asking Buildbucket for the build status
[12:30:25.273] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:25.273] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:202:0) after 1m0s
[12:31:25.301] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:202:0)
[12:31:25.301] Timer tick, asking Buildbucket for the build status
[12:31:25.485] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:25.485] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:203:0) after 1m0s
[12:32:25.513] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:203:0)
[12:32:25.513] Timer tick, asking Buildbucket for the build status
[12:32:25.581] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:25.581] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:204:0) after 1m0s
[12:33:25.636] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:204:0)
[12:33:25.636] Timer tick, asking Buildbucket for the build status
[12:33:25.741] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:25.741] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:205:0) after 1m0s
[12:34:25.824] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:205:0)
[12:34:25.824] Timer tick, asking Buildbucket for the build status
[12:34:25.885] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:25.885] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:206:0) after 1m0s
[12:35:25.983] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:206:0)
[12:35:25.983] Timer tick, asking Buildbucket for the build status
[12:35:26.040] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:26.040] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:207:0) after 1m0s
[12:36:26.068] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:207:0)
[12:36:26.068] Timer tick, asking Buildbucket for the build status
[12:36:26.174] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:26.174] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:208:0) after 1m0s
[12:37:26.237] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:208:0)
[12:37:26.237] Timer tick, asking Buildbucket for the build status
[12:37:26.522] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:26.522] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:209:0) after 1m0s
[12:38:26.581] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:209:0)
[12:38:26.581] Timer tick, asking Buildbucket for the build status
[12:38:26.648] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:26.648] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:210:0) after 1m0s
[12:39:26.659] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:210:0)
[12:39:26.659] Timer tick, asking Buildbucket for the build status
[12:39:26.795] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:26.795] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:211:0) after 1m0s
[12:40:26.873] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:211:0)
[12:40:26.873] Timer tick, asking Buildbucket for the build status
[12:40:26.967] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:26.967] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:212:0) after 1m0s
[12:41:26.996] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:212:0)
[12:41:26.996] Timer tick, asking Buildbucket for the build status
[12:41:27.260] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:27.260] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:213:0) after 1m0s
[12:42:27.312] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:213:0)
[12:42:27.312] Timer tick, asking Buildbucket for the build status
[12:42:27.379] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:27.379] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:214:0) after 1m0s
[12:43:27.366] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:214:0)
[12:43:27.366] Timer tick, asking Buildbucket for the build status
[12:43:27.437] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:27.437] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:215:0) after 1m0s
[12:44:27.498] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:215:0)
[12:44:27.498] Timer tick, asking Buildbucket for the build status
[12:44:27.588] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:27.588] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:216:0) after 1m0s
[12:45:27.625] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:216:0)
[12:45:27.625] Timer tick, asking Buildbucket for the build status
[12:45:27.883] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:27.883] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:217:0) after 1m0s
[12:46:27.952] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:217:0)
[12:46:27.952] Timer tick, asking Buildbucket for the build status
[12:46:28.080] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:28.080] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:218:0) after 1m0s
[12:47:28.143] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:218:0)
[12:47:28.143] Timer tick, asking Buildbucket for the build status
[12:47:28.228] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:28.228] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:219:0) after 1m0s
[12:48:28.256] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:219:0)
[12:48:28.256] Timer tick, asking Buildbucket for the build status
[12:48:28.389] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:28.389] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:220:0) after 1m0s
[12:49:28.439] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:220:0)
[12:49:28.439] Timer tick, asking Buildbucket for the build status
[12:49:28.505] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:28.505] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:221:0) after 1m0s
[12:50:28.574] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:221:0)
[12:50:28.574] Timer tick, asking Buildbucket for the build status
[12:50:28.645] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:28.645] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:222:0) after 1m0s
[12:51:28.704] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:222:0)
[12:51:28.704] Timer tick, asking Buildbucket for the build status
[12:51:28.838] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:28.838] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:223:0) after 1m0s
[12:52:28.887] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:223:0)
[12:52:28.887] Timer tick, asking Buildbucket for the build status
[12:52:29.241] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:29.241] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:224:0) after 1m0s
[12:53:29.334] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:224:0)
[12:53:29.334] Timer tick, asking Buildbucket for the build status
[12:53:29.412] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:29.412] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:225:0) after 1m0s
[12:54:29.513] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:225:0)
[12:54:29.513] Timer tick, asking Buildbucket for the build status
[12:54:29.736] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:29.736] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:226:0) after 1m0s
[12:55:29.849] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:226:0)
[12:55:29.849] Timer tick, asking Buildbucket for the build status
[12:55:30.250] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:30.250] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:227:0) after 1m0s
[12:56:30.497] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:227:0)
[12:56:30.497] Timer tick, asking Buildbucket for the build status
[12:56:30.612] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:30.612] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:228:0) after 1m0s
[12:57:32.619] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:228:0)
[12:57:32.619] Timer tick, asking Buildbucket for the build status
[12:57:33.035] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:33.035] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:229:0) after 1m0s
[12:58:33.171] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:229:0)
[12:58:33.171] Timer tick, asking Buildbucket for the build status
[12:58:33.317] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:33.317] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:230:0) after 1m0s
[12:59:33.349] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:230:0)
[12:59:33.349] Timer tick, asking Buildbucket for the build status
[12:59:33.458] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:33.458] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:231:0) after 1m0s
[13:00:33.554] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:231:0)
[13:00:33.554] Timer tick, asking Buildbucket for the build status
[13:00:33.669] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:33.669] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:232:0) after 1m0s
[13:01:33.722] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:232:0)
[13:01:33.722] Timer tick, asking Buildbucket for the build status
[13:01:34.041] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:34.041] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:233:0) after 1m0s
[13:02:34.113] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:233:0)
[13:02:34.113] Timer tick, asking Buildbucket for the build status
[13:02:34.909] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:34.909] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:234:0) after 1m0s
[13:03:35.000] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:234:0)
[13:03:35.000] Timer tick, asking Buildbucket for the build status
[13:03:35.092] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:35.092] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:235:0) after 1m0s
[13:04:35.122] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:235:0)
[13:04:35.122] Timer tick, asking Buildbucket for the build status
[13:04:35.378] Build 8864754609421952352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:35.378] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030184671700265184:236:0) after 1m0s
[13:05:18.164] Received PubSub notification, asking Buildbucket for the build status
[13:05:18.455] Build 8864754609421952352: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[13:05:18.455] Buildbucket build:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "completed_ts": "1604322317366336",
    "created_by": "project:chromium",
    "created_ts": "1604308229958829",
    "id": "8864754609421952352",
    "parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f6f2dc20178b6a31955b66d04e6bd6e0eacd1945\"}}",
    "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\": \"f6f2dc20178b6a31955b66d04e6bd6e0eacd1945\", \"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-9-uubh\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 946, \"got_angle_revision\": \"068bb086e1c844161c18185a9110f9588f5b6e8a\", \"got_dawn_revision\": \"0a374dce665328391ab3b68fd9e667b018dd9dcd\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"f6f2dc20178b6a31955b66d04e6bd6e0eacd1945\", \"got_revision_cp\": \"refs/heads/master@{#823085}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"e0de282e678b72dac25b81f8d25305231aec01f8\", \"got_v8_revision\": \"be169f638f5edd2af0946618b0c98c9339f33627\", \"got_v8_revision_cp\": \"refs/heads/8.8.215@{#1}\", \"got_webrtc_revision\": \"ee24eb66d23ffea5ef729dc340e1fc4381c72a4a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32507}\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f6f2dc20178b6a31955b66d04e6bd6e0eacd1945\"}, \"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-9-uubh\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"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\": [\"5614-d862eaa\"], \"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": "1604308262642982",
    "status": "COMPLETED",
    "status_changed_ts": "1604322317770726",
    "tags": [
      "build_address:luci.chromium.ci/win-official/946",
      "builder:win-official",
      "buildset:commit/git/f6f2dc20178b6a31955b66d04e6bd6e0eacd1945",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f6f2dc20178b6a31955b66d04e6bd6e0eacd1945",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9030184671700265184",
      "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/8864754609421952352/+/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:4fa10a6d8593d010",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1604322317797058",
    "url": "https://ci.chromium.org/b/8864754609421952352",
    "utcnow_ts": "1604322318398331"
  }
}
[13:05:18.455] Invocation finished in 3h54m50.052450611s with status SUCCEEDED