LUCI Scheduler :: chromium :: win-official

Status: SUCCEEDED

Triggered by: -

Duration: 4 hours

Actions:

Definition (rev 835dd06986af6863f902c628becb4df908d0fc20)

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

Incoming triggers

4daa5122518cd0550746f3f637635f4285695d5f (4 years ago)
f489cb525b8e4d70452eaf4470120cbb100a4395 (4 years ago)
95fc11b56459394fe89299aa28565154051ba8ff (4 years ago)
e1261485b87bb382c039b5cc2a515025c3a8c9ec (4 years ago)
10f2f0a8d4a666e32d718573af0bc1d8289dcca3 (4 years ago)
3630bba35693b7669d66dcc3a3eb04276854ca7f (4 years ago)
bf5aa15ebf3af09662d2f0e7025f724d0bd287d2 (4 years ago)
8446e0d6c24715ccbc0dfdf9d1e58d6ecaa15225 (4 years ago)
22f65038fa8c2d2cd9143435b89ac5f200c33bb2 (4 years ago)

Incoming properties

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

Incoming tags

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

Debug log (UTC)

[11:09:03.054] New invocation is queued and will start shortly
[11:09:04.442] Starting the invocation (attempt 1)
[11:09:04.474] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:09:04.474] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:09:04.474] Buildbucket request:
{
  "bucket": "luci.chromium.ci",
  "client_operation_id": "9020120948214034064",
  "parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"22f65038fa8c2d2cd9143435b89ac5f200c33bb2\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:win-official",
    "scheduler_invocation_id:9020120948214034064",
    "scheduler_job_id:chromium/win-official",
    "user_agent:luci-scheduler",
    "buildset:commit/git/22f65038fa8c2d2cd9143435b89ac5f200c33bb2",
    "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/22f65038fa8c2d2cd9143435b89ac5f200c33bb2",
    "gitiles_ref:refs/heads/master"
  ]
}
[11:09:05.103] Buildbucket response:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "created_by": "project:chromium",
    "created_ts": "1613905744574619",
    "id": "8854690885936282624",
    "parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"22f65038fa8c2d2cd9143435b89ac5f200c33bb2\"}}",
    "project": "chromium",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1613905745001841",
    "tags": [
      "build_address:luci.chromium.ci/win-official/1636",
      "builder:win-official",
      "buildset:commit/git/22f65038fa8c2d2cd9143435b89ac5f200c33bb2",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/22f65038fa8c2d2cd9143435b89ac5f200c33bb2",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9020120948214034064",
      "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/8854690885936282624/+/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": "1613905745001950",
    "url": "https://ci.chromium.org/b/8854690885936282624",
    "utcnow_ts": "1613905745095559"
  }
}
[11:09:05.103] Task URL: https://ci.chromium.org/b/8854690885936282624
[11:09:05.103] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:2:0) after 1m0s
[11:10:05.806] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:2:0)
[11:10:05.806] Timer tick, asking Buildbucket for the build status
[11:10:06.088] Build 8854690885936282624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:10:06.088] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:3:0) after 1m0s
[11:10:54.272] Received PubSub notification, asking Buildbucket for the build status
[11:10:54.355] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:07.352] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:3:0)
[11:11:07.352] Timer tick, asking Buildbucket for the build status
[11:11:07.417] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:07.417] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:5:0) after 1m0s
[11:12:07.474] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:5:0)
[11:12:07.474] Timer tick, asking Buildbucket for the build status
[11:12:07.557] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:07.557] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:6:0) after 1m0s
[11:13:07.624] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:6:0)
[11:13:07.624] Timer tick, asking Buildbucket for the build status
[11:13:07.804] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:07.804] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:7:0) after 1m0s
[11:14:07.778] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:7:0)
[11:14:07.778] Timer tick, asking Buildbucket for the build status
[11:14:07.868] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:07.868] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:8:0) after 1m0s
[11:15:07.884] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:8:0)
[11:15:07.884] Timer tick, asking Buildbucket for the build status
[11:15:08.023] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:08.023] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:9:0) after 1m0s
[11:16:08.044] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:9:0)
[11:16:08.044] Timer tick, asking Buildbucket for the build status
[11:16:08.140] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:08.140] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:10:0) after 1m0s
[11:17:08.157] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:10:0)
[11:17:08.157] Timer tick, asking Buildbucket for the build status
[11:17:08.241] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:08.241] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:11:0) after 1m0s
[11:18:08.269] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:11:0)
[11:18:08.269] Timer tick, asking Buildbucket for the build status
[11:18:08.439] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:08.439] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:12:0) after 1m0s
[11:19:08.456] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:12:0)
[11:19:08.456] Timer tick, asking Buildbucket for the build status
[11:19:08.553] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:08.553] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:13:0) after 1m0s
[11:20:08.532] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:13:0)
[11:20:08.532] Timer tick, asking Buildbucket for the build status
[11:20:08.604] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:08.604] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:14:0) after 1m0s
[11:21:08.618] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:14:0)
[11:21:08.618] Timer tick, asking Buildbucket for the build status
[11:21:08.725] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:08.726] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:15:0) after 1m0s
[11:22:08.742] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:15:0)
[11:22:08.742] Timer tick, asking Buildbucket for the build status
[11:22:08.838] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:08.838] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:16:0) after 1m0s
[11:23:08.885] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:16:0)
[11:23:08.885] Timer tick, asking Buildbucket for the build status
[11:23:08.981] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:08.981] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:17:0) after 1m0s
[11:24:09.003] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:17:0)
[11:24:09.003] Timer tick, asking Buildbucket for the build status
[11:24:09.306] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:09.306] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:18:0) after 1m0s
[11:25:09.323] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:18:0)
[11:25:09.323] Timer tick, asking Buildbucket for the build status
[11:25:09.609] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:09.609] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:19:0) after 1m0s
[11:26:09.634] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:19:0)
[11:26:09.634] Timer tick, asking Buildbucket for the build status
[11:26:09.703] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:09.703] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:20:0) after 1m0s
[11:27:09.748] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:20:0)
[11:27:09.748] Timer tick, asking Buildbucket for the build status
[11:27:09.842] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:09.842] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:21:0) after 1m0s
[11:28:09.861] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:21:0)
[11:28:09.861] Timer tick, asking Buildbucket for the build status
[11:28:10.027] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:10.027] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:22:0) after 1m0s
[11:29:10.053] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:22:0)
[11:29:10.053] Timer tick, asking Buildbucket for the build status
[11:29:10.210] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:10.210] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:23:0) after 1m0s
[11:30:10.305] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:23:0)
[11:30:10.305] Timer tick, asking Buildbucket for the build status
[11:30:10.542] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:10.542] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:24:0) after 1m0s
[11:31:10.603] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:24:0)
[11:31:10.603] Timer tick, asking Buildbucket for the build status
[11:31:10.686] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:10.686] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:25:0) after 1m0s
[11:32:10.837] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:25:0)
[11:32:10.837] Timer tick, asking Buildbucket for the build status
[11:32:10.906] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:10.906] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:26:0) after 1m0s
[11:33:11.086] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:26:0)
[11:33:11.086] Timer tick, asking Buildbucket for the build status
[11:33:11.298] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:11.299] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:27:0) after 1m0s
[11:34:11.426] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:27:0)
[11:34:11.426] Timer tick, asking Buildbucket for the build status
[11:34:11.944] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:11.944] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:28:0) after 1m0s
[11:35:12.036] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:28:0)
[11:35:12.036] Timer tick, asking Buildbucket for the build status
[11:35:12.110] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:12.110] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:29:0) after 1m0s
[11:36:12.196] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:29:0)
[11:36:12.196] Timer tick, asking Buildbucket for the build status
[11:36:12.516] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:12.516] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:30:0) after 1m0s
[11:37:12.628] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:30:0)
[11:37:12.628] Timer tick, asking Buildbucket for the build status
[11:37:12.708] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:12.708] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:31:0) after 1m0s
[11:38:12.749] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:31:0)
[11:38:12.749] Timer tick, asking Buildbucket for the build status
[11:38:12.829] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:12.829] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:32:0) after 1m0s
[11:39:12.891] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:32:0)
[11:39:12.891] Timer tick, asking Buildbucket for the build status
[11:39:13.410] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:13.410] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:33:0) after 1m0s
[11:40:13.493] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:33:0)
[11:40:13.493] Timer tick, asking Buildbucket for the build status
[11:40:13.561] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:13.561] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:34:0) after 1m0s
[11:41:13.672] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:34:0)
[11:41:13.672] Timer tick, asking Buildbucket for the build status
[11:41:13.838] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:13.838] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:35:0) after 1m0s
[11:42:13.888] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:35:0)
[11:42:13.888] Timer tick, asking Buildbucket for the build status
[11:42:13.952] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:13.952] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:36:0) after 1m0s
[11:43:13.925] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:36:0)
[11:43:13.925] Timer tick, asking Buildbucket for the build status
[11:43:14.012] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:14.012] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:37:0) after 1m0s
[11:44:14.060] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:37:0)
[11:44:14.060] Timer tick, asking Buildbucket for the build status
[11:44:14.142] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:14.142] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:38:0) after 1m0s
[11:45:14.233] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:38:0)
[11:45:14.233] Timer tick, asking Buildbucket for the build status
[11:45:14.516] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:14.516] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:39:0) after 1m0s
[11:46:14.603] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:39:0)
[11:46:14.603] Timer tick, asking Buildbucket for the build status
[11:46:14.698] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:14.698] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:40:0) after 1m0s
[11:47:14.713] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:40:0)
[11:47:14.713] Timer tick, asking Buildbucket for the build status
[11:47:14.917] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:14.917] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:41:0) after 1m0s
[11:48:14.937] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:41:0)
[11:48:14.937] Timer tick, asking Buildbucket for the build status
[11:48:15.012] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:15.012] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:42:0) after 1m0s
[11:49:15.068] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:42:0)
[11:49:15.068] Timer tick, asking Buildbucket for the build status
[11:49:15.564] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:15.564] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:43:0) after 1m0s
[11:50:15.627] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:43:0)
[11:50:15.627] Timer tick, asking Buildbucket for the build status
[11:50:15.905] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:15.905] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:44:0) after 1m0s
[11:51:15.986] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:44:0)
[11:51:15.986] Timer tick, asking Buildbucket for the build status
[11:51:16.101] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:16.101] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:45:0) after 1m0s
[11:52:16.189] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:45:0)
[11:52:16.189] Timer tick, asking Buildbucket for the build status
[11:52:16.339] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:16.339] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:46:0) after 1m0s
[11:53:16.394] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:46:0)
[11:53:16.394] Timer tick, asking Buildbucket for the build status
[11:53:16.523] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:16.523] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:47:0) after 1m0s
[11:54:16.591] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:47:0)
[11:54:16.591] Timer tick, asking Buildbucket for the build status
[11:54:16.685] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:16.685] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:48:0) after 1m0s
[11:55:16.848] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:48:0)
[11:55:16.848] Timer tick, asking Buildbucket for the build status
[11:55:16.931] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:16.931] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:49:0) after 1m0s
[11:56:16.961] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:49:0)
[11:56:16.961] Timer tick, asking Buildbucket for the build status
[11:56:17.217] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:17.217] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:50:0) after 1m0s
[11:57:17.279] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:50:0)
[11:57:17.279] Timer tick, asking Buildbucket for the build status
[11:57:17.636] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:17.636] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:51:0) after 1m0s
[11:58:17.656] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:51:0)
[11:58:17.656] Timer tick, asking Buildbucket for the build status
[11:58:17.747] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:17.747] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:52:0) after 1m0s
[11:59:17.797] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:52:0)
[11:59:17.797] Timer tick, asking Buildbucket for the build status
[11:59:17.994] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:17.994] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:53:0) after 1m0s
[12:00:18.017] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:53:0)
[12:00:18.017] Timer tick, asking Buildbucket for the build status
[12:00:18.255] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:18.255] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:54:0) after 1m0s
[12:01:18.277] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:54:0)
[12:01:18.277] Timer tick, asking Buildbucket for the build status
[12:01:18.542] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:18.542] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:55:0) after 1m0s
[12:02:18.569] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:55:0)
[12:02:18.569] Timer tick, asking Buildbucket for the build status
[12:02:18.642] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:18.642] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:56:0) after 1m0s
[12:03:18.755] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:56:0)
[12:03:18.755] Timer tick, asking Buildbucket for the build status
[12:03:18.836] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:18.836] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:57:0) after 1m0s
[12:04:18.860] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:57:0)
[12:04:18.860] Timer tick, asking Buildbucket for the build status
[12:04:19.035] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:19.035] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:58:0) after 1m0s
[12:05:19.055] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:58:0)
[12:05:19.056] Timer tick, asking Buildbucket for the build status
[12:05:19.212] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:19.212] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:59:0) after 1m0s
[12:06:19.312] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:59:0)
[12:06:19.312] Timer tick, asking Buildbucket for the build status
[12:06:19.402] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:19.402] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:60:0) after 1m0s
[12:07:19.440] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:60:0)
[12:07:19.440] Timer tick, asking Buildbucket for the build status
[12:07:19.515] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:19.515] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:61:0) after 1m0s
[12:08:19.536] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:61:0)
[12:08:19.536] Timer tick, asking Buildbucket for the build status
[12:08:19.603] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:19.603] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:62:0) after 1m0s
[12:09:19.668] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:62:0)
[12:09:19.668] Timer tick, asking Buildbucket for the build status
[12:09:19.793] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:19.793] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:63:0) after 1m0s
[12:10:19.811] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:63:0)
[12:10:19.811] Timer tick, asking Buildbucket for the build status
[12:10:19.872] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:19.873] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:64:0) after 1m0s
[12:11:19.988] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:64:0)
[12:11:19.988] Timer tick, asking Buildbucket for the build status
[12:11:20.086] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:20.086] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:65:0) after 1m0s
[12:12:20.122] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:65:0)
[12:12:20.122] Timer tick, asking Buildbucket for the build status
[12:12:20.410] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:20.410] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:66:0) after 1m0s
[12:13:20.553] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:66:0)
[12:13:20.553] Timer tick, asking Buildbucket for the build status
[12:13:23.025] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:23.025] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:67:0) after 1m0s
[12:14:23.103] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:67:0)
[12:14:23.103] Timer tick, asking Buildbucket for the build status
[12:14:23.337] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:23.337] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:68:0) after 1m0s
[12:15:23.355] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:68:0)
[12:15:23.355] Timer tick, asking Buildbucket for the build status
[12:15:23.535] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:23.535] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:69:0) after 1m0s
[12:16:23.556] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:69:0)
[12:16:23.556] Timer tick, asking Buildbucket for the build status
[12:16:24.077] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:24.077] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:70:0) after 1m0s
[12:17:24.146] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:70:0)
[12:17:24.146] Timer tick, asking Buildbucket for the build status
[12:17:24.223] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:24.223] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:71:0) after 1m0s
[12:18:24.239] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:71:0)
[12:18:24.239] Timer tick, asking Buildbucket for the build status
[12:18:24.304] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:24.304] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:72:0) after 1m0s
[12:19:24.335] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:72:0)
[12:19:24.335] Timer tick, asking Buildbucket for the build status
[12:19:24.419] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:24.419] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:73:0) after 1m0s
[12:20:24.456] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:73:0)
[12:20:24.456] Timer tick, asking Buildbucket for the build status
[12:20:24.542] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:24.542] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:74:0) after 1m0s
[12:21:24.530] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:74:0)
[12:21:24.530] Timer tick, asking Buildbucket for the build status
[12:21:24.636] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:24.636] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:75:0) after 1m0s
[12:22:25.049] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:75:0)
[12:22:25.049] Timer tick, asking Buildbucket for the build status
[12:22:25.142] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:25.142] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:76:0) after 1m0s
[12:23:25.450] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:76:0)
[12:23:25.450] Timer tick, asking Buildbucket for the build status
[12:23:25.784] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:25.784] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:77:0) after 1m0s
[12:24:25.945] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:77:0)
[12:24:25.945] Timer tick, asking Buildbucket for the build status
[12:24:26.031] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:26.031] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:78:0) after 1m0s
[12:25:26.234] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:78:0)
[12:25:26.234] Timer tick, asking Buildbucket for the build status
[12:25:26.421] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:26.421] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:79:0) after 1m0s
[12:26:26.639] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:79:0)
[12:26:26.639] Timer tick, asking Buildbucket for the build status
[12:26:26.709] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:26.709] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:80:0) after 1m0s
[12:27:26.728] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:80:0)
[12:27:26.728] Timer tick, asking Buildbucket for the build status
[12:27:27.028] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:27.028] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:81:0) after 1m0s
[12:28:27.050] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:81:0)
[12:28:27.050] Timer tick, asking Buildbucket for the build status
[12:28:27.238] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:27.238] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:82:0) after 1m0s
[12:29:27.255] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:82:0)
[12:29:27.255] Timer tick, asking Buildbucket for the build status
[12:29:27.357] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:27.357] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:83:0) after 1m0s
[12:30:27.545] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:83:0)
[12:30:27.545] Timer tick, asking Buildbucket for the build status
[12:30:27.709] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:27.709] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:84:0) after 1m0s
[12:31:27.878] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:84:0)
[12:31:27.878] Timer tick, asking Buildbucket for the build status
[12:31:27.953] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:27.953] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:85:0) after 1m0s
[12:32:28.078] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:85:0)
[12:32:28.078] Timer tick, asking Buildbucket for the build status
[12:32:28.221] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:28.221] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:86:0) after 1m0s
[12:33:28.392] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:86:0)
[12:33:28.392] Timer tick, asking Buildbucket for the build status
[12:33:28.464] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:28.464] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:87:0) after 1m0s
[12:34:28.534] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:87:0)
[12:34:28.534] Timer tick, asking Buildbucket for the build status
[12:34:28.622] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:28.622] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:88:0) after 1m0s
[12:35:28.748] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:88:0)
[12:35:28.748] Timer tick, asking Buildbucket for the build status
[12:35:28.950] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:28.950] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:89:0) after 1m0s
[12:36:29.054] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:89:0)
[12:36:29.054] Timer tick, asking Buildbucket for the build status
[12:36:29.206] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:29.206] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:90:0) after 1m0s
[12:37:29.254] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:90:0)
[12:37:29.254] Timer tick, asking Buildbucket for the build status
[12:37:29.737] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:29.737] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:91:0) after 1m0s
[12:38:29.861] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:91:0)
[12:38:29.861] Timer tick, asking Buildbucket for the build status
[12:38:29.943] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:29.943] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:92:0) after 1m0s
[12:39:30.241] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:92:0)
[12:39:30.241] Timer tick, asking Buildbucket for the build status
[12:39:30.342] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:30.342] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:93:0) after 1m0s
[12:40:30.449] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:93:0)
[12:40:30.449] Timer tick, asking Buildbucket for the build status
[12:40:30.617] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:30.617] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:94:0) after 1m0s
[12:41:30.765] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:94:0)
[12:41:30.765] Timer tick, asking Buildbucket for the build status
[12:41:30.835] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:30.835] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:95:0) after 1m0s
[12:42:31.019] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:95:0)
[12:42:31.019] Timer tick, asking Buildbucket for the build status
[12:42:31.097] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:31.097] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:96:0) after 1m0s
[12:43:31.158] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:96:0)
[12:43:31.158] Timer tick, asking Buildbucket for the build status
[12:43:31.229] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:31.229] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:97:0) after 1m0s
[12:44:31.423] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:97:0)
[12:44:31.423] Timer tick, asking Buildbucket for the build status
[12:44:31.797] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:31.797] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:98:0) after 1m0s
[12:45:31.830] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:98:0)
[12:45:31.830] Timer tick, asking Buildbucket for the build status
[12:45:31.892] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:31.892] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:99:0) after 1m0s
[12:46:32.032] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:99:0)
[12:46:32.032] Timer tick, asking Buildbucket for the build status
[12:46:32.113] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:32.113] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:100:0) after 1m0s
[12:47:32.144] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:100:0)
[12:47:32.144] Timer tick, asking Buildbucket for the build status
[12:47:32.406] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:32.406] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:101:0) after 1m0s
[12:48:32.528] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:101:0)
[12:48:32.529] Timer tick, asking Buildbucket for the build status
[12:48:32.591] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:32.591] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:102:0) after 1m0s
[12:49:32.899] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:102:0)
[12:49:32.899] Timer tick, asking Buildbucket for the build status
[12:49:32.974] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:32.974] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:103:0) after 1m0s
[12:50:33.235] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:103:0)
[12:50:33.235] Timer tick, asking Buildbucket for the build status
[12:50:33.621] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:33.621] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:104:0) after 1m0s
[12:51:33.742] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:104:0)
[12:51:33.742] Timer tick, asking Buildbucket for the build status
[12:51:33.848] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:33.848] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:105:0) after 1m0s
[12:52:33.974] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:105:0)
[12:52:33.974] Timer tick, asking Buildbucket for the build status
[12:52:34.046] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:34.046] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:106:0) after 1m0s
[12:53:34.090] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:106:0)
[12:53:34.090] Timer tick, asking Buildbucket for the build status
[12:53:34.239] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:34.239] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:107:0) after 1m0s
[12:54:34.391] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:107:0)
[12:54:34.391] Timer tick, asking Buildbucket for the build status
[12:54:34.938] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:34.938] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:108:0) after 1m0s
[12:55:35.050] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:108:0)
[12:55:35.050] Timer tick, asking Buildbucket for the build status
[12:55:35.128] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:35.128] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:109:0) after 1m0s
[12:56:35.233] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:109:0)
[12:56:35.233] Timer tick, asking Buildbucket for the build status
[12:56:35.338] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:35.338] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:110:0) after 1m0s
[12:57:35.464] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:110:0)
[12:57:35.464] Timer tick, asking Buildbucket for the build status
[12:57:35.581] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:35.581] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:111:0) after 1m0s
[12:58:35.789] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:111:0)
[12:58:35.789] Timer tick, asking Buildbucket for the build status
[12:58:35.852] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:35.852] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:112:0) after 1m0s
[12:59:35.970] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:112:0)
[12:59:35.970] Timer tick, asking Buildbucket for the build status
[12:59:36.071] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:36.071] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:113:0) after 1m0s
[13:00:36.092] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:113:0)
[13:00:36.092] Timer tick, asking Buildbucket for the build status
[13:00:36.332] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:36.332] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:114:0) after 1m0s
[13:01:36.394] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:114:0)
[13:01:36.394] Timer tick, asking Buildbucket for the build status
[13:01:36.465] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:36.465] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:115:0) after 1m0s
[13:02:36.532] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:115:0)
[13:02:36.532] Timer tick, asking Buildbucket for the build status
[13:02:36.595] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:36.595] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:116:0) after 1m0s
[13:03:36.695] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:116:0)
[13:03:36.695] Timer tick, asking Buildbucket for the build status
[13:03:36.918] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:36.918] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:117:0) after 1m0s
[13:04:36.955] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:117:0)
[13:04:36.955] Timer tick, asking Buildbucket for the build status
[13:04:37.208] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:37.208] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:118:0) after 1m0s
[13:05:37.250] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:118:0)
[13:05:37.250] Timer tick, asking Buildbucket for the build status
[13:05:37.333] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:37.333] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:119:0) after 1m0s
[13:06:37.355] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:119:0)
[13:06:37.355] Timer tick, asking Buildbucket for the build status
[13:06:37.427] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:37.427] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:120:0) after 1m0s
[13:07:37.427] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:120:0)
[13:07:37.427] Timer tick, asking Buildbucket for the build status
[13:07:37.509] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:37.509] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:121:0) after 1m0s
[13:08:37.611] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:121:0)
[13:08:37.611] Timer tick, asking Buildbucket for the build status
[13:08:37.690] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:37.690] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:122:0) after 1m0s
[13:09:37.737] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:122:0)
[13:09:37.737] Timer tick, asking Buildbucket for the build status
[13:09:37.823] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:37.823] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:123:0) after 1m0s
[13:10:37.872] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:123:0)
[13:10:37.872] Timer tick, asking Buildbucket for the build status
[13:10:37.952] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:37.952] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:124:0) after 1m0s
[13:11:38.142] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:124:0)
[13:11:38.142] Timer tick, asking Buildbucket for the build status
[13:11:38.220] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:38.220] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:125:0) after 1m0s
[13:12:38.466] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:125:0)
[13:12:38.466] Timer tick, asking Buildbucket for the build status
[13:12:38.540] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:38.540] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:126:0) after 1m0s
[13:13:38.631] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:126:0)
[13:13:38.631] Timer tick, asking Buildbucket for the build status
[13:13:38.710] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:38.710] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:127:0) after 1m0s
[13:14:38.758] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:127:0)
[13:14:38.758] Timer tick, asking Buildbucket for the build status
[13:14:38.911] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:38.911] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:128:0) after 1m0s
[13:15:39.158] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:128:0)
[13:15:39.158] Timer tick, asking Buildbucket for the build status
[13:15:39.303] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:39.303] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:129:0) after 1m0s
[13:16:39.452] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:129:0)
[13:16:39.452] Timer tick, asking Buildbucket for the build status
[13:16:39.537] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:39.537] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:130:0) after 1m0s
[13:17:39.642] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:130:0)
[13:17:39.642] Timer tick, asking Buildbucket for the build status
[13:17:39.723] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:39.723] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:131:0) after 1m0s
[13:18:39.873] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:131:0)
[13:18:39.873] Timer tick, asking Buildbucket for the build status
[13:18:40.266] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:40.266] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:132:0) after 1m0s
[13:19:40.377] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:132:0)
[13:19:40.377] Timer tick, asking Buildbucket for the build status
[13:19:40.489] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:40.489] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:133:0) after 1m0s
[13:20:40.732] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:133:0)
[13:20:40.732] Timer tick, asking Buildbucket for the build status
[13:20:40.915] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:40.915] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:134:0) after 1m0s
[13:21:40.970] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:134:0)
[13:21:40.970] Timer tick, asking Buildbucket for the build status
[13:21:41.050] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:41.050] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:135:0) after 1m0s
[13:22:41.111] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:135:0)
[13:22:41.111] Timer tick, asking Buildbucket for the build status
[13:22:41.179] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:41.179] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:136:0) after 1m0s
[13:23:41.277] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:136:0)
[13:23:41.277] Timer tick, asking Buildbucket for the build status
[13:23:41.378] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:41.378] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:137:0) after 1m0s
[13:24:41.428] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:137:0)
[13:24:41.428] Timer tick, asking Buildbucket for the build status
[13:24:41.555] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:41.555] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:138:0) after 1m0s
[13:25:41.602] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:138:0)
[13:25:41.602] Timer tick, asking Buildbucket for the build status
[13:25:41.893] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:41.893] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:139:0) after 1m0s
[13:26:42.081] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:139:0)
[13:26:42.081] Timer tick, asking Buildbucket for the build status
[13:26:42.176] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:42.176] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:140:0) after 1m0s
[13:27:42.208] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:140:0)
[13:27:42.208] Timer tick, asking Buildbucket for the build status
[13:27:42.280] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:42.280] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:141:0) after 1m0s
[13:28:42.402] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:141:0)
[13:28:42.402] Timer tick, asking Buildbucket for the build status
[13:28:42.525] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:42.525] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:142:0) after 1m0s
[13:29:42.615] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:142:0)
[13:29:42.615] Timer tick, asking Buildbucket for the build status
[13:29:42.937] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:42.937] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:143:0) after 1m0s
[13:30:42.989] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:143:0)
[13:30:42.989] Timer tick, asking Buildbucket for the build status
[13:30:43.118] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:43.118] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:144:0) after 1m0s
[13:31:43.417] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:144:0)
[13:31:43.417] Timer tick, asking Buildbucket for the build status
[13:31:43.491] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:43.491] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:145:0) after 1m0s
[13:32:43.730] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:145:0)
[13:32:43.730] Timer tick, asking Buildbucket for the build status
[13:32:43.797] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:43.797] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:146:0) after 1m0s
[13:33:43.988] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:146:0)
[13:33:43.988] Timer tick, asking Buildbucket for the build status
[13:33:44.069] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:44.069] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:147:0) after 1m0s
[13:34:44.252] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:147:0)
[13:34:44.252] Timer tick, asking Buildbucket for the build status
[13:34:44.353] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:44.353] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:148:0) after 1m0s
[13:35:44.450] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:148:0)
[13:35:44.450] Timer tick, asking Buildbucket for the build status
[13:35:44.535] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:44.535] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:149:0) after 1m0s
[13:36:44.667] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:149:0)
[13:36:44.667] Timer tick, asking Buildbucket for the build status
[13:36:44.749] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:44.749] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:150:0) after 1m0s
[13:37:44.810] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:150:0)
[13:37:44.810] Timer tick, asking Buildbucket for the build status
[13:37:44.881] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:44.881] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:151:0) after 1m0s
[13:38:45.017] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:151:0)
[13:38:45.017] Timer tick, asking Buildbucket for the build status
[13:38:45.082] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:45.082] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:152:0) after 1m0s
[13:39:45.157] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:152:0)
[13:39:45.157] Timer tick, asking Buildbucket for the build status
[13:39:45.324] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:45.324] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:153:0) after 1m0s
[13:40:45.433] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:153:0)
[13:40:45.433] Timer tick, asking Buildbucket for the build status
[13:40:45.515] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:45.515] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:154:0) after 1m0s
[13:41:45.762] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:154:0)
[13:41:45.762] Timer tick, asking Buildbucket for the build status
[13:41:45.842] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:45.842] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:155:0) after 1m0s
[13:42:45.959] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:155:0)
[13:42:45.959] Timer tick, asking Buildbucket for the build status
[13:42:46.291] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:46.292] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:156:0) after 1m0s
[13:43:46.464] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:156:0)
[13:43:46.464] Timer tick, asking Buildbucket for the build status
[13:43:46.542] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:46.542] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:157:0) after 1m0s
[13:44:46.717] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:157:0)
[13:44:46.717] Timer tick, asking Buildbucket for the build status
[13:44:46.862] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:46.862] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:158:0) after 1m0s
[13:45:47.032] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:158:0)
[13:45:47.032] Timer tick, asking Buildbucket for the build status
[13:45:47.110] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:47.110] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:159:0) after 1m0s
[13:46:47.379] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:159:0)
[13:46:47.379] Timer tick, asking Buildbucket for the build status
[13:46:47.515] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:47.515] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:160:0) after 1m0s
[13:47:47.594] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:160:0)
[13:47:47.594] Timer tick, asking Buildbucket for the build status
[13:47:47.688] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:47.688] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:161:0) after 1m0s
[13:48:47.864] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:161:0)
[13:48:47.864] Timer tick, asking Buildbucket for the build status
[13:48:47.938] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:47.938] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:162:0) after 1m0s
[13:49:48.014] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:162:0)
[13:49:48.014] Timer tick, asking Buildbucket for the build status
[13:49:48.181] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:48.181] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:163:0) after 1m0s
[13:50:48.322] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:163:0)
[13:50:48.322] Timer tick, asking Buildbucket for the build status
[13:50:48.390] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:48.390] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:164:0) after 1m0s
[13:51:48.527] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:164:0)
[13:51:48.527] Timer tick, asking Buildbucket for the build status
[13:51:48.828] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:48.828] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:165:0) after 1m0s
[13:52:48.949] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:165:0)
[13:52:48.949] Timer tick, asking Buildbucket for the build status
[13:52:49.240] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:49.240] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:166:0) after 1m0s
[13:53:49.215] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:166:0)
[13:53:49.215] Timer tick, asking Buildbucket for the build status
[13:53:49.411] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:49.411] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:167:0) after 1m0s
[13:54:49.435] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:167:0)
[13:54:49.435] Timer tick, asking Buildbucket for the build status
[13:54:49.550] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:49.550] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:168:0) after 1m0s
[13:55:49.618] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:168:0)
[13:55:49.618] Timer tick, asking Buildbucket for the build status
[13:55:49.795] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:49.796] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:169:0) after 1m0s
[13:56:49.858] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:169:0)
[13:56:49.858] Timer tick, asking Buildbucket for the build status
[13:56:49.927] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:49.927] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:170:0) after 1m0s
[13:57:50.037] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:170:0)
[13:57:50.037] Timer tick, asking Buildbucket for the build status
[13:57:50.114] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:50.114] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:171:0) after 1m0s
[13:58:50.262] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:171:0)
[13:58:50.262] Timer tick, asking Buildbucket for the build status
[13:58:50.327] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:50.327] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:172:0) after 1m0s
[13:59:50.491] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:172:0)
[13:59:50.491] Timer tick, asking Buildbucket for the build status
[13:59:50.868] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:50.868] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:173:0) after 1m0s
[14:00:50.940] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:173:0)
[14:00:50.940] Timer tick, asking Buildbucket for the build status
[14:00:51.014] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:51.014] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:174:0) after 1m0s
[14:01:51.202] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:174:0)
[14:01:51.202] Timer tick, asking Buildbucket for the build status
[14:01:51.530] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:51.530] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:175:0) after 1m0s
[14:02:51.674] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:175:0)
[14:02:51.674] Timer tick, asking Buildbucket for the build status
[14:02:51.750] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:51.750] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:176:0) after 1m0s
[14:03:52.041] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:176:0)
[14:03:52.041] Timer tick, asking Buildbucket for the build status
[14:03:52.125] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:52.125] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:177:0) after 1m0s
[14:04:52.160] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:177:0)
[14:04:52.160] Timer tick, asking Buildbucket for the build status
[14:04:52.248] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:52.248] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:178:0) after 1m0s
[14:05:52.311] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:178:0)
[14:05:52.311] Timer tick, asking Buildbucket for the build status
[14:05:52.390] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:52.390] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:179:0) after 1m0s
[14:06:52.529] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:179:0)
[14:06:52.529] Timer tick, asking Buildbucket for the build status
[14:06:52.640] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:52.640] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:180:0) after 1m0s
[14:07:52.838] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:180:0)
[14:07:52.838] Timer tick, asking Buildbucket for the build status
[14:07:53.212] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:53.212] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:181:0) after 1m0s
[14:08:53.508] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:181:0)
[14:08:53.508] Timer tick, asking Buildbucket for the build status
[14:08:53.582] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:53.582] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:182:0) after 1m0s
[14:09:53.710] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:182:0)
[14:09:53.710] Timer tick, asking Buildbucket for the build status
[14:09:53.886] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:53.886] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:183:0) after 1m0s
[14:10:53.916] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:183:0)
[14:10:53.916] Timer tick, asking Buildbucket for the build status
[14:10:53.996] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:53.996] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:184:0) after 1m0s
[14:11:54.123] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:184:0)
[14:11:54.123] Timer tick, asking Buildbucket for the build status
[14:11:54.330] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:54.330] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:185:0) after 1m0s
[14:12:54.534] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:185:0)
[14:12:54.534] Timer tick, asking Buildbucket for the build status
[14:12:54.720] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:54.720] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:186:0) after 1m0s
[14:13:54.746] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:186:0)
[14:13:54.746] Timer tick, asking Buildbucket for the build status
[14:13:54.833] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:54.833] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:187:0) after 1m0s
[14:14:54.984] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:187:0)
[14:14:54.984] Timer tick, asking Buildbucket for the build status
[14:14:55.117] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:55.117] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:188:0) after 1m0s
[14:15:55.216] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:188:0)
[14:15:55.216] Timer tick, asking Buildbucket for the build status
[14:15:55.292] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:55.292] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:189:0) after 1m0s
[14:16:55.317] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:189:0)
[14:16:55.317] Timer tick, asking Buildbucket for the build status
[14:16:55.390] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:55.390] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:190:0) after 1m0s
[14:17:55.620] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:190:0)
[14:17:55.620] Timer tick, asking Buildbucket for the build status
[14:17:55.724] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:55.724] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:191:0) after 1m0s
[14:18:55.798] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:191:0)
[14:18:55.798] Timer tick, asking Buildbucket for the build status
[14:18:55.932] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:55.932] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:192:0) after 1m0s
[14:19:56.061] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:192:0)
[14:19:56.061] Timer tick, asking Buildbucket for the build status
[14:19:56.156] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:56.156] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:193:0) after 1m0s
[14:20:56.179] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:193:0)
[14:20:56.179] Timer tick, asking Buildbucket for the build status
[14:20:56.322] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:56.322] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:194:0) after 1m0s
[14:21:56.363] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:194:0)
[14:21:56.363] Timer tick, asking Buildbucket for the build status
[14:21:56.607] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:56.607] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:195:0) after 1m0s
[14:22:56.659] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:195:0)
[14:22:56.659] Timer tick, asking Buildbucket for the build status
[14:22:56.755] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:56.755] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:196:0) after 1m0s
[14:23:56.828] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:196:0)
[14:23:56.828] Timer tick, asking Buildbucket for the build status
[14:23:56.897] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:56.897] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:197:0) after 1m0s
[14:24:56.971] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:197:0)
[14:24:56.971] Timer tick, asking Buildbucket for the build status
[14:24:57.418] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:57.418] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:198:0) after 1m0s
[14:25:57.594] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:198:0)
[14:25:57.594] Timer tick, asking Buildbucket for the build status
[14:25:57.740] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:57.740] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:199:0) after 1m0s
[14:26:57.800] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:199:0)
[14:26:57.800] Timer tick, asking Buildbucket for the build status
[14:26:57.870] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:57.870] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:200:0) after 1m0s
[14:27:57.929] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:200:0)
[14:27:57.929] Timer tick, asking Buildbucket for the build status
[14:27:58.022] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:58.022] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:201:0) after 1m0s
[14:28:58.116] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:201:0)
[14:28:58.116] Timer tick, asking Buildbucket for the build status
[14:28:58.226] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:58.226] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:202:0) after 1m0s
[14:29:58.252] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:202:0)
[14:29:58.252] Timer tick, asking Buildbucket for the build status
[14:29:58.357] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:58.357] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:203:0) after 1m0s
[14:30:58.383] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:203:0)
[14:30:58.383] Timer tick, asking Buildbucket for the build status
[14:30:58.455] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:58.455] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:204:0) after 1m0s
[14:31:58.549] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:204:0)
[14:31:58.549] Timer tick, asking Buildbucket for the build status
[14:31:58.648] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:58.648] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:205:0) after 1m0s
[14:32:58.629] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:205:0)
[14:32:58.629] Timer tick, asking Buildbucket for the build status
[14:32:58.742] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:58.742] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:206:0) after 1m0s
[14:33:58.813] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:206:0)
[14:33:58.813] Timer tick, asking Buildbucket for the build status
[14:33:58.883] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:58.883] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:207:0) after 1m0s
[14:34:59.005] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:207:0)
[14:34:59.005] Timer tick, asking Buildbucket for the build status
[14:34:59.093] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:59.093] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:208:0) after 1m0s
[14:35:59.126] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:208:0)
[14:35:59.126] Timer tick, asking Buildbucket for the build status
[14:35:59.214] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:59.214] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:209:0) after 1m0s
[14:36:59.414] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:209:0)
[14:36:59.414] Timer tick, asking Buildbucket for the build status
[14:36:59.529] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:59.529] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:210:0) after 1m0s
[14:37:59.631] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:210:0)
[14:37:59.631] Timer tick, asking Buildbucket for the build status
[14:37:59.821] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:59.821] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:211:0) after 1m0s
[14:38:59.942] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:211:0)
[14:38:59.942] Timer tick, asking Buildbucket for the build status
[14:39:00.195] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:00.195] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:212:0) after 1m0s
[14:40:00.259] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:212:0)
[14:40:00.259] Timer tick, asking Buildbucket for the build status
[14:40:00.681] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:00.681] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:213:0) after 1m0s
[14:41:00.840] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:213:0)
[14:41:00.840] Timer tick, asking Buildbucket for the build status
[14:41:00.921] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:00.921] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:214:0) after 1m0s
[14:42:01.619] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:214:0)
[14:42:01.619] Timer tick, asking Buildbucket for the build status
[14:42:01.794] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:01.794] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:215:0) after 1m0s
[14:43:01.815] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:215:0)
[14:43:01.815] Timer tick, asking Buildbucket for the build status
[14:43:02.114] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:02.114] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:216:0) after 1m0s
[14:44:02.156] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:216:0)
[14:44:02.156] Timer tick, asking Buildbucket for the build status
[14:44:02.459] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:02.459] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:217:0) after 1m0s
[14:45:02.485] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:217:0)
[14:45:02.485] Timer tick, asking Buildbucket for the build status
[14:45:02.625] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:02.625] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:218:0) after 1m0s
[14:46:02.655] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:218:0)
[14:46:02.655] Timer tick, asking Buildbucket for the build status
[14:46:02.744] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:02.744] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:219:0) after 1m0s
[14:47:02.768] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:219:0)
[14:47:02.768] Timer tick, asking Buildbucket for the build status
[14:47:02.879] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:02.879] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:220:0) after 1m0s
[14:48:03.022] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:220:0)
[14:48:03.022] Timer tick, asking Buildbucket for the build status
[14:48:03.102] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:03.102] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:221:0) after 1m0s
[14:49:03.222] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:221:0)
[14:49:03.222] Timer tick, asking Buildbucket for the build status
[14:49:03.601] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:03.601] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:222:0) after 1m0s
[14:50:03.625] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:222:0)
[14:50:03.625] Timer tick, asking Buildbucket for the build status
[14:50:03.940] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:03.940] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:223:0) after 1m0s
[14:51:04.012] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:223:0)
[14:51:04.012] Timer tick, asking Buildbucket for the build status
[14:51:04.076] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:04.076] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:224:0) after 1m0s
[14:52:04.305] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:224:0)
[14:52:04.305] Timer tick, asking Buildbucket for the build status
[14:52:04.380] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:04.381] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:225:0) after 1m0s
[14:53:04.538] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:225:0)
[14:53:04.538] Timer tick, asking Buildbucket for the build status
[14:53:04.624] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:04.624] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:226:0) after 1m0s
[14:54:05.248] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:226:0)
[14:54:05.248] Timer tick, asking Buildbucket for the build status
[14:54:05.339] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:05.339] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:227:0) after 1m0s
[14:55:05.433] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:227:0)
[14:55:05.433] Timer tick, asking Buildbucket for the build status
[14:55:05.526] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:05.526] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:228:0) after 1m0s
[14:56:05.550] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:228:0)
[14:56:05.550] Timer tick, asking Buildbucket for the build status
[14:56:05.812] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:05.812] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:229:0) after 1m0s
[14:57:05.873] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:229:0)
[14:57:05.873] Timer tick, asking Buildbucket for the build status
[14:57:06.131] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:06.131] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:230:0) after 1m0s
[14:58:06.145] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:230:0)
[14:58:06.145] Timer tick, asking Buildbucket for the build status
[14:58:06.231] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:06.231] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:231:0) after 1m0s
[14:59:06.324] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:231:0)
[14:59:06.324] Timer tick, asking Buildbucket for the build status
[14:59:06.504] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:06.504] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:232:0) after 1m0s
[15:00:06.652] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:232:0)
[15:00:06.652] Timer tick, asking Buildbucket for the build status
[15:00:06.936] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:06.936] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:233:0) after 1m0s
[15:01:08.913] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:233:0)
[15:01:08.914] Timer tick, asking Buildbucket for the build status
[15:01:09.157] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:09.157] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:234:0) after 1m0s
[15:02:09.349] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:234:0)
[15:02:09.349] Timer tick, asking Buildbucket for the build status
[15:02:09.429] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:09.429] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:235:0) after 1m0s
[15:03:09.515] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:235:0)
[15:03:09.515] Timer tick, asking Buildbucket for the build status
[15:03:09.701] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:09.701] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:236:0) after 1m0s
[15:04:09.786] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:236:0)
[15:04:09.786] Timer tick, asking Buildbucket for the build status
[15:04:10.008] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:10.008] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:237:0) after 1m0s
[15:05:10.034] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:237:0)
[15:05:10.034] Timer tick, asking Buildbucket for the build status
[15:05:10.131] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:10.131] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:238:0) after 1m0s
[15:06:10.153] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:238:0)
[15:06:10.153] Timer tick, asking Buildbucket for the build status
[15:06:10.226] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:10.226] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:239:0) after 1m0s
[15:07:10.252] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:239:0)
[15:07:10.252] Timer tick, asking Buildbucket for the build status
[15:07:10.443] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:10.443] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:240:0) after 1m0s
[15:08:10.470] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:240:0)
[15:08:10.470] Timer tick, asking Buildbucket for the build status
[15:08:10.554] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:10.554] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:241:0) after 1m0s
[15:09:10.589] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:241:0)
[15:09:10.589] Timer tick, asking Buildbucket for the build status
[15:09:10.671] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:10.671] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:242:0) after 1m0s
[15:10:10.701] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:242:0)
[15:10:10.701] Timer tick, asking Buildbucket for the build status
[15:10:10.812] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:10.812] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:243:0) after 1m0s
[15:11:10.837] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:243:0)
[15:11:10.837] Timer tick, asking Buildbucket for the build status
[15:11:10.993] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:10.993] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:244:0) after 1m0s
[15:12:11.076] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:244:0)
[15:12:11.077] Timer tick, asking Buildbucket for the build status
[15:12:11.151] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:11.151] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:245:0) after 1m0s
[15:13:11.234] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:245:0)
[15:13:11.234] Timer tick, asking Buildbucket for the build status
[15:13:11.408] Build 8854690885936282624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:11.408] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020120948214034064:246:0) after 1m0s
[15:13:17.797] Received PubSub notification, asking Buildbucket for the build status
[15:13:17.884] Build 8854690885936282624: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:13:17.884] Buildbucket build:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "completed_ts": "1613920397019811",
    "created_by": "project:chromium",
    "created_ts": "1613905744574619",
    "id": "8854690885936282624",
    "parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"22f65038fa8c2d2cd9143435b89ac5f200c33bb2\"}}",
    "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\": \"22f65038fa8c2d2cd9143435b89ac5f200c33bb2\", \"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-wqii\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 1636, \"got_angle_revision\": \"6e8cdd39b19912e7fe6408b0318d0907dc7e4d21\", \"got_dawn_revision\": \"1258e245a978083cab0b707c84dea814eadb3fbb\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"22f65038fa8c2d2cd9143435b89ac5f200c33bb2\", \"got_revision_cp\": \"refs/heads/master@{#856142}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"d85a7a27b27269741a779a72f33436b83d98687c\", \"got_v8_revision\": \"2430d8fffa7d4f8a0992bcb5eb3725e5367cd9ac\", \"got_v8_revision_cp\": \"refs/heads/9.0.229@{#1}\", \"got_webrtc_revision\": \"753c76a705199ea752933f3688a8e4c8233dca53\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33298}\", \"mirrored_builders\": [\"tryserver.chromium:win-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"22f65038fa8c2d2cd9143435b89ac5f200c33bb2\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_9b3ebe5fd1c5be87380c40d216747346a59b28cf26de183f0e8e2b32e944d3c8_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-9-wqii\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5706-397711c\"], \"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": "1613905853022917",
    "status": "COMPLETED",
    "status_changed_ts": "1613920397387243",
    "tags": [
      "build_address:luci.chromium.ci/win-official/1636",
      "builder:win-official",
      "buildset:commit/git/22f65038fa8c2d2cd9143435b89ac5f200c33bb2",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/22f65038fa8c2d2cd9143435b89ac5f200c33bb2",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9020120948214034064",
      "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/8854690885936282624/+/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:51dd18dd42e0b910",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1613920397391948",
    "url": "https://ci.chromium.org/b/8854690885936282624",
    "utcnow_ts": "1613920397877740"
  }
}
[15:13:17.884] Invocation finished in 4h4m14.865685775s with status SUCCEEDED