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

Definition (rev 61da5958bb1bf61dc6dab9a9ab14fa46798b5d0f)

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

Incoming triggers

Incoming properties

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

Incoming tags

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

Debug log (UTC)

[00:34:04.223] New invocation is queued and will start shortly
[00:34:05.424] Starting the invocation (attempt 1)
[00:34:05.461] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:34:05.461] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:34:05.461] Buildbucket request:
{
  "bucket": "luci.chromium.ci",
  "client_operation_id": "9023694179407693344",
  "parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"854d530cf1ebb9d84930b6f65f2fa12296261df7\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:win-official",
    "scheduler_invocation_id:9023694179407693344",
    "scheduler_job_id:chromium/win-official",
    "user_agent:luci-scheduler",
    "buildset:commit/git/854d530cf1ebb9d84930b6f65f2fa12296261df7",
    "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/854d530cf1ebb9d84930b6f65f2fa12296261df7",
    "gitiles_ref:refs/heads/master"
  ]
}
[00:34:06.562] Buildbucket response:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "created_by": "project:chromium",
    "created_ts": "1610498045596128",
    "id": "8858264117299048336",
    "parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"854d530cf1ebb9d84930b6f65f2fa12296261df7\"}}",
    "project": "chromium",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1610498046190027",
    "tags": [
      "build_address:luci.chromium.ci/win-official/1372",
      "builder:win-official",
      "buildset:commit/git/854d530cf1ebb9d84930b6f65f2fa12296261df7",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/854d530cf1ebb9d84930b6f65f2fa12296261df7",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9023694179407693344",
      "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/8858264117299048336/+/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": "1610498046190213",
    "url": "https://ci.chromium.org/b/8858264117299048336",
    "utcnow_ts": "1610498046542954"
  }
}
[00:34:06.563] Task URL: https://ci.chromium.org/b/8858264117299048336
[00:34:06.563] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:2:0) after 1m0s
[00:34:50.260] Received PubSub notification, asking Buildbucket for the build status
[00:34:50.389] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:06.621] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:2:0)
[00:35:06.621] Timer tick, asking Buildbucket for the build status
[00:35:06.780] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:06.780] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:4:0) after 1m0s
[00:36:06.757] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:4:0)
[00:36:06.757] Timer tick, asking Buildbucket for the build status
[00:36:06.912] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:06.912] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:5:0) after 1m0s
[00:37:07.017] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:5:0)
[00:37:07.017] Timer tick, asking Buildbucket for the build status
[00:37:07.406] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:07.407] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:6:0) after 1m0s
[00:38:07.531] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:6:0)
[00:38:07.531] Timer tick, asking Buildbucket for the build status
[00:38:07.712] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:07.712] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:7:0) after 1m0s
[00:39:07.727] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:7:0)
[00:39:07.727] Timer tick, asking Buildbucket for the build status
[00:39:07.812] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:07.812] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:8:0) after 1m0s
[00:40:07.888] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:8:0)
[00:40:07.888] Timer tick, asking Buildbucket for the build status
[00:40:08.360] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:08.360] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:9:0) after 1m0s
[00:41:08.415] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:9:0)
[00:41:08.415] Timer tick, asking Buildbucket for the build status
[00:41:08.496] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:08.496] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:10:0) after 1m0s
[00:42:08.569] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:10:0)
[00:42:08.569] Timer tick, asking Buildbucket for the build status
[00:42:08.674] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:08.674] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:11:0) after 1m0s
[00:43:08.701] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:11:0)
[00:43:08.701] Timer tick, asking Buildbucket for the build status
[00:43:09.044] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:09.044] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:12:0) after 1m0s
[00:44:09.141] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:12:0)
[00:44:09.141] Timer tick, asking Buildbucket for the build status
[00:44:09.352] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:09.352] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:13:0) after 1m0s
[00:45:09.439] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:13:0)
[00:45:09.439] Timer tick, asking Buildbucket for the build status
[00:45:10.020] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:10.020] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:14:0) after 1m0s
[00:46:10.049] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:14:0)
[00:46:10.049] Timer tick, asking Buildbucket for the build status
[00:46:10.365] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:10.365] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:15:0) after 1m0s
[00:47:10.365] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:15:0)
[00:47:10.365] Timer tick, asking Buildbucket for the build status
[00:47:10.514] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:10.514] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:16:0) after 1m0s
[00:48:10.580] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:16:0)
[00:48:10.580] Timer tick, asking Buildbucket for the build status
[00:48:10.653] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:10.653] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:17:0) after 1m0s
[00:49:10.725] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:17:0)
[00:49:10.725] Timer tick, asking Buildbucket for the build status
[00:49:10.999] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:10.999] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:18:0) after 1m0s
[00:50:11.083] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:18:0)
[00:50:11.083] Timer tick, asking Buildbucket for the build status
[00:50:11.419] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:11.419] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:19:0) after 1m0s
[00:51:11.449] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:19:0)
[00:51:11.449] Timer tick, asking Buildbucket for the build status
[00:51:11.509] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:11.509] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:20:0) after 1m0s
[00:52:11.528] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:20:0)
[00:52:11.528] Timer tick, asking Buildbucket for the build status
[00:52:11.726] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:11.726] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:21:0) after 1m0s
[00:53:11.731] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:21:0)
[00:53:11.731] Timer tick, asking Buildbucket for the build status
[00:53:11.833] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:11.833] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:22:0) after 1m0s
[00:54:11.871] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:22:0)
[00:54:11.871] Timer tick, asking Buildbucket for the build status
[00:54:11.975] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:11.975] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:23:0) after 1m0s
[00:55:12.063] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:23:0)
[00:55:12.063] Timer tick, asking Buildbucket for the build status
[00:55:12.192] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:12.192] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:24:0) after 1m0s
[00:56:12.336] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:24:0)
[00:56:12.336] Timer tick, asking Buildbucket for the build status
[00:56:12.761] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:12.761] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:25:0) after 1m0s
[00:57:12.780] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:25:0)
[00:57:12.780] Timer tick, asking Buildbucket for the build status
[00:57:13.851] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:13.851] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:26:0) after 1m0s
[00:58:13.904] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:26:0)
[00:58:13.904] Timer tick, asking Buildbucket for the build status
[00:58:14.290] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:14.290] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:27:0) after 1m0s
[00:59:14.348] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:27:0)
[00:59:14.348] Timer tick, asking Buildbucket for the build status
[00:59:14.473] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:14.473] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:28:0) after 1m0s
[01:00:14.552] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:28:0)
[01:00:14.552] Timer tick, asking Buildbucket for the build status
[01:00:14.720] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:14.720] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:29:0) after 1m0s
[01:01:14.760] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:29:0)
[01:01:14.760] Timer tick, asking Buildbucket for the build status
[01:01:14.858] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:14.858] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:30:0) after 1m0s
[01:02:14.939] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:30:0)
[01:02:14.939] Timer tick, asking Buildbucket for the build status
[01:02:15.033] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:15.033] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:31:0) after 1m0s
[01:03:15.032] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:31:0)
[01:03:15.032] Timer tick, asking Buildbucket for the build status
[01:03:15.183] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:15.183] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:32:0) after 1m0s
[01:04:15.226] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:32:0)
[01:04:15.226] Timer tick, asking Buildbucket for the build status
[01:04:15.339] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:15.339] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:33:0) after 1m0s
[01:05:15.403] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:33:0)
[01:05:15.403] Timer tick, asking Buildbucket for the build status
[01:05:15.512] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:15.512] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:34:0) after 1m0s
[01:06:15.541] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:34:0)
[01:06:15.541] Timer tick, asking Buildbucket for the build status
[01:06:15.857] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:15.857] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:35:0) after 1m0s
[01:07:15.869] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:35:0)
[01:07:15.869] Timer tick, asking Buildbucket for the build status
[01:07:15.933] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:15.933] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:36:0) after 1m0s
[01:08:15.947] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:36:0)
[01:08:15.947] Timer tick, asking Buildbucket for the build status
[01:08:16.066] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:16.066] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:37:0) after 1m0s
[01:09:16.099] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:37:0)
[01:09:16.099] Timer tick, asking Buildbucket for the build status
[01:09:16.315] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:16.315] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:38:0) after 1m0s
[01:10:16.343] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:38:0)
[01:10:16.343] Timer tick, asking Buildbucket for the build status
[01:10:16.495] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:16.495] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:39:0) after 1m0s
[01:11:16.519] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:39:0)
[01:11:16.519] Timer tick, asking Buildbucket for the build status
[01:11:16.853] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:16.854] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:40:0) after 1m0s
[01:12:16.901] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:40:0)
[01:12:16.901] Timer tick, asking Buildbucket for the build status
[01:12:17.308] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:17.308] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:41:0) after 1m0s
[01:13:17.388] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:41:0)
[01:13:17.388] Timer tick, asking Buildbucket for the build status
[01:13:17.601] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:17.601] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:42:0) after 1m0s
[01:14:17.646] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:42:0)
[01:14:17.646] Timer tick, asking Buildbucket for the build status
[01:14:17.763] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:17.763] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:43:0) after 1m0s
[01:15:17.781] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:43:0)
[01:15:17.781] Timer tick, asking Buildbucket for the build status
[01:15:17.972] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:17.972] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:44:0) after 1m0s
[01:16:17.982] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:44:0)
[01:16:17.982] Timer tick, asking Buildbucket for the build status
[01:16:18.069] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:18.069] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:45:0) after 1m0s
[01:17:18.136] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:45:0)
[01:17:18.136] Timer tick, asking Buildbucket for the build status
[01:17:18.390] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:18.390] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:46:0) after 1m0s
[01:18:18.447] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:46:0)
[01:18:18.447] Timer tick, asking Buildbucket for the build status
[01:18:18.661] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:18.661] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:47:0) after 1m0s
[01:19:18.686] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:47:0)
[01:19:18.686] Timer tick, asking Buildbucket for the build status
[01:19:18.805] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:18.805] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:48:0) after 1m0s
[01:20:18.898] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:48:0)
[01:20:18.898] Timer tick, asking Buildbucket for the build status
[01:20:18.999] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:18.999] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:49:0) after 1m0s
[01:21:19.112] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:49:0)
[01:21:19.112] Timer tick, asking Buildbucket for the build status
[01:21:19.414] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:19.414] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:50:0) after 1m0s
[01:22:19.532] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:50:0)
[01:22:19.532] Timer tick, asking Buildbucket for the build status
[01:22:19.882] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:19.882] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:51:0) after 1m0s
[01:23:19.863] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:51:0)
[01:23:19.863] Timer tick, asking Buildbucket for the build status
[01:23:19.927] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:19.927] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:52:0) after 1m0s
[01:24:19.958] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:52:0)
[01:24:19.958] Timer tick, asking Buildbucket for the build status
[01:24:20.118] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:20.118] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:53:0) after 1m0s
[01:25:20.185] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:53:0)
[01:25:20.185] Timer tick, asking Buildbucket for the build status
[01:25:20.413] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:20.413] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:54:0) after 1m0s
[01:26:20.489] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:54:0)
[01:26:20.489] Timer tick, asking Buildbucket for the build status
[01:26:20.721] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:20.721] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:55:0) after 1m0s
[01:27:20.738] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:55:0)
[01:27:20.738] Timer tick, asking Buildbucket for the build status
[01:27:20.814] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:20.814] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:56:0) after 1m0s
[01:28:20.801] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:56:0)
[01:28:20.801] Timer tick, asking Buildbucket for the build status
[01:28:20.995] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:20.995] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:57:0) after 1m0s
[01:29:21.048] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:57:0)
[01:29:21.048] Timer tick, asking Buildbucket for the build status
[01:29:21.219] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:21.219] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:58:0) after 1m0s
[01:30:21.272] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:58:0)
[01:30:21.272] Timer tick, asking Buildbucket for the build status
[01:30:21.518] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:21.518] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:59:0) after 1m0s
[01:31:21.601] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:59:0)
[01:31:21.601] Timer tick, asking Buildbucket for the build status
[01:31:21.696] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:21.696] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:60:0) after 1m0s
[01:32:21.765] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:60:0)
[01:32:21.765] Timer tick, asking Buildbucket for the build status
[01:32:21.845] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:21.845] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:61:0) after 1m0s
[01:33:22.286] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:61:0)
[01:33:22.286] Timer tick, asking Buildbucket for the build status
[01:33:22.347] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:22.347] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:62:0) after 1m0s
[01:34:22.622] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:62:0)
[01:34:22.622] Timer tick, asking Buildbucket for the build status
[01:34:22.750] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:22.750] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:63:0) after 1m0s
[01:35:23.039] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:63:0)
[01:35:23.039] Timer tick, asking Buildbucket for the build status
[01:35:23.346] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:23.346] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:64:0) after 1m0s
[01:36:23.393] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:64:0)
[01:36:23.393] Timer tick, asking Buildbucket for the build status
[01:36:23.570] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:23.570] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:65:0) after 1m0s
[01:37:23.623] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:65:0)
[01:37:23.623] Timer tick, asking Buildbucket for the build status
[01:37:23.715] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:23.715] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:66:0) after 1m0s
[01:38:23.760] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:66:0)
[01:38:23.760] Timer tick, asking Buildbucket for the build status
[01:38:24.914] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:24.914] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:67:0) after 1m0s
[01:39:24.955] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:67:0)
[01:39:24.955] Timer tick, asking Buildbucket for the build status
[01:39:25.207] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:25.207] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:68:0) after 1m0s
[01:40:25.235] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:68:0)
[01:40:25.235] Timer tick, asking Buildbucket for the build status
[01:40:25.406] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:25.406] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:69:0) after 1m0s
[01:41:25.439] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:69:0)
[01:41:25.439] Timer tick, asking Buildbucket for the build status
[01:41:25.520] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:25.520] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:70:0) after 1m0s
[01:42:25.580] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:70:0)
[01:42:25.580] Timer tick, asking Buildbucket for the build status
[01:42:25.698] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:25.698] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:71:0) after 1m0s
[01:43:25.718] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:71:0)
[01:43:25.718] Timer tick, asking Buildbucket for the build status
[01:43:25.827] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:25.827] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:72:0) after 1m0s
[01:44:25.840] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:72:0)
[01:44:25.840] Timer tick, asking Buildbucket for the build status
[01:44:26.001] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:26.002] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:73:0) after 1m0s
[01:45:26.019] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:73:0)
[01:45:26.019] Timer tick, asking Buildbucket for the build status
[01:45:26.125] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:26.125] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:74:0) after 1m0s
[01:46:26.182] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:74:0)
[01:46:26.182] Timer tick, asking Buildbucket for the build status
[01:46:26.422] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:26.422] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:75:0) after 1m0s
[01:47:26.498] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:75:0)
[01:47:26.498] Timer tick, asking Buildbucket for the build status
[01:47:26.598] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:26.598] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:76:0) after 1m0s
[01:48:26.671] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:76:0)
[01:48:26.671] Timer tick, asking Buildbucket for the build status
[01:48:26.760] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:26.760] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:77:0) after 1m0s
[01:49:26.843] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:77:0)
[01:49:26.843] Timer tick, asking Buildbucket for the build status
[01:49:26.958] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:26.958] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:78:0) after 1m0s
[01:50:27.337] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:78:0)
[01:50:27.337] Timer tick, asking Buildbucket for the build status
[01:50:27.400] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:27.400] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:79:0) after 1m0s
[01:51:27.577] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:79:0)
[01:51:27.577] Timer tick, asking Buildbucket for the build status
[01:51:27.639] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:27.639] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:80:0) after 1m0s
[01:52:27.798] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:80:0)
[01:52:27.798] Timer tick, asking Buildbucket for the build status
[01:52:27.878] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:27.878] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:81:0) after 1m0s
[01:53:27.942] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:81:0)
[01:53:27.942] Timer tick, asking Buildbucket for the build status
[01:53:28.039] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:28.039] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:82:0) after 1m0s
[01:54:28.108] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:82:0)
[01:54:28.108] Timer tick, asking Buildbucket for the build status
[01:54:28.270] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:28.270] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:83:0) after 1m0s
[01:55:28.388] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:83:0)
[01:55:28.388] Timer tick, asking Buildbucket for the build status
[01:55:28.472] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:28.472] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:84:0) after 1m0s
[01:56:28.783] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:84:0)
[01:56:28.783] Timer tick, asking Buildbucket for the build status
[01:56:28.872] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:28.872] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:85:0) after 1m0s
[01:57:29.059] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:85:0)
[01:57:29.059] Timer tick, asking Buildbucket for the build status
[01:57:29.217] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:29.217] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:86:0) after 1m0s
[01:58:29.301] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:86:0)
[01:58:29.301] Timer tick, asking Buildbucket for the build status
[01:58:29.535] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:29.535] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:87:0) after 1m0s
[01:59:29.609] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:87:0)
[01:59:29.609] Timer tick, asking Buildbucket for the build status
[01:59:29.810] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:29.810] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:88:0) after 1m0s
[02:00:29.851] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:88:0)
[02:00:29.851] Timer tick, asking Buildbucket for the build status
[02:00:30.169] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:30.169] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:89:0) after 1m0s
[02:01:30.209] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:89:0)
[02:01:30.209] Timer tick, asking Buildbucket for the build status
[02:01:30.295] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:30.295] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:90:0) after 1m0s
[02:02:30.377] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:90:0)
[02:02:30.377] Timer tick, asking Buildbucket for the build status
[02:02:30.614] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:30.614] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:91:0) after 1m0s
[02:03:30.645] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:91:0)
[02:03:30.645] Timer tick, asking Buildbucket for the build status
[02:03:30.736] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:30.736] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:92:0) after 1m0s
[02:04:30.776] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:92:0)
[02:04:30.776] Timer tick, asking Buildbucket for the build status
[02:04:31.019] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:31.019] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:93:0) after 1m0s
[02:05:31.068] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:93:0)
[02:05:31.068] Timer tick, asking Buildbucket for the build status
[02:05:31.127] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:31.127] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:94:0) after 1m0s
[02:06:31.158] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:94:0)
[02:06:31.158] Timer tick, asking Buildbucket for the build status
[02:06:31.264] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:31.264] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:95:0) after 1m0s
[02:07:31.390] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:95:0)
[02:07:31.390] Timer tick, asking Buildbucket for the build status
[02:07:31.580] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:31.580] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:96:0) after 1m0s
[02:08:31.611] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:96:0)
[02:08:31.611] Timer tick, asking Buildbucket for the build status
[02:08:31.738] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:31.738] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:97:0) after 1m0s
[02:09:31.789] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:97:0)
[02:09:31.789] Timer tick, asking Buildbucket for the build status
[02:09:32.048] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:32.048] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:98:0) after 1m0s
[02:10:32.109] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:98:0)
[02:10:32.109] Timer tick, asking Buildbucket for the build status
[02:10:33.485] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:33.485] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:99:0) after 1m0s
[02:11:33.596] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:99:0)
[02:11:33.596] Timer tick, asking Buildbucket for the build status
[02:11:33.682] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:33.682] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:100:0) after 1m0s
[02:12:33.734] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:100:0)
[02:12:33.734] Timer tick, asking Buildbucket for the build status
[02:12:33.800] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:33.800] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:101:0) after 1m0s
[02:13:33.915] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:101:0)
[02:13:33.915] Timer tick, asking Buildbucket for the build status
[02:13:33.981] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:33.981] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:102:0) after 1m0s
[02:14:34.053] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:102:0)
[02:14:34.053] Timer tick, asking Buildbucket for the build status
[02:14:34.255] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:34.255] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:103:0) after 1m0s
[02:15:34.254] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:103:0)
[02:15:34.254] Timer tick, asking Buildbucket for the build status
[02:15:34.504] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:34.504] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:104:0) after 1m0s
[02:16:34.586] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:104:0)
[02:16:34.586] Timer tick, asking Buildbucket for the build status
[02:16:34.636] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:34.636] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:105:0) after 1m0s
[02:17:34.761] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:105:0)
[02:17:34.761] Timer tick, asking Buildbucket for the build status
[02:17:34.819] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:34.819] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:106:0) after 1m0s
[02:18:34.858] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:106:0)
[02:18:34.858] Timer tick, asking Buildbucket for the build status
[02:18:34.987] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:34.987] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:107:0) after 1m0s
[02:19:35.042] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:107:0)
[02:19:35.042] Timer tick, asking Buildbucket for the build status
[02:19:35.407] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:35.407] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:108:0) after 1m0s
[02:20:35.383] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:108:0)
[02:20:35.383] Timer tick, asking Buildbucket for the build status
[02:20:35.602] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:35.602] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:109:0) after 1m0s
[02:21:35.695] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:109:0)
[02:21:35.695] Timer tick, asking Buildbucket for the build status
[02:21:35.769] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:35.769] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:110:0) after 1m0s
[02:22:35.795] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:110:0)
[02:22:35.795] Timer tick, asking Buildbucket for the build status
[02:22:36.027] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:36.027] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:111:0) after 1m0s
[02:23:36.030] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:111:0)
[02:23:36.030] Timer tick, asking Buildbucket for the build status
[02:23:36.097] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:36.097] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:112:0) after 1m0s
[02:24:36.092] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:112:0)
[02:24:36.092] Timer tick, asking Buildbucket for the build status
[02:24:36.220] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:36.220] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:113:0) after 1m0s
[02:25:36.310] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:113:0)
[02:25:36.310] Timer tick, asking Buildbucket for the build status
[02:25:36.396] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:36.396] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:114:0) after 1m0s
[02:26:36.463] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:114:0)
[02:26:36.463] Timer tick, asking Buildbucket for the build status
[02:26:36.546] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:36.546] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:115:0) after 1m0s
[02:27:36.618] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:115:0)
[02:27:36.618] Timer tick, asking Buildbucket for the build status
[02:27:36.703] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:36.703] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:116:0) after 1m0s
[02:28:36.743] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:116:0)
[02:28:36.743] Timer tick, asking Buildbucket for the build status
[02:28:37.082] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:37.082] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:117:0) after 1m0s
[02:29:37.086] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:117:0)
[02:29:37.086] Timer tick, asking Buildbucket for the build status
[02:29:37.892] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:37.892] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:118:0) after 1m0s
[02:30:37.980] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:118:0)
[02:30:37.980] Timer tick, asking Buildbucket for the build status
[02:30:38.062] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:38.062] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:119:0) after 1m0s
[02:31:38.161] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:119:0)
[02:31:38.161] Timer tick, asking Buildbucket for the build status
[02:31:38.289] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:38.289] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:120:0) after 1m0s
[02:32:38.362] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:120:0)
[02:32:38.362] Timer tick, asking Buildbucket for the build status
[02:32:38.600] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:38.600] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:121:0) after 1m0s
[02:33:38.625] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:121:0)
[02:33:38.625] Timer tick, asking Buildbucket for the build status
[02:33:38.715] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:38.715] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:122:0) after 1m0s
[02:34:38.798] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:122:0)
[02:34:38.798] Timer tick, asking Buildbucket for the build status
[02:34:38.953] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:38.953] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:123:0) after 1m0s
[02:35:38.967] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:123:0)
[02:35:38.967] Timer tick, asking Buildbucket for the build status
[02:35:39.039] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:39.039] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:124:0) after 1m0s
[02:36:39.177] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:124:0)
[02:36:39.177] Timer tick, asking Buildbucket for the build status
[02:36:39.250] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:39.250] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:125:0) after 1m0s
[02:37:39.319] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:125:0)
[02:37:39.319] Timer tick, asking Buildbucket for the build status
[02:37:39.574] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:39.574] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:126:0) after 1m0s
[02:38:39.678] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:126:0)
[02:38:39.678] Timer tick, asking Buildbucket for the build status
[02:38:39.870] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:39.870] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:127:0) after 1m0s
[02:39:39.950] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:127:0)
[02:39:39.950] Timer tick, asking Buildbucket for the build status
[02:39:40.082] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:40.082] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:128:0) after 1m0s
[02:40:40.215] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:128:0)
[02:40:40.215] Timer tick, asking Buildbucket for the build status
[02:40:40.298] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:40.298] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:129:0) after 1m0s
[02:41:40.375] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:129:0)
[02:41:40.375] Timer tick, asking Buildbucket for the build status
[02:41:40.446] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:40.446] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:130:0) after 1m0s
[02:42:40.438] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:130:0)
[02:42:40.438] Timer tick, asking Buildbucket for the build status
[02:42:40.532] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:40.532] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:131:0) after 1m0s
[02:43:40.542] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:131:0)
[02:43:40.542] Timer tick, asking Buildbucket for the build status
[02:43:40.641] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:40.641] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:132:0) after 1m0s
[02:44:40.816] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:132:0)
[02:44:40.816] Timer tick, asking Buildbucket for the build status
[02:44:40.933] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:40.933] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:133:0) after 1m0s
[02:45:40.999] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:133:0)
[02:45:40.999] Timer tick, asking Buildbucket for the build status
[02:45:41.105] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:41.105] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:134:0) after 1m0s
[02:46:41.130] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:134:0)
[02:46:41.130] Timer tick, asking Buildbucket for the build status
[02:46:41.212] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:41.212] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:135:0) after 1m0s
[02:47:41.255] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:135:0)
[02:47:41.255] Timer tick, asking Buildbucket for the build status
[02:47:41.327] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:41.327] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:136:0) after 1m0s
[02:48:41.340] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:136:0)
[02:48:41.340] Timer tick, asking Buildbucket for the build status
[02:48:41.426] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:41.426] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:137:0) after 1m0s
[02:49:41.476] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:137:0)
[02:49:41.476] Timer tick, asking Buildbucket for the build status
[02:49:41.919] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:41.919] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:138:0) after 1m0s
[02:50:41.958] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:138:0)
[02:50:41.958] Timer tick, asking Buildbucket for the build status
[02:50:42.045] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:42.045] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:139:0) after 1m0s
[02:51:42.124] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:139:0)
[02:51:42.124] Timer tick, asking Buildbucket for the build status
[02:51:42.317] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:42.317] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:140:0) after 1m0s
[02:52:42.349] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:140:0)
[02:52:42.349] Timer tick, asking Buildbucket for the build status
[02:52:42.413] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:42.413] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:141:0) after 1m0s
[02:53:42.472] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:141:0)
[02:53:42.472] Timer tick, asking Buildbucket for the build status
[02:53:42.547] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:42.547] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:142:0) after 1m0s
[02:54:42.660] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:142:0)
[02:54:42.660] Timer tick, asking Buildbucket for the build status
[02:54:42.791] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:42.791] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:143:0) after 1m0s
[02:55:42.913] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:143:0)
[02:55:42.913] Timer tick, asking Buildbucket for the build status
[02:55:42.983] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:42.983] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:144:0) after 1m0s
[02:56:43.030] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:144:0)
[02:56:43.030] Timer tick, asking Buildbucket for the build status
[02:56:43.229] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:43.229] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:145:0) after 1m0s
[02:57:43.287] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:145:0)
[02:57:43.287] Timer tick, asking Buildbucket for the build status
[02:57:43.365] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:43.365] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:146:0) after 1m0s
[02:58:43.415] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:146:0)
[02:58:43.415] Timer tick, asking Buildbucket for the build status
[02:58:43.505] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:43.505] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:147:0) after 1m0s
[02:59:43.628] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:147:0)
[02:59:43.628] Timer tick, asking Buildbucket for the build status
[02:59:43.743] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:43.744] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:148:0) after 1m0s
[03:00:43.815] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:148:0)
[03:00:43.815] Timer tick, asking Buildbucket for the build status
[03:00:43.953] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:43.953] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:149:0) after 1m0s
[03:01:43.968] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:149:0)
[03:01:43.968] Timer tick, asking Buildbucket for the build status
[03:01:44.223] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:44.223] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:150:0) after 1m0s
[03:02:44.253] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:150:0)
[03:02:44.253] Timer tick, asking Buildbucket for the build status
[03:02:44.351] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:44.351] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:151:0) after 1m0s
[03:03:44.418] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:151:0)
[03:03:44.418] Timer tick, asking Buildbucket for the build status
[03:03:44.510] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:44.510] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:152:0) after 1m0s
[03:04:44.576] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:152:0)
[03:04:44.576] Timer tick, asking Buildbucket for the build status
[03:04:44.728] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:44.728] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:153:0) after 1m0s
[03:05:44.742] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:153:0)
[03:05:44.742] Timer tick, asking Buildbucket for the build status
[03:05:44.811] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:44.812] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:154:0) after 1m0s
[03:06:44.855] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:154:0)
[03:06:44.855] Timer tick, asking Buildbucket for the build status
[03:06:44.929] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:44.929] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:155:0) after 1m0s
[03:07:45.007] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:155:0)
[03:07:45.007] Timer tick, asking Buildbucket for the build status
[03:07:45.083] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:45.083] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:156:0) after 1m0s
[03:08:45.132] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:156:0)
[03:08:45.132] Timer tick, asking Buildbucket for the build status
[03:08:45.206] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:45.206] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:157:0) after 1m0s
[03:09:45.625] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:157:0)
[03:09:45.625] Timer tick, asking Buildbucket for the build status
[03:09:45.850] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:45.850] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:158:0) after 1m0s
[03:10:46.382] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:158:0)
[03:10:46.382] Timer tick, asking Buildbucket for the build status
[03:10:46.455] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:46.455] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:159:0) after 1m0s
[03:11:46.495] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:159:0)
[03:11:46.495] Timer tick, asking Buildbucket for the build status
[03:11:46.713] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:46.713] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:160:0) after 1m0s
[03:12:46.808] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:160:0)
[03:12:46.808] Timer tick, asking Buildbucket for the build status
[03:12:46.871] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:46.871] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:161:0) after 1m0s
[03:13:47.027] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:161:0)
[03:13:47.027] Timer tick, asking Buildbucket for the build status
[03:13:47.175] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:47.175] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:162:0) after 1m0s
[03:14:47.243] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:162:0)
[03:14:47.243] Timer tick, asking Buildbucket for the build status
[03:14:47.354] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:47.354] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:163:0) after 1m0s
[03:15:47.474] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:163:0)
[03:15:47.474] Timer tick, asking Buildbucket for the build status
[03:15:47.622] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:47.622] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:164:0) after 1m0s
[03:16:47.691] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:164:0)
[03:16:47.691] Timer tick, asking Buildbucket for the build status
[03:16:47.848] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:47.848] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:165:0) after 1m0s
[03:17:47.836] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:165:0)
[03:17:47.836] Timer tick, asking Buildbucket for the build status
[03:17:47.925] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:47.925] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:166:0) after 1m0s
[03:18:48.064] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:166:0)
[03:18:48.064] Timer tick, asking Buildbucket for the build status
[03:18:48.413] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:48.413] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:167:0) after 1m0s
[03:19:48.471] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:167:0)
[03:19:48.471] Timer tick, asking Buildbucket for the build status
[03:19:49.137] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:49.137] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:168:0) after 1m0s
[03:20:49.145] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:168:0)
[03:20:49.145] Timer tick, asking Buildbucket for the build status
[03:20:49.206] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:49.206] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:169:0) after 1m0s
[03:21:49.268] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:169:0)
[03:21:49.268] Timer tick, asking Buildbucket for the build status
[03:21:49.325] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:49.325] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:170:0) after 1m0s
[03:22:49.379] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:170:0)
[03:22:49.379] Timer tick, asking Buildbucket for the build status
[03:22:49.476] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:49.476] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:171:0) after 1m0s
[03:23:49.535] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:171:0)
[03:23:49.535] Timer tick, asking Buildbucket for the build status
[03:23:49.615] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:49.615] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:172:0) after 1m0s
[03:24:49.863] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:172:0)
[03:24:49.863] Timer tick, asking Buildbucket for the build status
[03:24:49.997] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:49.997] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:173:0) after 1m0s
[03:25:50.112] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:173:0)
[03:25:50.112] Timer tick, asking Buildbucket for the build status
[03:25:50.210] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:50.210] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:174:0) after 1m0s
[03:26:50.500] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:174:0)
[03:26:50.500] Timer tick, asking Buildbucket for the build status
[03:26:50.569] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:50.569] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:175:0) after 1m0s
[03:27:50.788] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:175:0)
[03:27:50.788] Timer tick, asking Buildbucket for the build status
[03:27:51.294] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:51.294] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:176:0) after 1m0s
[03:28:51.393] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:176:0)
[03:28:51.393] Timer tick, asking Buildbucket for the build status
[03:28:51.504] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:51.504] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:177:0) after 1m0s
[03:29:51.670] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:177:0)
[03:29:51.670] Timer tick, asking Buildbucket for the build status
[03:29:51.799] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:51.799] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:178:0) after 1m0s
[03:30:51.893] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:178:0)
[03:30:51.893] Timer tick, asking Buildbucket for the build status
[03:30:52.314] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:52.314] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:179:0) after 1m0s
[03:31:52.521] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:179:0)
[03:31:52.521] Timer tick, asking Buildbucket for the build status
[03:31:52.610] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:52.610] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:180:0) after 1m0s
[03:32:52.896] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:180:0)
[03:32:52.896] Timer tick, asking Buildbucket for the build status
[03:32:52.951] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:52.951] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:181:0) after 1m0s
[03:33:53.123] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:181:0)
[03:33:53.123] Timer tick, asking Buildbucket for the build status
[03:33:53.187] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:53.187] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:182:0) after 1m0s
[03:34:53.560] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:182:0)
[03:34:53.560] Timer tick, asking Buildbucket for the build status
[03:34:53.671] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:53.671] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:183:0) after 1m0s
[03:35:53.749] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:183:0)
[03:35:53.749] Timer tick, asking Buildbucket for the build status
[03:35:53.816] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:53.816] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:184:0) after 1m0s
[03:36:54.266] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:184:0)
[03:36:54.266] Timer tick, asking Buildbucket for the build status
[03:36:54.515] Build 8858264117299048336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:54.515] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023694179407693344:185:0) after 1m0s
[03:37:51.173] Received PubSub notification, asking Buildbucket for the build status
[03:37:51.251] Build 8858264117299048336: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:37:51.251] Buildbucket build:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "completed_ts": "1610509070232296",
    "created_by": "project:chromium",
    "created_ts": "1610498045596128",
    "id": "8858264117299048336",
    "parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"854d530cf1ebb9d84930b6f65f2fa12296261df7\"}}",
    "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\": \"854d530cf1ebb9d84930b6f65f2fa12296261df7\", \"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-4-yywi\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 1372, \"got_angle_revision\": \"d38b9f86ff8c57378ed2b301ad1f1b9ba80837ed\", \"got_dawn_revision\": \"22eff1eb8c2ff44e1928121d93559fcf0b81f834\", \"got_nacl_revision\": \"d28e6c52e05ea2f1b3231de473b6dbfce59bce40\", \"got_revision\": \"854d530cf1ebb9d84930b6f65f2fa12296261df7\", \"got_revision_cp\": \"refs/heads/master@{#842792}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"3549479dc4ccd92ef3b9e179080dcec1a430b01d\", \"got_v8_revision\": \"16b9bbbd581c25391981aa03180b76aa60463a3e\", \"got_v8_revision_cp\": \"refs/heads/8.9.255@{#1}\", \"got_webrtc_revision\": \"1c5e63e5451374783aaf0259f5c23d3688a5b2ff\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32938}\", \"mirrored_builders\": [\"tryserver.chromium:win-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"854d530cf1ebb9d84930b6f65f2fa12296261df7\"}, \"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-4-yywi\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5661-c6f6250\"], \"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": "1610498089404447",
    "status": "COMPLETED",
    "status_changed_ts": "1610509070582956",
    "tags": [
      "build_address:luci.chromium.ci/win-official/1372",
      "builder:win-official",
      "buildset:commit/git/854d530cf1ebb9d84930b6f65f2fa12296261df7",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/854d530cf1ebb9d84930b6f65f2fa12296261df7",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9023694179407693344",
      "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/8858264117299048336/+/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:5111fb8408f8e210",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1610509070588512",
    "url": "https://ci.chromium.org/b/8858264117299048336",
    "utcnow_ts": "1610509071235229"
  }
}
[03:37:51.251] Invocation finished in 3h3m47.048605542s with status SUCCEEDED