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

• b8475bc1cc62261694c2ed4627cd1dcbf4c4cd68 (5 years ago)
• 36e81fd75028adf6cd4c6f240a4511ae505e9328 (5 years ago)
• 07db065225ca4b10f107b6a337c07a7680f1efd0 (5 years ago)
• 399a03265b79f3dcebc3570508a9eb51c1549ed1 (5 years ago)
• 96ed58631d221505952070be6896f57cf1bb1f83 (5 years ago)
• ec1eb02791a8db2386301b4bfe65dad50ddd9781 (5 years ago)
• ab4e2a8d0ee5a5c8faeb9ccbece93231c149d1b0 (5 years ago)
• 3a2727246fde02600292613dc503d256dc7968f0 (5 years ago)
• 9833a0dc7683feb977ad686647c710d0487f625c (5 years ago)
• 1912d30965c305a88844f11f7e2559d5ce7e52e5 (5 years ago)
• 7d7e87edfa3a7ebb82d31a278b7faf69a51e7ad7 (5 years ago)
• 29c2a8095a500afa8d35b8d528e06ce4912c5a2a (5 years ago)
• 098e477af2b812515458393e03d549d3e178422d (5 years ago)

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

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

[23:39:45.066] New invocation is queued and will start shortly
[23:39:46.308] Starting the invocation (attempt 1)
[23:39:46.342] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:39:46.342] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:39:46.342] Buildbucket request:
{
  "bucket": "luci.chromium.ci",
  "client_operation_id": "9021976254515713376",
  "parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"098e477af2b812515458393e03d549d3e178422d\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:win-official",
    "scheduler_invocation_id:9021976254515713376",
    "scheduler_job_id:chromium/win-official",
    "user_agent:luci-scheduler",
    "buildset:commit/git/098e477af2b812515458393e03d549d3e178422d",
    "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/098e477af2b812515458393e03d549d3e178422d",
    "gitiles_ref:refs/heads/master"
  ]
}
[23:39:47.377] Buildbucket response:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "created_by": "project:chromium",
    "created_ts": "1612136386423055",
    "id": "8856546192428339392",
    "parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"098e477af2b812515458393e03d549d3e178422d\"}}",
    "project": "chromium",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1612136387189817",
    "tags": [
      "build_address:luci.chromium.ci/win-official/1507",
      "builder:win-official",
      "buildset:commit/git/098e477af2b812515458393e03d549d3e178422d",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/098e477af2b812515458393e03d549d3e178422d",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9021976254515713376",
      "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/8856546192428339392/+/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": "1612136387189975",
    "url": "https://ci.chromium.org/b/8856546192428339392",
    "utcnow_ts": "1612136387368672"
  }
}
[23:39:47.377] Task URL: https://ci.chromium.org/b/8856546192428339392
[23:39:47.377] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:2:0) after 1m0s
[23:40:32.209] Received PubSub notification, asking Buildbucket for the build status
[23:40:32.282] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:47.444] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:2:0)
[23:40:47.444] Timer tick, asking Buildbucket for the build status
[23:40:47.514] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:47.514] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:4:0) after 1m0s
[23:41:47.595] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:4:0)
[23:41:47.595] Timer tick, asking Buildbucket for the build status
[23:41:47.663] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:47.663] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:5:0) after 1m0s
[23:42:47.679] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:5:0)
[23:42:47.679] Timer tick, asking Buildbucket for the build status
[23:42:47.752] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:47.752] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:6:0) after 1m0s
[23:43:47.773] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:6:0)
[23:43:47.773] Timer tick, asking Buildbucket for the build status
[23:43:47.862] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:47.862] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:7:0) after 1m0s
[23:44:47.878] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:7:0)
[23:44:47.878] Timer tick, asking Buildbucket for the build status
[23:44:47.955] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:47.955] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:8:0) after 1m0s
[23:45:47.965] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:8:0)
[23:45:47.965] Timer tick, asking Buildbucket for the build status
[23:45:48.052] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:48.052] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:9:0) after 1m0s
[23:46:48.454] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:9:0)
[23:46:48.454] Timer tick, asking Buildbucket for the build status
[23:46:48.541] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:48.541] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:10:0) after 1m0s
[23:47:48.602] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:10:0)
[23:47:48.602] Timer tick, asking Buildbucket for the build status
[23:47:48.709] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:48.709] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:11:0) after 1m0s
[23:48:48.885] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:11:0)
[23:48:48.885] Timer tick, asking Buildbucket for the build status
[23:48:48.955] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:48.955] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:12:0) after 1m0s
[23:49:48.973] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:12:0)
[23:49:48.973] Timer tick, asking Buildbucket for the build status
[23:49:49.226] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:49.226] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:13:0) after 1m0s
[23:50:49.245] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:13:0)
[23:50:49.245] Timer tick, asking Buildbucket for the build status
[23:50:49.742] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:49.742] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:14:0) after 1m0s
[23:51:49.768] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:14:0)
[23:51:49.768] Timer tick, asking Buildbucket for the build status
[23:51:49.839] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:49.839] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:15:0) after 1m0s
[23:52:49.890] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:15:0)
[23:52:49.890] Timer tick, asking Buildbucket for the build status
[23:52:49.979] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:49.979] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:16:0) after 1m0s
[23:53:50.088] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:16:0)
[23:53:50.088] Timer tick, asking Buildbucket for the build status
[23:53:50.144] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:50.144] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:17:0) after 1m0s
[23:54:50.218] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:17:0)
[23:54:50.218] Timer tick, asking Buildbucket for the build status
[23:54:50.622] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:50.622] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:18:0) after 1m0s
[23:55:50.643] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:18:0)
[23:55:50.643] Timer tick, asking Buildbucket for the build status
[23:55:50.698] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:50.698] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:19:0) after 1m0s
[23:56:50.857] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:19:0)
[23:56:50.857] Timer tick, asking Buildbucket for the build status
[23:56:50.918] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:50.918] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:20:0) after 1m0s
[23:57:51.280] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:20:0)
[23:57:51.280] Timer tick, asking Buildbucket for the build status
[23:57:51.345] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:51.345] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:21:0) after 1m0s
[23:58:51.632] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:21:0)
[23:58:51.632] Timer tick, asking Buildbucket for the build status
[23:58:51.807] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:51.807] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:22:0) after 1m0s
[23:59:51.957] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:22:0)
[23:59:51.957] Timer tick, asking Buildbucket for the build status
[23:59:52.045] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:52.045] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:23:0) after 1m0s
[00:00:52.386] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:23:0)
[00:00:52.386] Timer tick, asking Buildbucket for the build status
[00:00:52.994] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:52.994] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:24:0) after 1m0s
[00:01:53.236] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:24:0)
[00:01:53.236] Timer tick, asking Buildbucket for the build status
[00:01:53.388] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:53.388] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:25:0) after 1m0s
[00:02:53.566] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:25:0)
[00:02:53.566] Timer tick, asking Buildbucket for the build status
[00:02:53.688] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:53.688] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:26:0) after 1m0s
[00:03:53.760] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:26:0)
[00:03:53.760] Timer tick, asking Buildbucket for the build status
[00:03:54.052] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:54.052] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:27:0) after 1m0s
[00:04:54.127] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:27:0)
[00:04:54.127] Timer tick, asking Buildbucket for the build status
[00:04:54.277] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:54.277] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:28:0) after 1m0s
[00:05:54.484] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:28:0)
[00:05:54.484] Timer tick, asking Buildbucket for the build status
[00:05:54.560] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:54.561] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:29:0) after 1m0s
[00:06:54.604] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:29:0)
[00:06:54.604] Timer tick, asking Buildbucket for the build status
[00:06:54.887] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:54.887] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:30:0) after 1m0s
[00:07:54.939] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:30:0)
[00:07:54.939] Timer tick, asking Buildbucket for the build status
[00:07:55.004] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:55.004] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:31:0) after 1m0s
[00:08:55.112] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:31:0)
[00:08:55.112] Timer tick, asking Buildbucket for the build status
[00:08:55.169] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:55.169] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:32:0) after 1m0s
[00:09:55.200] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:32:0)
[00:09:55.200] Timer tick, asking Buildbucket for the build status
[00:09:55.321] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:55.321] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:33:0) after 1m0s
[00:10:55.375] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:33:0)
[00:10:55.375] Timer tick, asking Buildbucket for the build status
[00:10:55.523] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:55.523] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:34:0) after 1m0s
[00:11:55.546] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:34:0)
[00:11:55.546] Timer tick, asking Buildbucket for the build status
[00:11:55.647] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:55.647] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:35:0) after 1m0s
[00:12:55.698] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:35:0)
[00:12:55.698] Timer tick, asking Buildbucket for the build status
[00:12:55.762] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:55.762] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:36:0) after 1m0s
[00:13:55.809] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:36:0)
[00:13:55.809] Timer tick, asking Buildbucket for the build status
[00:13:56.027] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:56.027] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:37:0) after 1m0s
[00:14:56.075] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:37:0)
[00:14:56.075] Timer tick, asking Buildbucket for the build status
[00:14:56.221] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:56.221] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:38:0) after 1m0s
[00:15:56.249] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:38:0)
[00:15:56.249] Timer tick, asking Buildbucket for the build status
[00:15:56.393] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:56.393] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:39:0) after 1m0s
[00:16:56.591] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:39:0)
[00:16:56.591] Timer tick, asking Buildbucket for the build status
[00:16:57.200] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:57.200] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:40:0) after 1m0s
[00:17:57.197] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:40:0)
[00:17:57.197] Timer tick, asking Buildbucket for the build status
[00:17:57.337] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:57.337] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:41:0) after 1m0s
[00:18:57.400] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:41:0)
[00:18:57.400] Timer tick, asking Buildbucket for the build status
[00:18:57.464] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:57.464] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:42:0) after 1m0s
[00:19:57.519] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:42:0)
[00:19:57.519] Timer tick, asking Buildbucket for the build status
[00:19:57.823] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:57.823] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:43:0) after 1m0s
[00:20:57.811] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:43:0)
[00:20:57.811] Timer tick, asking Buildbucket for the build status
[00:20:58.019] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:58.019] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:44:0) after 1m0s
[00:21:58.054] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:44:0)
[00:21:58.054] Timer tick, asking Buildbucket for the build status
[00:21:58.135] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:58.135] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:45:0) after 1m0s
[00:22:58.228] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:45:0)
[00:22:58.228] Timer tick, asking Buildbucket for the build status
[00:22:58.282] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:58.282] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:46:0) after 1m0s
[00:23:58.371] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:46:0)
[00:23:58.371] Timer tick, asking Buildbucket for the build status
[00:23:58.522] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:58.522] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:47:0) after 1m0s
[00:24:58.599] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:47:0)
[00:24:58.599] Timer tick, asking Buildbucket for the build status
[00:24:59.311] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:59.311] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:48:0) after 1m0s
[00:25:59.378] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:48:0)
[00:25:59.378] Timer tick, asking Buildbucket for the build status
[00:25:59.512] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:59.512] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:49:0) after 1m0s
[00:26:59.565] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:49:0)
[00:26:59.565] Timer tick, asking Buildbucket for the build status
[00:26:59.799] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:59.799] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:50:0) after 1m0s
[00:27:59.816] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:50:0)
[00:27:59.816] Timer tick, asking Buildbucket for the build status
[00:28:00.209] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:00.209] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:51:0) after 1m0s
[00:29:00.264] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:51:0)
[00:29:00.264] Timer tick, asking Buildbucket for the build status
[00:29:00.324] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:00.324] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:52:0) after 1m0s
[00:30:00.375] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:52:0)
[00:30:00.375] Timer tick, asking Buildbucket for the build status
[00:30:00.472] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:00.472] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:53:0) after 1m0s
[00:31:00.495] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:53:0)
[00:31:00.495] Timer tick, asking Buildbucket for the build status
[00:31:00.547] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:00.547] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:54:0) after 1m0s
[00:32:00.577] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:54:0)
[00:32:00.578] Timer tick, asking Buildbucket for the build status
[00:32:00.664] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:00.664] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:55:0) after 1m0s
[00:33:01.081] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:55:0)
[00:33:01.081] Timer tick, asking Buildbucket for the build status
[00:33:01.181] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:01.181] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:56:0) after 1m0s
[00:34:01.466] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:56:0)
[00:34:01.466] Timer tick, asking Buildbucket for the build status
[00:34:01.544] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:01.544] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:57:0) after 1m0s
[00:35:01.569] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:57:0)
[00:35:01.569] Timer tick, asking Buildbucket for the build status
[00:35:01.893] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:01.893] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:58:0) after 1m0s
[00:36:01.915] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:58:0)
[00:36:01.915] Timer tick, asking Buildbucket for the build status
[00:36:01.992] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:01.992] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:59:0) after 1m0s
[00:37:02.015] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:59:0)
[00:37:02.015] Timer tick, asking Buildbucket for the build status
[00:37:02.066] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:02.066] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:60:0) after 1m0s
[00:38:02.084] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:60:0)
[00:38:02.084] Timer tick, asking Buildbucket for the build status
[00:38:02.217] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:02.217] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:61:0) after 1m0s
[00:39:02.246] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:61:0)
[00:39:02.246] Timer tick, asking Buildbucket for the build status
[00:39:02.435] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:02.435] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:62:0) after 1m0s
[00:40:02.477] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:62:0)
[00:40:02.477] Timer tick, asking Buildbucket for the build status
[00:40:02.602] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:02.602] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:63:0) after 1m0s
[00:41:02.652] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:63:0)
[00:41:02.652] Timer tick, asking Buildbucket for the build status
[00:41:02.715] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:02.715] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:64:0) after 1m0s
[00:42:02.758] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:64:0)
[00:42:02.758] Timer tick, asking Buildbucket for the build status
[00:42:02.832] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:02.832] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:65:0) after 1m0s
[00:43:02.901] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:65:0)
[00:43:02.901] Timer tick, asking Buildbucket for the build status
[00:43:03.107] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:03.107] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:66:0) after 1m0s
[00:44:03.175] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:66:0)
[00:44:03.175] Timer tick, asking Buildbucket for the build status
[00:44:03.312] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:03.312] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:67:0) after 1m0s
[00:45:03.348] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:67:0)
[00:45:03.348] Timer tick, asking Buildbucket for the build status
[00:45:03.434] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:03.434] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:68:0) after 1m0s
[00:46:03.588] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:68:0)
[00:46:03.588] Timer tick, asking Buildbucket for the build status
[00:46:03.797] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:03.797] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:69:0) after 1m0s
[00:47:03.845] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:69:0)
[00:47:03.845] Timer tick, asking Buildbucket for the build status
[00:47:04.058] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:04.058] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:70:0) after 1m0s
[00:48:04.076] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:70:0)
[00:48:04.076] Timer tick, asking Buildbucket for the build status
[00:48:04.150] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:04.150] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:71:0) after 1m0s
[00:49:04.195] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:71:0)
[00:49:04.195] Timer tick, asking Buildbucket for the build status
[00:49:04.257] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:04.257] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:72:0) after 1m0s
[00:50:04.336] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:72:0)
[00:50:04.336] Timer tick, asking Buildbucket for the build status
[00:50:04.432] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:04.432] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:73:0) after 1m0s
[00:51:04.577] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:73:0)
[00:51:04.577] Timer tick, asking Buildbucket for the build status
[00:51:04.640] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:04.640] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:74:0) after 1m0s
[00:52:04.670] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:74:0)
[00:52:04.670] Timer tick, asking Buildbucket for the build status
[00:52:04.728] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:04.728] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:75:0) after 1m0s
[00:53:04.847] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:75:0)
[00:53:04.847] Timer tick, asking Buildbucket for the build status
[00:53:04.907] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:04.907] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:76:0) after 1m0s
[00:54:04.933] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:76:0)
[00:54:04.933] Timer tick, asking Buildbucket for the build status
[00:54:04.997] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:04.997] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:77:0) after 1m0s
[00:55:05.099] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:77:0)
[00:55:05.099] Timer tick, asking Buildbucket for the build status
[00:55:05.400] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:05.400] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:78:0) after 1m0s
[00:56:05.456] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:78:0)
[00:56:05.456] Timer tick, asking Buildbucket for the build status
[00:56:05.755] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:05.755] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:79:0) after 1m0s
[00:57:05.732] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:79:0)
[00:57:05.732] Timer tick, asking Buildbucket for the build status
[00:57:05.802] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:05.802] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:80:0) after 1m0s
[00:58:05.850] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:80:0)
[00:58:05.850] Timer tick, asking Buildbucket for the build status
[00:58:05.917] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:05.917] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:81:0) after 1m0s
[00:59:06.021] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:81:0)
[00:59:06.021] Timer tick, asking Buildbucket for the build status
[00:59:06.082] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:06.082] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:82:0) after 1m0s
[01:00:06.172] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:82:0)
[01:00:06.172] Timer tick, asking Buildbucket for the build status
[01:00:06.471] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:06.471] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:83:0) after 1m0s
[01:01:07.018] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:83:0)
[01:01:07.018] Timer tick, asking Buildbucket for the build status
[01:01:07.214] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:07.214] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:84:0) after 1m0s
[01:02:07.420] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:84:0)
[01:02:07.420] Timer tick, asking Buildbucket for the build status
[01:02:07.490] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:07.490] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:85:0) after 1m0s
[01:03:07.606] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:85:0)
[01:03:07.607] Timer tick, asking Buildbucket for the build status
[01:03:07.679] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:07.679] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:86:0) after 1m0s
[01:04:07.700] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:86:0)
[01:04:07.700] Timer tick, asking Buildbucket for the build status
[01:04:07.774] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:07.774] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:87:0) after 1m0s
[01:05:07.900] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:87:0)
[01:05:07.900] Timer tick, asking Buildbucket for the build status
[01:05:08.032] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:08.032] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:88:0) after 1m0s
[01:06:08.070] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:88:0)
[01:06:08.070] Timer tick, asking Buildbucket for the build status
[01:06:08.140] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:08.140] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:89:0) after 1m0s
[01:07:08.205] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:89:0)
[01:07:08.205] Timer tick, asking Buildbucket for the build status
[01:07:08.273] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:08.273] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:90:0) after 1m0s
[01:08:08.329] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:90:0)
[01:08:08.329] Timer tick, asking Buildbucket for the build status
[01:08:08.588] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:08.588] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:91:0) after 1m0s
[01:09:08.609] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:91:0)
[01:09:08.609] Timer tick, asking Buildbucket for the build status
[01:09:08.668] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:08.668] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:92:0) after 1m0s
[01:10:08.778] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:92:0)
[01:10:08.778] Timer tick, asking Buildbucket for the build status
[01:10:08.901] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:08.901] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:93:0) after 1m0s
[01:11:08.936] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:93:0)
[01:11:08.936] Timer tick, asking Buildbucket for the build status
[01:11:09.025] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:09.025] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:94:0) after 1m0s
[01:12:09.056] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:94:0)
[01:12:09.056] Timer tick, asking Buildbucket for the build status
[01:12:09.134] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:09.134] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:95:0) after 1m0s
[01:13:09.131] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:95:0)
[01:13:09.131] Timer tick, asking Buildbucket for the build status
[01:13:09.206] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:09.206] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:96:0) after 1m0s
[01:14:09.283] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:96:0)
[01:14:09.286] Timer tick, asking Buildbucket for the build status
[01:14:09.350] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:09.350] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:97:0) after 1m0s
[01:15:09.396] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:97:0)
[01:15:09.396] Timer tick, asking Buildbucket for the build status
[01:15:09.515] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:09.515] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:98:0) after 1m0s
[01:16:09.600] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:98:0)
[01:16:09.600] Timer tick, asking Buildbucket for the build status
[01:16:09.675] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:09.675] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:99:0) after 1m0s
[01:17:09.752] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:99:0)
[01:17:09.752] Timer tick, asking Buildbucket for the build status
[01:17:09.836] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:09.836] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:100:0) after 1m0s
[01:18:10.109] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:100:0)
[01:18:10.109] Timer tick, asking Buildbucket for the build status
[01:18:10.235] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:10.235] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:101:0) after 1m0s
[01:19:14.534] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:101:0)
[01:19:14.534] Timer tick, asking Buildbucket for the build status
[01:19:14.938] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:14.938] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:102:0) after 1m0s
[01:20:14.986] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:102:0)
[01:20:14.986] Timer tick, asking Buildbucket for the build status
[01:20:15.242] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:15.242] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:103:0) after 1m0s
[01:21:15.298] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:103:0)
[01:21:15.298] Timer tick, asking Buildbucket for the build status
[01:21:15.379] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:15.379] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:104:0) after 1m0s
[01:22:15.405] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:104:0)
[01:22:15.405] Timer tick, asking Buildbucket for the build status
[01:22:15.469] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:15.469] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:105:0) after 1m0s
[01:23:15.598] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:105:0)
[01:23:15.598] Timer tick, asking Buildbucket for the build status
[01:23:15.660] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:15.660] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:106:0) after 1m0s
[01:24:15.709] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:106:0)
[01:24:15.709] Timer tick, asking Buildbucket for the build status
[01:24:15.915] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:15.915] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:107:0) after 1m0s
[01:25:15.955] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:107:0)
[01:25:15.955] Timer tick, asking Buildbucket for the build status
[01:25:16.069] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:16.069] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:108:0) after 1m0s
[01:26:16.109] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:108:0)
[01:26:16.109] Timer tick, asking Buildbucket for the build status
[01:26:16.171] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:16.171] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:109:0) after 1m0s
[01:27:16.253] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:109:0)
[01:27:16.254] Timer tick, asking Buildbucket for the build status
[01:27:16.308] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:16.308] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:110:0) after 1m0s
[01:28:16.430] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:110:0)
[01:28:16.430] Timer tick, asking Buildbucket for the build status
[01:28:16.601] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:16.601] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:111:0) after 1m0s
[01:29:16.645] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:111:0)
[01:29:16.645] Timer tick, asking Buildbucket for the build status
[01:29:16.705] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:16.705] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:112:0) after 1m0s
[01:30:16.733] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:112:0)
[01:30:16.733] Timer tick, asking Buildbucket for the build status
[01:30:16.929] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:16.929] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:113:0) after 1m0s
[01:31:16.988] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:113:0)
[01:31:16.988] Timer tick, asking Buildbucket for the build status
[01:31:17.200] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:17.201] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:114:0) after 1m0s
[01:32:17.254] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:114:0)
[01:32:17.254] Timer tick, asking Buildbucket for the build status
[01:32:17.310] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:17.310] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:115:0) after 1m0s
[01:33:17.450] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:115:0)
[01:33:17.450] Timer tick, asking Buildbucket for the build status
[01:33:17.841] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:17.841] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:116:0) after 1m0s
[01:34:17.903] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:116:0)
[01:34:17.903] Timer tick, asking Buildbucket for the build status
[01:34:17.970] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:17.970] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:117:0) after 1m0s
[01:35:17.968] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:117:0)
[01:35:17.968] Timer tick, asking Buildbucket for the build status
[01:35:18.063] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:18.063] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:118:0) after 1m0s
[01:36:18.117] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:118:0)
[01:36:18.117] Timer tick, asking Buildbucket for the build status
[01:36:18.277] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:18.277] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:119:0) after 1m0s
[01:37:18.401] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:119:0)
[01:37:18.401] Timer tick, asking Buildbucket for the build status
[01:37:18.593] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:18.593] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:120:0) after 1m0s
[01:38:18.701] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:120:0)
[01:38:18.701] Timer tick, asking Buildbucket for the build status
[01:38:18.770] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:18.770] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:121:0) after 1m0s
[01:39:18.853] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:121:0)
[01:39:18.853] Timer tick, asking Buildbucket for the build status
[01:39:19.028] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:19.028] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:122:0) after 1m0s
[01:40:19.066] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:122:0)
[01:40:19.066] Timer tick, asking Buildbucket for the build status
[01:40:19.199] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:19.199] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:123:0) after 1m0s
[01:41:19.278] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:123:0)
[01:41:19.278] Timer tick, asking Buildbucket for the build status
[01:41:19.360] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:19.360] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:124:0) after 1m0s
[01:42:19.463] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:124:0)
[01:42:19.463] Timer tick, asking Buildbucket for the build status
[01:42:19.647] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:19.647] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:125:0) after 1m0s
[01:43:19.704] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:125:0)
[01:43:19.704] Timer tick, asking Buildbucket for the build status
[01:43:19.757] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:19.758] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:126:0) after 1m0s
[01:44:19.842] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:126:0)
[01:44:19.842] Timer tick, asking Buildbucket for the build status
[01:44:20.012] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:20.012] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:127:0) after 1m0s
[01:45:20.056] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:127:0)
[01:45:20.056] Timer tick, asking Buildbucket for the build status
[01:45:20.298] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:20.298] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:128:0) after 1m0s
[01:46:20.323] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:128:0)
[01:46:20.323] Timer tick, asking Buildbucket for the build status
[01:46:20.381] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:20.381] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:129:0) after 1m0s
[01:47:20.419] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:129:0)
[01:47:20.419] Timer tick, asking Buildbucket for the build status
[01:47:20.476] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:20.476] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:130:0) after 1m0s
[01:48:20.501] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:130:0)
[01:48:20.501] Timer tick, asking Buildbucket for the build status
[01:48:22.116] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:22.116] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:131:0) after 1m0s
[01:49:22.131] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:131:0)
[01:49:22.131] Timer tick, asking Buildbucket for the build status
[01:49:23.106] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:23.106] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:132:0) after 1m0s
[01:50:23.137] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:132:0)
[01:50:23.137] Timer tick, asking Buildbucket for the build status
[01:50:23.351] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:23.351] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:133:0) after 1m0s
[01:51:23.384] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:133:0)
[01:51:23.384] Timer tick, asking Buildbucket for the build status
[01:51:23.600] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:23.600] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:134:0) after 1m0s
[01:52:23.636] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:134:0)
[01:52:23.636] Timer tick, asking Buildbucket for the build status
[01:52:23.722] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:23.722] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:135:0) after 1m0s
[01:53:23.782] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:135:0)
[01:53:23.782] Timer tick, asking Buildbucket for the build status
[01:53:23.851] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:23.851] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:136:0) after 1m0s
[01:54:23.889] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:136:0)
[01:54:23.889] Timer tick, asking Buildbucket for the build status
[01:54:23.947] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:23.947] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:137:0) after 1m0s
[01:55:23.973] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:137:0)
[01:55:23.973] Timer tick, asking Buildbucket for the build status
[01:55:24.068] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:24.068] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:138:0) after 1m0s
[01:56:24.096] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:138:0)
[01:56:24.096] Timer tick, asking Buildbucket for the build status
[01:56:24.260] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:24.260] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:139:0) after 1m0s
[01:57:24.321] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:139:0)
[01:57:24.321] Timer tick, asking Buildbucket for the build status
[01:57:24.387] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:24.387] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:140:0) after 1m0s
[01:58:24.439] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:140:0)
[01:58:24.439] Timer tick, asking Buildbucket for the build status
[01:58:24.496] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:24.496] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:141:0) after 1m0s
[01:59:24.582] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:141:0)
[01:59:24.582] Timer tick, asking Buildbucket for the build status
[01:59:24.640] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:24.640] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:142:0) after 1m0s
[02:00:24.724] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:142:0)
[02:00:24.724] Timer tick, asking Buildbucket for the build status
[02:00:24.813] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:24.813] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:143:0) after 1m0s
[02:01:24.928] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:143:0)
[02:01:24.928] Timer tick, asking Buildbucket for the build status
[02:01:24.984] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:24.984] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:144:0) after 1m0s
[02:02:24.976] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:144:0)
[02:02:24.976] Timer tick, asking Buildbucket for the build status
[02:02:25.043] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:25.043] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:145:0) after 1m0s
[02:03:25.087] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:145:0)
[02:03:25.087] Timer tick, asking Buildbucket for the build status
[02:03:25.164] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:25.164] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:146:0) after 1m0s
[02:04:25.236] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:146:0)
[02:04:25.236] Timer tick, asking Buildbucket for the build status
[02:04:25.400] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:25.400] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:147:0) after 1m0s
[02:05:25.490] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:147:0)
[02:05:25.490] Timer tick, asking Buildbucket for the build status
[02:05:25.593] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:25.593] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:148:0) after 1m0s
[02:06:25.612] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:148:0)
[02:06:25.612] Timer tick, asking Buildbucket for the build status
[02:06:25.669] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:25.669] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:149:0) after 1m0s
[02:07:25.755] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:149:0)
[02:07:25.755] Timer tick, asking Buildbucket for the build status
[02:07:25.842] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:25.842] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:150:0) after 1m0s
[02:08:25.838] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:150:0)
[02:08:25.838] Timer tick, asking Buildbucket for the build status
[02:08:25.912] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:25.912] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:151:0) after 1m0s
[02:09:25.972] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:151:0)
[02:09:25.972] Timer tick, asking Buildbucket for the build status
[02:09:26.432] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:26.432] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:152:0) after 1m0s
[02:10:26.469] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:152:0)
[02:10:26.469] Timer tick, asking Buildbucket for the build status
[02:10:27.261] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:27.261] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:153:0) after 1m0s
[02:11:27.266] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:153:0)
[02:11:27.266] Timer tick, asking Buildbucket for the build status
[02:11:28.312] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:28.312] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:154:0) after 1m0s
[02:12:28.367] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:154:0)
[02:12:28.367] Timer tick, asking Buildbucket for the build status
[02:12:28.627] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:28.627] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:155:0) after 1m0s
[02:13:28.648] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:155:0)
[02:13:28.648] Timer tick, asking Buildbucket for the build status
[02:13:28.704] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:28.704] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:156:0) after 1m0s
[02:14:28.719] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:156:0)
[02:14:28.719] Timer tick, asking Buildbucket for the build status
[02:14:28.774] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:28.774] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:157:0) after 1m0s
[02:15:28.834] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:157:0)
[02:15:28.834] Timer tick, asking Buildbucket for the build status
[02:15:28.963] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:28.963] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:158:0) after 1m0s
[02:16:29.112] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:158:0)
[02:16:29.112] Timer tick, asking Buildbucket for the build status
[02:16:29.192] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:29.192] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:159:0) after 1m0s
[02:17:29.224] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:159:0)
[02:17:29.224] Timer tick, asking Buildbucket for the build status
[02:17:29.311] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:29.311] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:160:0) after 1m0s
[02:18:29.362] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:160:0)
[02:18:29.362] Timer tick, asking Buildbucket for the build status
[02:18:29.635] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:29.635] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:161:0) after 1m0s
[02:19:29.666] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:161:0)
[02:19:29.666] Timer tick, asking Buildbucket for the build status
[02:19:29.908] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:29.908] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:162:0) after 1m0s
[02:20:29.958] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:162:0)
[02:20:29.958] Timer tick, asking Buildbucket for the build status
[02:20:30.085] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:30.085] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:163:0) after 1m0s
[02:21:30.116] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:163:0)
[02:21:30.116] Timer tick, asking Buildbucket for the build status
[02:21:30.182] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:30.182] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:164:0) after 1m0s
[02:22:30.260] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:164:0)
[02:22:30.260] Timer tick, asking Buildbucket for the build status
[02:22:30.376] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:30.376] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:165:0) after 1m0s
[02:23:30.397] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:165:0)
[02:23:30.397] Timer tick, asking Buildbucket for the build status
[02:23:30.458] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:30.458] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:166:0) after 1m0s
[02:24:30.513] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:166:0)
[02:24:30.514] Timer tick, asking Buildbucket for the build status
[02:24:30.576] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:30.576] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:167:0) after 1m0s
[02:25:30.634] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:167:0)
[02:25:30.634] Timer tick, asking Buildbucket for the build status
[02:25:30.812] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:30.813] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:168:0) after 1m0s
[02:26:31.617] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:168:0)
[02:26:31.617] Timer tick, asking Buildbucket for the build status
[02:26:31.675] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:31.675] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:169:0) after 1m0s
[02:27:31.823] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:169:0)
[02:27:31.823] Timer tick, asking Buildbucket for the build status
[02:27:31.920] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:31.920] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:170:0) after 1m0s
[02:28:32.247] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:170:0)
[02:28:32.248] Timer tick, asking Buildbucket for the build status
[02:28:32.437] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:32.437] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:171:0) after 1m0s
[02:29:32.654] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:171:0)
[02:29:32.654] Timer tick, asking Buildbucket for the build status
[02:29:32.717] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:32.717] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:172:0) after 1m0s
[02:30:32.829] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:172:0)
[02:30:32.829] Timer tick, asking Buildbucket for the build status
[02:30:32.967] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:32.967] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:173:0) after 1m0s
[02:31:33.056] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:173:0)
[02:31:33.056] Timer tick, asking Buildbucket for the build status
[02:31:33.113] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:33.113] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:174:0) after 1m0s
[02:32:34.885] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:174:0)
[02:32:34.885] Timer tick, asking Buildbucket for the build status
[02:32:35.034] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:35.034] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:175:0) after 1m0s
[02:33:35.062] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:175:0)
[02:33:35.062] Timer tick, asking Buildbucket for the build status
[02:33:35.354] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:35.354] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:176:0) after 1m0s
[02:34:35.378] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:176:0)
[02:34:35.378] Timer tick, asking Buildbucket for the build status
[02:34:36.001] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:36.001] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:177:0) after 1m0s
[02:35:36.127] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:177:0)
[02:35:36.127] Timer tick, asking Buildbucket for the build status
[02:35:36.231] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:36.231] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:178:0) after 1m0s
[02:36:36.349] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:178:0)
[02:36:36.349] Timer tick, asking Buildbucket for the build status
[02:36:36.722] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:36.722] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:179:0) after 1m0s
[02:37:36.757] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:179:0)
[02:37:36.757] Timer tick, asking Buildbucket for the build status
[02:37:36.829] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:36.829] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:180:0) after 1m0s
[02:38:36.855] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:180:0)
[02:38:36.855] Timer tick, asking Buildbucket for the build status
[02:38:36.910] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:36.910] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:181:0) after 1m0s
[02:39:36.935] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:181:0)
[02:39:36.935] Timer tick, asking Buildbucket for the build status
[02:39:36.993] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:36.993] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:182:0) after 1m0s
[02:40:37.093] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:182:0)
[02:40:37.093] Timer tick, asking Buildbucket for the build status
[02:40:37.219] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:37.219] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:183:0) after 1m0s
[02:41:37.281] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:183:0)
[02:41:37.281] Timer tick, asking Buildbucket for the build status
[02:41:37.635] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:37.635] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:184:0) after 1m0s
[02:42:37.757] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:184:0)
[02:42:37.757] Timer tick, asking Buildbucket for the build status
[02:42:38.034] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:38.034] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:185:0) after 1m0s
[02:43:38.088] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:185:0)
[02:43:38.088] Timer tick, asking Buildbucket for the build status
[02:43:38.150] Build 8856546192428339392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:38.150] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021976254515713376:186:0) after 1m0s
[02:44:11.234] Received PubSub notification, asking Buildbucket for the build status
[02:44:11.317] Build 8856546192428339392: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:44:11.317] Buildbucket build:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "completed_ts": "1612147450528107",
    "created_by": "project:chromium",
    "created_ts": "1612136386423055",
    "id": "8856546192428339392",
    "parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"098e477af2b812515458393e03d549d3e178422d\"}}",
    "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\": \"098e477af2b812515458393e03d549d3e178422d\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"win-dbg-2-ksg6\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 1507, \"got_angle_revision\": \"0be050a44a4308ace01229b89bd4560457356007\", \"got_dawn_revision\": \"c1d3a66bd217395a501543b09c6d2c25e9d2e22e\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"098e477af2b812515458393e03d549d3e178422d\", \"got_revision_cp\": \"refs/heads/master@{#848972}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"8b4cf1c2491d56cf9eda153b5455e4b295732b7c\", \"got_v8_revision\": \"cbbe339c1ca9754b3123fe2bdb83c0f58ee5d728\", \"got_v8_revision_cp\": \"refs/heads/9.0.101@{#1}\", \"got_webrtc_revision\": \"41bfcf4a63611409220fcd458a03deaa2cd23619\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33116}\", \"mirrored_builders\": [\"tryserver.chromium:win-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"098e477af2b812515458393e03d549d3e178422d\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_9b3ebe5fd1c5be87380c40d216747346a59b28cf26de183f0e8e2b32e944d3c8_v2\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-2-ksg6\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5673-2413400\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1612136431738396",
    "status": "COMPLETED",
    "status_changed_ts": "1612147450816145",
    "tags": [
      "build_address:luci.chromium.ci/win-official/1507",
      "builder:win-official",
      "buildset:commit/git/098e477af2b812515458393e03d549d3e178422d",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/098e477af2b812515458393e03d549d3e178422d",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9021976254515713376",
      "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/8856546192428339392/+/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:5173a29b86ce5a10",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1612147450832068",
    "url": "https://ci.chromium.org/b/8856546192428339392",
    "utcnow_ts": "1612147451308806"
  }
}
[02:44:11.317] Invocation finished in 3h4m26.267886487s with status SUCCEEDED