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": "e4c22acead672653aa9c3b5db3ceb3f6d3c5e456"
}

Incoming tags

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

Debug log (UTC)

[01:56:50.333] New invocation is queued and will start shortly
[01:56:51.632] Starting the invocation (attempt 1)
[01:56:51.671] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:56:51.674] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:56:51.674] Buildbucket request:
{
  "bucket": "luci.chromium.ci",
  "client_operation_id": "9036825532197111600",
  "parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"e4c22acead672653aa9c3b5db3ceb3f6d3c5e456\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:win-official",
    "scheduler_invocation_id:9036825532197111600",
    "scheduler_job_id:chromium/win-official",
    "user_agent:luci-scheduler",
    "buildset:commit/git/e4c22acead672653aa9c3b5db3ceb3f6d3c5e456",
    "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e4c22acead672653aa9c3b5db3ceb3f6d3c5e456",
    "gitiles_ref:refs/heads/master"
  ]
}
[01:56:52.526] Buildbucket response:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "created_by": "project:chromium",
    "created_ts": "1597975011774307",
    "id": "8871395470012349440",
    "parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e4c22acead672653aa9c3b5db3ceb3f6d3c5e456\"}}",
    "project": "chromium",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1597975012270935",
    "tags": [
      "build_address:luci.chromium.ci/win-official/385",
      "builder:win-official",
      "buildset:commit/git/e4c22acead672653aa9c3b5db3ceb3f6d3c5e456",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e4c22acead672653aa9c3b5db3ceb3f6d3c5e456",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9036825532197111600",
      "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/8871395470012349440/+/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": "1597975012271077",
    "url": "https://ci.chromium.org/b/8871395470012349440",
    "utcnow_ts": "1597975012516707"
  }
}
[01:56:52.526] Task URL: https://ci.chromium.org/b/8871395470012349440
[01:56:52.526] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:2:0) after 1m0s
[01:57:34.653] Received PubSub notification, asking Buildbucket for the build status
[01:57:34.744] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:52.679] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:2:0)
[01:57:52.679] Timer tick, asking Buildbucket for the build status
[01:57:52.960] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:52.960] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:4:0) after 1m0s
[01:58:53.059] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:4:0)
[01:58:53.059] Timer tick, asking Buildbucket for the build status
[01:58:53.235] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:53.235] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:5:0) after 1m0s
[01:59:53.330] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:5:0)
[01:59:53.330] Timer tick, asking Buildbucket for the build status
[01:59:53.419] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:53.419] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:6:0) after 1m0s
[02:00:53.490] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:6:0)
[02:00:53.490] Timer tick, asking Buildbucket for the build status
[02:00:53.562] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:53.562] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:7:0) after 1m0s
[02:01:53.630] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:7:0)
[02:01:53.630] Timer tick, asking Buildbucket for the build status
[02:01:53.954] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:53.954] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:8:0) after 1m0s
[02:02:54.003] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:8:0)
[02:02:54.003] Timer tick, asking Buildbucket for the build status
[02:02:54.517] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:54.517] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:9:0) after 1m0s
[02:03:54.595] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:9:0)
[02:03:54.595] Timer tick, asking Buildbucket for the build status
[02:03:54.977] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:54.977] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:10:0) after 1m0s
[02:04:55.050] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:10:0)
[02:04:55.050] Timer tick, asking Buildbucket for the build status
[02:04:55.162] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:55.162] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:11:0) after 1m0s
[02:05:55.231] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:11:0)
[02:05:55.231] Timer tick, asking Buildbucket for the build status
[02:05:55.320] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:55.320] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:12:0) after 1m0s
[02:06:55.414] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:12:0)
[02:06:55.414] Timer tick, asking Buildbucket for the build status
[02:06:55.585] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:55.585] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:13:0) after 1m0s
[02:07:55.744] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:13:0)
[02:07:55.744] Timer tick, asking Buildbucket for the build status
[02:07:55.972] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:55.972] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:14:0) after 1m0s
[02:08:56.037] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:14:0)
[02:08:56.037] Timer tick, asking Buildbucket for the build status
[02:08:56.198] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:56.198] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:15:0) after 1m0s
[02:09:56.289] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:15:0)
[02:09:56.289] Timer tick, asking Buildbucket for the build status
[02:09:56.373] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:56.373] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:16:0) after 1m0s
[02:10:56.496] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:16:0)
[02:10:56.496] Timer tick, asking Buildbucket for the build status
[02:10:56.894] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:56.894] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:17:0) after 1m0s
[02:11:56.977] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:17:0)
[02:11:56.977] Timer tick, asking Buildbucket for the build status
[02:11:57.169] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:57.169] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:18:0) after 1m0s
[02:12:57.252] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:18:0)
[02:12:57.252] Timer tick, asking Buildbucket for the build status
[02:12:57.459] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:57.459] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:19:0) after 1m0s
[02:13:57.517] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:19:0)
[02:13:57.517] Timer tick, asking Buildbucket for the build status
[02:13:57.609] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:57.609] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:20:0) after 1m0s
[02:14:57.731] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:20:0)
[02:14:57.731] Timer tick, asking Buildbucket for the build status
[02:14:58.032] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:58.032] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:21:0) after 1m0s
[02:15:58.114] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:21:0)
[02:15:58.114] Timer tick, asking Buildbucket for the build status
[02:15:58.223] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:58.223] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:22:0) after 1m0s
[02:16:58.293] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:22:0)
[02:16:58.293] Timer tick, asking Buildbucket for the build status
[02:16:58.463] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:58.463] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:23:0) after 1m0s
[02:17:58.561] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:23:0)
[02:17:58.561] Timer tick, asking Buildbucket for the build status
[02:17:58.724] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:58.724] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:24:0) after 1m0s
[02:18:58.810] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:24:0)
[02:18:58.810] Timer tick, asking Buildbucket for the build status
[02:18:58.908] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:58.908] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:25:0) after 1m0s
[02:19:58.963] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:25:0)
[02:19:58.963] Timer tick, asking Buildbucket for the build status
[02:19:59.034] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:59.034] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:26:0) after 1m0s
[02:20:59.133] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:26:0)
[02:20:59.133] Timer tick, asking Buildbucket for the build status
[02:20:59.203] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:59.203] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:27:0) after 1m0s
[02:21:59.277] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:27:0)
[02:21:59.277] Timer tick, asking Buildbucket for the build status
[02:21:59.472] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:59.472] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:28:0) after 1m0s
[02:22:59.563] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:28:0)
[02:22:59.563] Timer tick, asking Buildbucket for the build status
[02:23:00.144] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:00.144] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:29:0) after 1m0s
[02:24:00.192] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:29:0)
[02:24:00.192] Timer tick, asking Buildbucket for the build status
[02:24:00.269] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:00.269] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:30:0) after 1m0s
[02:25:00.352] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:30:0)
[02:25:00.352] Timer tick, asking Buildbucket for the build status
[02:25:00.444] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:00.444] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:31:0) after 1m0s
[02:26:00.525] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:31:0)
[02:26:00.525] Timer tick, asking Buildbucket for the build status
[02:26:00.611] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:00.611] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:32:0) after 1m0s
[02:27:02.394] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:32:0)
[02:27:02.394] Timer tick, asking Buildbucket for the build status
[02:27:02.557] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:02.557] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:33:0) after 1m0s
[02:28:02.811] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:33:0)
[02:28:02.811] Timer tick, asking Buildbucket for the build status
[02:28:02.873] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:02.873] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:34:0) after 1m0s
[02:29:02.949] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:34:0)
[02:29:02.949] Timer tick, asking Buildbucket for the build status
[02:29:03.086] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:03.087] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:35:0) after 1m0s
[02:30:03.154] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:35:0)
[02:30:03.154] Timer tick, asking Buildbucket for the build status
[02:30:03.292] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:03.292] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:36:0) after 1m0s
[02:31:03.582] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:36:0)
[02:31:03.582] Timer tick, asking Buildbucket for the build status
[02:31:03.781] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:03.781] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:37:0) after 1m0s
[02:32:03.917] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:37:0)
[02:32:03.917] Timer tick, asking Buildbucket for the build status
[02:32:04.073] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:04.073] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:38:0) after 1m0s
[02:33:04.181] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:38:0)
[02:33:04.181] Timer tick, asking Buildbucket for the build status
[02:33:04.437] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:04.437] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:39:0) after 1m0s
[02:34:04.562] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:39:0)
[02:34:04.562] Timer tick, asking Buildbucket for the build status
[02:34:05.094] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:05.094] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:40:0) after 1m0s
[02:35:05.205] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:40:0)
[02:35:05.205] Timer tick, asking Buildbucket for the build status
[02:35:05.273] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:05.274] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:41:0) after 1m0s
[02:36:05.358] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:41:0)
[02:36:05.358] Timer tick, asking Buildbucket for the build status
[02:36:05.444] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:05.444] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:42:0) after 1m0s
[02:37:05.541] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:42:0)
[02:37:05.541] Timer tick, asking Buildbucket for the build status
[02:37:05.800] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:05.800] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:43:0) after 1m0s
[02:38:05.885] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:43:0)
[02:38:05.885] Timer tick, asking Buildbucket for the build status
[02:38:05.957] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:05.957] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:44:0) after 1m0s
[02:39:06.047] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:44:0)
[02:39:06.047] Timer tick, asking Buildbucket for the build status
[02:39:06.116] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:06.116] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:45:0) after 1m0s
[02:40:06.245] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:45:0)
[02:40:06.245] Timer tick, asking Buildbucket for the build status
[02:40:06.509] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:06.509] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:46:0) after 1m0s
[02:41:06.648] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:46:0)
[02:41:06.648] Timer tick, asking Buildbucket for the build status
[02:41:06.732] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:06.732] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:47:0) after 1m0s
[02:42:07.046] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:47:0)
[02:42:07.046] Timer tick, asking Buildbucket for the build status
[02:42:07.322] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:07.322] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:48:0) after 1m0s
[02:43:07.491] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:48:0)
[02:43:07.491] Timer tick, asking Buildbucket for the build status
[02:43:07.627] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:07.627] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:49:0) after 1m0s
[02:44:07.849] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:49:0)
[02:44:07.849] Timer tick, asking Buildbucket for the build status
[02:44:07.915] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:07.915] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:50:0) after 1m0s
[02:45:08.042] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:50:0)
[02:45:08.042] Timer tick, asking Buildbucket for the build status
[02:45:08.278] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:08.278] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:51:0) after 1m0s
[02:46:08.393] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:51:0)
[02:46:08.393] Timer tick, asking Buildbucket for the build status
[02:46:08.583] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:08.583] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:52:0) after 1m0s
[02:47:08.700] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:52:0)
[02:47:08.700] Timer tick, asking Buildbucket for the build status
[02:47:08.848] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:08.848] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:53:0) after 1m0s
[02:48:09.004] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:53:0)
[02:48:09.004] Timer tick, asking Buildbucket for the build status
[02:48:09.088] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:09.088] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:54:0) after 1m0s
[02:49:09.295] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:54:0)
[02:49:09.295] Timer tick, asking Buildbucket for the build status
[02:49:09.365] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:09.365] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:55:0) after 1m0s
[02:50:09.598] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:55:0)
[02:50:09.598] Timer tick, asking Buildbucket for the build status
[02:50:09.787] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:09.787] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:56:0) after 1m0s
[02:51:09.891] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:56:0)
[02:51:09.891] Timer tick, asking Buildbucket for the build status
[02:51:09.957] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:09.957] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:57:0) after 1m0s
[02:52:10.030] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:57:0)
[02:52:10.030] Timer tick, asking Buildbucket for the build status
[02:52:10.396] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:10.396] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:58:0) after 1m0s
[02:53:10.509] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:58:0)
[02:53:10.509] Timer tick, asking Buildbucket for the build status
[02:53:10.590] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:10.590] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:59:0) after 1m0s
[02:54:10.642] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:59:0)
[02:54:10.642] Timer tick, asking Buildbucket for the build status
[02:54:10.800] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:10.800] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:60:0) after 1m0s
[02:55:10.914] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:60:0)
[02:55:10.914] Timer tick, asking Buildbucket for the build status
[02:55:10.997] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:10.997] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:61:0) after 1m0s
[02:56:11.163] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:61:0)
[02:56:11.163] Timer tick, asking Buildbucket for the build status
[02:56:12.085] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:12.085] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:62:0) after 1m0s
[02:57:12.192] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:62:0)
[02:57:12.192] Timer tick, asking Buildbucket for the build status
[02:57:12.323] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:12.323] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:63:0) after 1m0s
[02:58:12.414] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:63:0)
[02:58:12.414] Timer tick, asking Buildbucket for the build status
[02:58:12.532] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:12.532] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:64:0) after 1m0s
[02:59:12.648] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:64:0)
[02:59:12.648] Timer tick, asking Buildbucket for the build status
[02:59:12.756] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:12.756] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:65:0) after 1m0s
[03:00:12.849] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:65:0)
[03:00:12.849] Timer tick, asking Buildbucket for the build status
[03:00:12.972] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:12.972] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:66:0) after 1m0s
[03:01:14.053] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:66:0)
[03:01:14.053] Timer tick, asking Buildbucket for the build status
[03:01:14.125] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:14.125] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:67:0) after 1m0s
[03:02:14.281] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:67:0)
[03:02:14.281] Timer tick, asking Buildbucket for the build status
[03:02:14.686] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:14.686] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:68:0) after 1m0s
[03:03:14.714] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:68:0)
[03:03:14.714] Timer tick, asking Buildbucket for the build status
[03:03:14.820] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:14.820] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:69:0) after 1m0s
[03:04:14.938] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:69:0)
[03:04:14.938] Timer tick, asking Buildbucket for the build status
[03:04:15.063] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:15.063] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:70:0) after 1m0s
[03:05:15.319] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:70:0)
[03:05:15.319] Timer tick, asking Buildbucket for the build status
[03:05:15.625] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:15.625] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:71:0) after 1m0s
[03:06:15.761] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:71:0)
[03:06:15.761] Timer tick, asking Buildbucket for the build status
[03:06:15.978] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:15.978] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:72:0) after 1m0s
[03:07:15.989] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:72:0)
[03:07:15.989] Timer tick, asking Buildbucket for the build status
[03:07:16.201] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:16.202] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:73:0) after 1m0s
[03:08:16.264] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:73:0)
[03:08:16.264] Timer tick, asking Buildbucket for the build status
[03:08:16.426] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:16.426] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:74:0) after 1m0s
[03:09:16.563] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:74:0)
[03:09:16.563] Timer tick, asking Buildbucket for the build status
[03:09:16.660] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:16.660] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:75:0) after 1m0s
[03:10:16.744] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:75:0)
[03:10:16.744] Timer tick, asking Buildbucket for the build status
[03:10:16.864] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:16.864] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:76:0) after 1m0s
[03:11:16.919] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:76:0)
[03:11:16.919] Timer tick, asking Buildbucket for the build status
[03:11:16.983] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:16.983] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:77:0) after 1m0s
[03:12:17.083] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:77:0)
[03:12:17.083] Timer tick, asking Buildbucket for the build status
[03:12:17.207] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:17.207] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:78:0) after 1m0s
[03:13:17.279] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:78:0)
[03:13:17.279] Timer tick, asking Buildbucket for the build status
[03:13:17.452] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:17.452] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:79:0) after 1m0s
[03:14:17.548] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:79:0)
[03:14:17.548] Timer tick, asking Buildbucket for the build status
[03:14:17.672] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:17.672] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:80:0) after 1m0s
[03:15:17.742] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:80:0)
[03:15:17.742] Timer tick, asking Buildbucket for the build status
[03:15:17.842] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:17.842] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:81:0) after 1m0s
[03:16:17.861] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:81:0)
[03:16:17.861] Timer tick, asking Buildbucket for the build status
[03:16:17.958] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:17.958] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:82:0) after 1m0s
[03:17:18.005] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:82:0)
[03:17:18.005] Timer tick, asking Buildbucket for the build status
[03:17:18.156] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:18.156] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:83:0) after 1m0s
[03:18:18.220] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:83:0)
[03:18:18.220] Timer tick, asking Buildbucket for the build status
[03:18:19.788] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:19.789] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:84:0) after 1m0s
[03:19:19.799] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:84:0)
[03:19:19.799] Timer tick, asking Buildbucket for the build status
[03:19:19.870] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:19.870] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:85:0) after 1m0s
[03:20:19.905] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:85:0)
[03:20:19.905] Timer tick, asking Buildbucket for the build status
[03:20:20.085] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:20.085] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:86:0) after 1m0s
[03:21:20.184] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:86:0)
[03:21:20.184] Timer tick, asking Buildbucket for the build status
[03:21:20.259] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:20.259] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:87:0) after 1m0s
[03:22:20.434] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:87:0)
[03:22:20.434] Timer tick, asking Buildbucket for the build status
[03:22:20.558] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:20.558] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:88:0) after 1m0s
[03:23:20.785] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:88:0)
[03:23:20.785] Timer tick, asking Buildbucket for the build status
[03:23:21.056] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:21.056] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:89:0) after 1m0s
[03:24:21.264] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:89:0)
[03:24:21.264] Timer tick, asking Buildbucket for the build status
[03:24:29.187] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:29.187] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:90:0) after 1m0s
[03:25:29.402] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:90:0)
[03:25:29.402] Timer tick, asking Buildbucket for the build status
[03:25:29.480] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:29.480] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:91:0) after 1m0s
[03:26:29.576] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:91:0)
[03:26:29.576] Timer tick, asking Buildbucket for the build status
[03:26:29.686] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:29.686] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:92:0) after 1m0s
[03:27:30.291] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:92:0)
[03:27:30.291] Timer tick, asking Buildbucket for the build status
[03:27:30.467] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:30.467] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:93:0) after 1m0s
[03:28:30.638] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:93:0)
[03:28:30.638] Timer tick, asking Buildbucket for the build status
[03:28:30.829] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:30.829] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:94:0) after 1m0s
[03:29:30.949] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:94:0)
[03:29:30.949] Timer tick, asking Buildbucket for the build status
[03:29:31.023] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:31.023] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:95:0) after 1m0s
[03:30:31.078] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:95:0)
[03:30:31.078] Timer tick, asking Buildbucket for the build status
[03:30:31.169] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:31.169] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:96:0) after 1m0s
[03:31:31.501] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:96:0)
[03:31:31.502] Timer tick, asking Buildbucket for the build status
[03:31:31.575] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:31.575] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:97:0) after 1m0s
[03:32:31.624] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:97:0)
[03:32:31.624] Timer tick, asking Buildbucket for the build status
[03:32:31.757] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:31.757] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:98:0) after 1m0s
[03:33:31.893] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:98:0)
[03:33:31.893] Timer tick, asking Buildbucket for the build status
[03:33:32.375] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:32.375] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:99:0) after 1m0s
[03:34:32.412] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:99:0)
[03:34:32.412] Timer tick, asking Buildbucket for the build status
[03:34:35.397] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:35.397] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:100:0) after 1m0s
[03:35:35.544] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:100:0)
[03:35:35.544] Timer tick, asking Buildbucket for the build status
[03:35:35.625] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:35.625] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:101:0) after 1m0s
[03:36:35.752] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:101:0)
[03:36:35.752] Timer tick, asking Buildbucket for the build status
[03:36:35.867] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:35.867] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:102:0) after 1m0s
[03:37:35.933] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:102:0)
[03:37:35.933] Timer tick, asking Buildbucket for the build status
[03:37:36.075] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:36.075] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:103:0) after 1m0s
[03:38:36.217] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:103:0)
[03:38:36.217] Timer tick, asking Buildbucket for the build status
[03:38:36.324] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:36.324] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:104:0) after 1m0s
[03:39:36.439] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:104:0)
[03:39:36.439] Timer tick, asking Buildbucket for the build status
[03:39:36.545] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:36.545] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:105:0) after 1m0s
[03:40:36.560] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:105:0)
[03:40:36.561] Timer tick, asking Buildbucket for the build status
[03:40:36.761] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:36.761] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:106:0) after 1m0s
[03:41:36.868] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:106:0)
[03:41:36.868] Timer tick, asking Buildbucket for the build status
[03:41:37.163] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:37.163] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:107:0) after 1m0s
[03:42:37.262] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:107:0)
[03:42:37.262] Timer tick, asking Buildbucket for the build status
[03:42:37.646] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:37.646] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:108:0) after 1m0s
[03:43:37.773] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:108:0)
[03:43:37.773] Timer tick, asking Buildbucket for the build status
[03:43:37.927] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:37.927] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:109:0) after 1m0s
[03:44:38.069] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:109:0)
[03:44:38.069] Timer tick, asking Buildbucket for the build status
[03:44:38.392] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:38.392] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:110:0) after 1m0s
[03:45:38.636] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:110:0)
[03:45:38.636] Timer tick, asking Buildbucket for the build status
[03:45:38.739] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:38.739] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:111:0) after 1m0s
[03:46:39.003] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:111:0)
[03:46:39.003] Timer tick, asking Buildbucket for the build status
[03:46:39.076] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:39.076] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:112:0) after 1m0s
[03:47:39.269] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:112:0)
[03:47:39.269] Timer tick, asking Buildbucket for the build status
[03:47:39.509] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:39.509] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:113:0) after 1m0s
[03:48:39.661] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:113:0)
[03:48:39.661] Timer tick, asking Buildbucket for the build status
[03:48:39.748] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:39.749] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:114:0) after 1m0s
[03:49:39.926] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:114:0)
[03:49:39.926] Timer tick, asking Buildbucket for the build status
[03:49:40.011] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:40.011] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:115:0) after 1m0s
[03:50:40.045] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:115:0)
[03:50:40.045] Timer tick, asking Buildbucket for the build status
[03:50:40.149] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:40.149] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:116:0) after 1m0s
[03:51:40.232] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:116:0)
[03:51:40.232] Timer tick, asking Buildbucket for the build status
[03:51:40.343] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:40.343] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:117:0) after 1m0s
[03:52:40.437] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:117:0)
[03:52:40.437] Timer tick, asking Buildbucket for the build status
[03:52:40.585] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:40.585] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:118:0) after 1m0s
[03:53:40.579] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:118:0)
[03:53:40.579] Timer tick, asking Buildbucket for the build status
[03:53:40.679] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:40.679] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:119:0) after 1m0s
[03:54:40.717] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:119:0)
[03:54:40.717] Timer tick, asking Buildbucket for the build status
[03:54:40.798] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:40.798] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:120:0) after 1m0s
[03:55:41.005] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:120:0)
[03:55:41.005] Timer tick, asking Buildbucket for the build status
[03:55:41.123] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:41.123] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:121:0) after 1m0s
[03:56:41.130] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:121:0)
[03:56:41.130] Timer tick, asking Buildbucket for the build status
[03:56:41.255] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:41.255] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:122:0) after 1m0s
[03:57:41.403] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:122:0)
[03:57:41.403] Timer tick, asking Buildbucket for the build status
[03:57:41.575] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:41.575] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:123:0) after 1m0s
[03:58:41.657] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:123:0)
[03:58:41.657] Timer tick, asking Buildbucket for the build status
[03:58:41.847] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:41.847] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:124:0) after 1m0s
[03:59:41.985] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:124:0)
[03:59:41.985] Timer tick, asking Buildbucket for the build status
[03:59:42.074] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:42.074] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:125:0) after 1m0s
[04:00:42.172] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:125:0)
[04:00:42.172] Timer tick, asking Buildbucket for the build status
[04:00:42.325] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:42.325] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:126:0) after 1m0s
[04:01:42.581] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:126:0)
[04:01:42.581] Timer tick, asking Buildbucket for the build status
[04:01:42.848] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:42.848] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:127:0) after 1m0s
[04:02:42.998] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:127:0)
[04:02:42.998] Timer tick, asking Buildbucket for the build status
[04:02:43.161] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:43.161] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:128:0) after 1m0s
[04:03:43.302] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:128:0)
[04:03:43.302] Timer tick, asking Buildbucket for the build status
[04:03:43.388] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:43.388] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:129:0) after 1m0s
[04:04:43.418] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:129:0)
[04:04:43.418] Timer tick, asking Buildbucket for the build status
[04:04:43.501] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:43.502] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:130:0) after 1m0s
[04:05:43.676] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:130:0)
[04:05:43.676] Timer tick, asking Buildbucket for the build status
[04:05:43.738] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:43.738] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:131:0) after 1m0s
[04:06:43.839] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:131:0)
[04:06:43.839] Timer tick, asking Buildbucket for the build status
[04:06:43.943] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:43.943] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:132:0) after 1m0s
[04:07:44.172] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:132:0)
[04:07:44.172] Timer tick, asking Buildbucket for the build status
[04:07:44.339] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:44.339] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:133:0) after 1m0s
[04:08:44.587] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:133:0)
[04:08:44.587] Timer tick, asking Buildbucket for the build status
[04:08:44.792] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:44.792] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:134:0) after 1m0s
[04:09:44.901] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:134:0)
[04:09:44.901] Timer tick, asking Buildbucket for the build status
[04:09:44.995] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:44.995] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:135:0) after 1m0s
[04:10:45.049] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:135:0)
[04:10:45.049] Timer tick, asking Buildbucket for the build status
[04:10:45.125] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:45.125] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:136:0) after 1m0s
[04:11:45.240] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:136:0)
[04:11:45.240] Timer tick, asking Buildbucket for the build status
[04:11:45.595] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:45.595] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:137:0) after 1m0s
[04:12:45.745] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:137:0)
[04:12:45.745] Timer tick, asking Buildbucket for the build status
[04:12:45.869] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:45.869] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:138:0) after 1m0s
[04:13:45.967] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:138:0)
[04:13:45.967] Timer tick, asking Buildbucket for the build status
[04:13:46.064] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:46.065] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:139:0) after 1m0s
[04:14:46.106] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:139:0)
[04:14:46.106] Timer tick, asking Buildbucket for the build status
[04:14:46.578] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:46.578] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:140:0) after 1m0s
[04:15:46.614] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:140:0)
[04:15:46.614] Timer tick, asking Buildbucket for the build status
[04:15:46.713] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:46.713] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:141:0) after 1m0s
[04:16:46.824] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:141:0)
[04:16:46.824] Timer tick, asking Buildbucket for the build status
[04:16:47.073] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:47.073] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:142:0) after 1m0s
[04:17:47.128] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:142:0)
[04:17:47.128] Timer tick, asking Buildbucket for the build status
[04:17:48.363] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:48.363] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:143:0) after 1m0s
[04:18:48.512] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:143:0)
[04:18:48.512] Timer tick, asking Buildbucket for the build status
[04:18:48.829] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:48.829] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:144:0) after 1m0s
[04:19:48.894] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:144:0)
[04:19:48.894] Timer tick, asking Buildbucket for the build status
[04:19:49.044] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:49.044] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:145:0) after 1m0s
[04:20:49.162] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:145:0)
[04:20:49.162] Timer tick, asking Buildbucket for the build status
[04:20:49.243] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:49.243] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:146:0) after 1m0s
[04:21:49.310] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:146:0)
[04:21:49.310] Timer tick, asking Buildbucket for the build status
[04:21:49.382] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:49.382] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:147:0) after 1m0s
[04:22:49.492] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:147:0)
[04:22:49.492] Timer tick, asking Buildbucket for the build status
[04:22:49.660] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:49.660] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:148:0) after 1m0s
[04:23:49.704] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:148:0)
[04:23:49.704] Timer tick, asking Buildbucket for the build status
[04:23:49.781] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:49.781] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:149:0) after 1m0s
[04:24:49.848] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:149:0)
[04:24:49.848] Timer tick, asking Buildbucket for the build status
[04:24:49.927] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:49.927] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:150:0) after 1m0s
[04:25:49.970] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:150:0)
[04:25:49.970] Timer tick, asking Buildbucket for the build status
[04:25:50.027] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:50.027] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:151:0) after 1m0s
[04:26:50.096] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:151:0)
[04:26:50.096] Timer tick, asking Buildbucket for the build status
[04:26:50.175] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:50.175] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:152:0) after 1m0s
[04:27:50.255] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:152:0)
[04:27:50.255] Timer tick, asking Buildbucket for the build status
[04:27:50.353] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:50.353] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:153:0) after 1m0s
[04:28:50.461] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:153:0)
[04:28:50.461] Timer tick, asking Buildbucket for the build status
[04:28:50.543] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:50.543] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:154:0) after 1m0s
[04:29:50.580] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:154:0)
[04:29:50.580] Timer tick, asking Buildbucket for the build status
[04:29:54.225] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:54.226] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:155:0) after 1m0s
[04:30:54.259] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:155:0)
[04:30:54.259] Timer tick, asking Buildbucket for the build status
[04:30:54.370] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:54.370] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:156:0) after 1m0s
[04:31:54.413] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:156:0)
[04:31:54.413] Timer tick, asking Buildbucket for the build status
[04:31:54.493] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:54.493] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:157:0) after 1m0s
[04:32:54.508] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:157:0)
[04:32:54.509] Timer tick, asking Buildbucket for the build status
[04:32:54.754] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:54.754] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:158:0) after 1m0s
[04:33:54.878] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:158:0)
[04:33:54.878] Timer tick, asking Buildbucket for the build status
[04:33:54.953] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:54.953] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:159:0) after 1m0s
[04:34:55.139] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:159:0)
[04:34:55.139] Timer tick, asking Buildbucket for the build status
[04:34:55.229] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:55.229] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:160:0) after 1m0s
[04:35:55.263] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:160:0)
[04:35:55.263] Timer tick, asking Buildbucket for the build status
[04:35:55.515] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:55.515] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:161:0) after 1m0s
[04:36:55.563] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:161:0)
[04:36:55.563] Timer tick, asking Buildbucket for the build status
[04:36:55.754] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:55.754] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:162:0) after 1m0s
[04:37:55.797] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:162:0)
[04:37:55.797] Timer tick, asking Buildbucket for the build status
[04:37:56.601] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:56.602] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:163:0) after 1m0s
[04:38:56.623] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:163:0)
[04:38:56.623] Timer tick, asking Buildbucket for the build status
[04:38:56.699] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:56.699] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:164:0) after 1m0s
[04:39:56.782] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:164:0)
[04:39:56.782] Timer tick, asking Buildbucket for the build status
[04:39:56.841] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:56.841] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:165:0) after 1m0s
[04:40:56.977] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:165:0)
[04:40:56.977] Timer tick, asking Buildbucket for the build status
[04:40:57.427] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:57.427] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:166:0) after 1m0s
[04:41:57.457] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:166:0)
[04:41:57.457] Timer tick, asking Buildbucket for the build status
[04:41:57.774] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:57.774] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:167:0) after 1m0s
[04:42:57.943] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:167:0)
[04:42:57.943] Timer tick, asking Buildbucket for the build status
[04:42:58.089] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:58.089] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:168:0) after 1m0s
[04:43:58.234] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:168:0)
[04:43:58.234] Timer tick, asking Buildbucket for the build status
[04:43:58.303] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:58.303] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:169:0) after 1m0s
[04:44:58.375] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:169:0)
[04:44:58.375] Timer tick, asking Buildbucket for the build status
[04:44:58.447] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:58.447] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:170:0) after 1m0s
[04:45:58.566] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:170:0)
[04:45:58.566] Timer tick, asking Buildbucket for the build status
[04:45:58.797] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:58.797] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:171:0) after 1m0s
[04:46:58.896] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:171:0)
[04:46:58.896] Timer tick, asking Buildbucket for the build status
[04:46:58.975] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:58.975] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:172:0) after 1m0s
[04:47:59.037] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:172:0)
[04:47:59.037] Timer tick, asking Buildbucket for the build status
[04:47:59.155] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:59.155] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:173:0) after 1m0s
[04:48:59.252] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:173:0)
[04:48:59.252] Timer tick, asking Buildbucket for the build status
[04:48:59.394] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:59.394] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:174:0) after 1m0s
[04:49:59.474] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:174:0)
[04:49:59.474] Timer tick, asking Buildbucket for the build status
[04:49:59.588] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:59.588] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:175:0) after 1m0s
[04:50:59.629] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:175:0)
[04:50:59.629] Timer tick, asking Buildbucket for the build status
[04:50:59.718] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:59.719] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:176:0) after 1m0s
[04:51:59.752] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:176:0)
[04:51:59.752] Timer tick, asking Buildbucket for the build status
[04:51:59.813] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:59.813] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:177:0) after 1m0s
[04:52:59.844] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:177:0)
[04:52:59.844] Timer tick, asking Buildbucket for the build status
[04:53:01.563] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:01.563] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:178:0) after 1m0s
[04:54:02.240] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:178:0)
[04:54:02.240] Timer tick, asking Buildbucket for the build status
[04:54:02.300] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:02.300] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:179:0) after 1m0s
[04:55:02.365] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:179:0)
[04:55:02.365] Timer tick, asking Buildbucket for the build status
[04:55:02.447] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:02.447] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:180:0) after 1m0s
[04:56:02.511] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:180:0)
[04:56:02.511] Timer tick, asking Buildbucket for the build status
[04:56:02.595] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:02.595] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:181:0) after 1m0s
[04:57:02.930] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:181:0)
[04:57:02.930] Timer tick, asking Buildbucket for the build status
[04:57:02.994] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:02.994] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:182:0) after 1m0s
[04:58:03.101] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:182:0)
[04:58:03.101] Timer tick, asking Buildbucket for the build status
[04:58:03.638] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:03.638] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:183:0) after 1m0s
[04:59:03.862] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:183:0)
[04:59:03.862] Timer tick, asking Buildbucket for the build status
[04:59:04.008] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:04.008] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:184:0) after 1m0s
[05:00:04.094] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:184:0)
[05:00:04.094] Timer tick, asking Buildbucket for the build status
[05:00:04.182] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:04.182] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:185:0) after 1m0s
[05:01:04.176] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:185:0)
[05:01:04.176] Timer tick, asking Buildbucket for the build status
[05:01:04.381] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:04.381] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:186:0) after 1m0s
[05:02:04.446] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:186:0)
[05:02:04.446] Timer tick, asking Buildbucket for the build status
[05:02:04.571] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:04.571] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:187:0) after 1m0s
[05:03:04.615] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:187:0)
[05:03:04.615] Timer tick, asking Buildbucket for the build status
[05:03:04.755] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:04.755] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:188:0) after 1m0s
[05:04:04.828] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:188:0)
[05:04:04.828] Timer tick, asking Buildbucket for the build status
[05:04:05.096] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:05.096] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:189:0) after 1m0s
[05:05:05.128] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:189:0)
[05:05:05.128] Timer tick, asking Buildbucket for the build status
[05:05:08.920] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:08.920] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:190:0) after 1m0s
[05:06:09.051] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:190:0)
[05:06:09.052] Timer tick, asking Buildbucket for the build status
[05:06:09.214] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:09.214] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:191:0) after 1m0s
[05:07:09.253] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:191:0)
[05:07:09.253] Timer tick, asking Buildbucket for the build status
[05:07:09.440] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:09.440] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:192:0) after 1m0s
[05:08:09.486] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:192:0)
[05:08:09.486] Timer tick, asking Buildbucket for the build status
[05:08:09.607] Build 8871395470012349440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:09.607] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036825532197111600:193:0) after 1m0s
[05:08:31.671] Received PubSub notification, asking Buildbucket for the build status
[05:08:31.759] Build 8871395470012349440: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:08:31.759] Buildbucket build:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "completed_ts": "1597986510795565",
    "created_by": "project:chromium",
    "created_ts": "1597975011774307",
    "id": "8871395470012349440",
    "parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e4c22acead672653aa9c3b5db3ceb3f6d3c5e456\"}}",
    "project": "chromium",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {\"$build/chromium_tests\": {\"bucketed_triggers\": true}, \"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$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-7-oles\", \"branch\": \"refs/heads/master\", \"buildername\": \"win-official\", \"buildnumber\": 385, \"got_angle_revision\": \"c060d8d65786a4cfee3e43b70476354f05987c7d\", \"got_dawn_revision\": \"ab4e4feb01ac2e3fc4d202ebf261817b664b69d9\", \"got_nacl_revision\": \"3008f9e6de122325d8f9dbf02f7cdd51fa1ec306\", \"got_revision\": \"e4c22acead672653aa9c3b5db3ceb3f6d3c5e456\", \"got_revision_cp\": \"refs/heads/master@{#800419}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"44e1791f100c18aa8cbfc4fef18727f32f6b9eba\", \"got_v8_revision\": \"a64aed2333abf49e494d2a5ce24bbd14fff19f60\", \"got_v8_revision_cp\": \"refs/heads/8.6.395@{#1}\", \"got_webrtc_revision\": \"bedb605c82720509975daa4e05146f55d3d09e10\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31976}\", \"mastername\": \"chromium\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e4c22acead672653aa9c3b5db3ceb3f6d3c5e456\"}, \"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-7-oles\"], \"image\": [\"chrome-win10-1703-20081700-d9392568d25\"], \"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\": [\"5498-3454aa6\"], \"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": "1597975053183831",
    "status": "COMPLETED",
    "status_changed_ts": "1597986511171806",
    "tags": [
      "build_address:luci.chromium.ci/win-official/385",
      "builder:win-official",
      "buildset:commit/git/e4c22acead672653aa9c3b5db3ceb3f6d3c5e456",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e4c22acead672653aa9c3b5db3ceb3f6d3c5e456",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9036825532197111600",
      "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/8871395470012349440/+/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:4e278d2efca17210",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1597986511177229",
    "url": "https://ci.chromium.org/b/8871395470012349440",
    "utcnow_ts": "1597986511752739"
  }
}
[05:08:31.759] Invocation finished in 3h11m41.452154792s with status SUCCEEDED