LUCI Scheduler :: chromium :: win-official

Status: SUCCEEDED

Triggered by: -

Duration: 4 hours

Actions:

Definition (rev 61da5958bb1bf61dc6dab9a9ab14fa46798b5d0f)

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

Incoming triggers

78d95924cc6a2700ef359a177f18082c8bff4e1f (5 years ago)
2de58a0217d02d4d521cad4a18650e0e479ee087 (5 years ago)
8860253376c38c090d585bda4b20b801e3aa3ce3 (5 years ago)
d3f376a9efb4f13bf56f625b06e349665c0bb27b (5 years ago)
285cd8756c5e811e1cb99a5e94b5b05e094ed4d1 (5 years ago)
acf3123a9b99b01de58052d0e41bfb7b76eb8e4e (5 years ago)
8b6172ae53b26889afbad912d8d6e2eaa3c99814 (5 years ago)
03514c1ddfe35221e137e99cc4812cfad6a538f8 (5 years ago)
9b60b5b5bc157f67327918b78c4c50a42135611d (5 years ago)
e3b82499e89b42bd42abcfee6d91e8090f5eb1da (5 years ago)
bc1a8d3d60fc4822e15e7528eb6f74d0b93d4e75 (5 years ago)
d69ae10aa0ea4a475f7e3d8118a8f39895f64352 (5 years ago)
5786261541e560b9ba888d13e5c84a0ef7c80eb2 (5 years ago)
8e63dfcf119a94a23bdf18f1c10e2cdfc1f8800f (5 years ago)
1d41c559146e76620ebf72e308d94ed715a2b742 (5 years ago)
3eb7b106719dda4ded0e23675d7ff05e2e3e8fd9 (5 years ago)
bd19f4afc4ff04c044898b93baae505e696d21d8 (5 years ago)
c3ad19ae637adc56bcae7872d8684eab986a2225 (5 years ago)
e437a995e16449d15a1d62051e6e3fe841b35604 (5 years ago)
1185042aff54878bf3e38176c3a92a5759dc4ac3 (5 years ago)
a26ee33af52ed95ab58840c27494ba846088b915 (5 years ago)
58328102f712785d5828b1a562d7997658fd54e3 (5 years ago)
5616dce982c2590b75053844ebcf15ecff66a566 (5 years ago)
e8990099d555ae36df0ecad1a16991c4c9b152c8 (5 years ago)
6fba5108a59f534de963336324f602a28a7fb1cb (5 years ago)
68910d39922382ceef67cb6ad947aedc83967cc6 (5 years ago)
ca8ed0cd5646e9ab0c4531ceb7d85c5eaf762fdc (5 years ago)
abb0ef991720bf5394a20f5cf77270ce923b72c9 (5 years ago)
2d2177301ae88d98d0b8c76cc117bc816c873d9c (5 years ago)

Incoming properties

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

Incoming tags

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

Debug log (UTC)

[05:22:39.483] New invocation is queued and will start shortly
[05:22:40.792] Starting the invocation (attempt 1)
[05:22:40.828] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:22:40.828] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:22:40.828] Buildbucket request:
{
  "bucket": "luci.chromium.ci",
  "client_operation_id": "9023041844273424016",
  "parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"2d2177301ae88d98d0b8c76cc117bc816c873d9c\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:win-official",
    "scheduler_invocation_id:9023041844273424016",
    "scheduler_job_id:chromium/win-official",
    "user_agent:luci-scheduler",
    "buildset:commit/git/2d2177301ae88d98d0b8c76cc117bc816c873d9c",
    "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2d2177301ae88d98d0b8c76cc117bc816c873d9c",
    "gitiles_ref:refs/heads/master"
  ]
}
[05:22:41.507] Buildbucket response:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary": true,
    "canary_preference": "CANARY",
    "created_by": "project:chromium",
    "created_ts": "1611120160986044",
    "id": "8857611782031948608",
    "parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2d2177301ae88d98d0b8c76cc117bc816c873d9c\"}}",
    "project": "chromium",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1611120161367657",
    "tags": [
      "build_address:luci.chromium.ci/win-official/1420",
      "builder:win-official",
      "buildset:commit/git/2d2177301ae88d98d0b8c76cc117bc816c873d9c",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2d2177301ae88d98d0b8c76cc117bc816c873d9c",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9023041844273424016",
      "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/8857611782031948608/+/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": "1611120161367786",
    "url": "https://ci.chromium.org/b/8857611782031948608",
    "utcnow_ts": "1611120161498999"
  }
}
[05:22:41.507] Task URL: https://ci.chromium.org/b/8857611782031948608
[05:22:41.507] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:2:0) after 1m0s
[05:23:41.515] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:2:0)
[05:23:41.515] Timer tick, asking Buildbucket for the build status
[05:23:41.607] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:23:41.607] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:3:0) after 1m0s
[05:24:41.619] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:3:0)
[05:24:41.619] Timer tick, asking Buildbucket for the build status
[05:24:41.697] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:24:41.697] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:4:0) after 1m0s
[05:25:41.781] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:4:0)
[05:25:41.781] Timer tick, asking Buildbucket for the build status
[05:25:41.859] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:25:41.859] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:5:0) after 1m0s
[05:26:42.048] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:5:0)
[05:26:42.048] Timer tick, asking Buildbucket for the build status
[05:26:42.136] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:26:42.136] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:6:0) after 1m0s
[05:27:42.186] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:6:0)
[05:27:42.186] Timer tick, asking Buildbucket for the build status
[05:27:42.450] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:27:42.450] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:7:0) after 1m0s
[05:28:42.624] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:7:0)
[05:28:42.624] Timer tick, asking Buildbucket for the build status
[05:28:42.854] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:28:42.854] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:8:0) after 1m0s
[05:29:42.883] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:8:0)
[05:29:42.883] Timer tick, asking Buildbucket for the build status
[05:29:42.952] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:29:42.952] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:9:0) after 1m0s
[05:30:43.006] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:9:0)
[05:30:43.006] Timer tick, asking Buildbucket for the build status
[05:30:43.088] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:30:43.088] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:10:0) after 1m0s
[05:31:43.204] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:10:0)
[05:31:43.204] Timer tick, asking Buildbucket for the build status
[05:31:43.271] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:31:43.271] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:11:0) after 1m0s
[05:32:43.315] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:11:0)
[05:32:43.315] Timer tick, asking Buildbucket for the build status
[05:32:43.427] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:32:43.427] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:12:0) after 1m0s
[05:33:43.465] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:12:0)
[05:33:43.465] Timer tick, asking Buildbucket for the build status
[05:33:43.654] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:33:43.654] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:13:0) after 1m0s
[05:34:43.666] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:13:0)
[05:34:43.666] Timer tick, asking Buildbucket for the build status
[05:34:43.766] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:34:43.766] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:14:0) after 1m0s
[05:35:43.825] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:14:0)
[05:35:43.825] Timer tick, asking Buildbucket for the build status
[05:35:43.911] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:35:43.911] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:15:0) after 1m0s
[05:36:43.990] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:15:0)
[05:36:43.990] Timer tick, asking Buildbucket for the build status
[05:36:44.057] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:36:44.057] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:16:0) after 1m0s
[05:37:44.078] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:16:0)
[05:37:44.078] Timer tick, asking Buildbucket for the build status
[05:37:44.183] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:37:44.183] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:17:0) after 1m0s
[05:38:44.209] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:17:0)
[05:38:44.209] Timer tick, asking Buildbucket for the build status
[05:38:44.281] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:38:44.281] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:18:0) after 1m0s
[05:39:44.306] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:18:0)
[05:39:44.306] Timer tick, asking Buildbucket for the build status
[05:39:44.497] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:39:44.497] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:19:0) after 1m0s
[05:40:44.541] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:19:0)
[05:40:44.541] Timer tick, asking Buildbucket for the build status
[05:40:44.615] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:40:44.615] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:20:0) after 1m0s
[05:41:44.635] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:20:0)
[05:41:44.635] Timer tick, asking Buildbucket for the build status
[05:41:44.714] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:41:44.714] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:21:0) after 1m0s
[05:42:44.780] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:21:0)
[05:42:44.780] Timer tick, asking Buildbucket for the build status
[05:42:44.874] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:42:44.874] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:22:0) after 1m0s
[05:43:44.900] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:22:0)
[05:43:44.900] Timer tick, asking Buildbucket for the build status
[05:43:44.966] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:43:44.966] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:23:0) after 1m0s
[05:44:45.049] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:23:0)
[05:44:45.049] Timer tick, asking Buildbucket for the build status
[05:44:45.224] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:44:45.224] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:24:0) after 1m0s
[05:45:45.341] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:24:0)
[05:45:45.341] Timer tick, asking Buildbucket for the build status
[05:45:45.665] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:45:45.665] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:25:0) after 1m0s
[05:46:45.689] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:25:0)
[05:46:45.689] Timer tick, asking Buildbucket for the build status
[05:46:45.764] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:46:45.764] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:26:0) after 1m0s
[05:47:45.851] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:26:0)
[05:47:45.851] Timer tick, asking Buildbucket for the build status
[05:47:45.958] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:47:45.958] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:27:0) after 1m0s
[05:48:45.977] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:27:0)
[05:48:45.977] Timer tick, asking Buildbucket for the build status
[05:48:46.189] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:48:46.189] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:28:0) after 1m0s
[05:49:46.239] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:28:0)
[05:49:46.239] Timer tick, asking Buildbucket for the build status
[05:49:46.581] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:49:46.581] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:29:0) after 1m0s
[05:50:46.610] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:29:0)
[05:50:46.610] Timer tick, asking Buildbucket for the build status
[05:50:46.750] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:50:46.750] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:30:0) after 1m0s
[05:51:46.870] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:30:0)
[05:51:46.870] Timer tick, asking Buildbucket for the build status
[05:51:47.144] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:51:47.144] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:31:0) after 1m0s
[05:52:47.301] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:31:0)
[05:52:47.301] Timer tick, asking Buildbucket for the build status
[05:52:47.404] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:52:47.404] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:32:0) after 1m0s
[05:53:47.485] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:32:0)
[05:53:47.485] Timer tick, asking Buildbucket for the build status
[05:53:47.569] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:53:47.569] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:33:0) after 1m0s
[05:54:47.635] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:33:0)
[05:54:47.635] Timer tick, asking Buildbucket for the build status
[05:54:47.724] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:54:47.724] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:34:0) after 1m0s
[05:55:47.747] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:34:0)
[05:55:47.747] Timer tick, asking Buildbucket for the build status
[05:55:47.925] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:55:47.925] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:35:0) after 1m0s
[05:56:48.011] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:35:0)
[05:56:48.011] Timer tick, asking Buildbucket for the build status
[05:56:48.122] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:56:48.122] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:36:0) after 1m0s
[05:57:48.125] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:36:0)
[05:57:48.125] Timer tick, asking Buildbucket for the build status
[05:57:48.584] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:57:48.584] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:37:0) after 1m0s
[05:58:48.635] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:37:0)
[05:58:48.635] Timer tick, asking Buildbucket for the build status
[05:58:48.887] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:58:48.887] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:38:0) after 1m0s
[05:59:48.907] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:38:0)
[05:59:48.907] Timer tick, asking Buildbucket for the build status
[05:59:49.020] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:59:49.020] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:39:0) after 1m0s
[06:00:49.047] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:39:0)
[06:00:49.047] Timer tick, asking Buildbucket for the build status
[06:00:50.356] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:00:50.356] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:40:0) after 1m0s
[06:01:50.362] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:40:0)
[06:01:50.363] Timer tick, asking Buildbucket for the build status
[06:01:50.439] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:01:50.439] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:41:0) after 1m0s
[06:02:50.457] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:41:0)
[06:02:50.457] Timer tick, asking Buildbucket for the build status
[06:02:50.719] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:02:50.719] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:42:0) after 1m0s
[06:03:50.830] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:42:0)
[06:03:50.830] Timer tick, asking Buildbucket for the build status
[06:03:50.928] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:03:50.928] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:43:0) after 1m0s
[06:04:50.971] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:43:0)
[06:04:50.971] Timer tick, asking Buildbucket for the build status
[06:04:51.049] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:04:51.049] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:44:0) after 1m0s
[06:05:51.062] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:44:0)
[06:05:51.062] Timer tick, asking Buildbucket for the build status
[06:05:51.160] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:05:51.160] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:45:0) after 1m0s
[06:06:51.195] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:45:0)
[06:06:51.195] Timer tick, asking Buildbucket for the build status
[06:06:51.285] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:06:51.285] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:46:0) after 1m0s
[06:07:51.309] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:46:0)
[06:07:51.309] Timer tick, asking Buildbucket for the build status
[06:07:51.405] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:07:51.405] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:47:0) after 1m0s
[06:08:51.431] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:47:0)
[06:08:51.431] Timer tick, asking Buildbucket for the build status
[06:08:51.679] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:08:51.679] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:48:0) after 1m0s
[06:09:51.693] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:48:0)
[06:09:51.693] Timer tick, asking Buildbucket for the build status
[06:09:51.931] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:09:51.931] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:49:0) after 1m0s
[06:10:52.242] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:49:0)
[06:10:52.242] Timer tick, asking Buildbucket for the build status
[06:10:52.313] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:10:52.313] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:50:0) after 1m0s
[06:11:52.491] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:50:0)
[06:11:52.491] Timer tick, asking Buildbucket for the build status
[06:11:52.564] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:11:52.564] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:51:0) after 1m0s
[06:12:52.712] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:51:0)
[06:12:52.712] Timer tick, asking Buildbucket for the build status
[06:12:52.804] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:12:52.804] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:52:0) after 1m0s
[06:13:52.918] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:52:0)
[06:13:52.918] Timer tick, asking Buildbucket for the build status
[06:13:53.148] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:13:53.148] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:53:0) after 1m0s
[06:14:53.171] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:53:0)
[06:14:53.171] Timer tick, asking Buildbucket for the build status
[06:14:53.358] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:14:53.358] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:54:0) after 1m0s
[06:15:53.408] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:54:0)
[06:15:53.408] Timer tick, asking Buildbucket for the build status
[06:15:53.475] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:15:53.475] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:55:0) after 1m0s
[06:16:53.506] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:55:0)
[06:16:53.506] Timer tick, asking Buildbucket for the build status
[06:16:53.713] Build 8857611782031948608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:16:53.713] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:56:0) after 1m0s
[06:17:26.078] Received PubSub notification, asking Buildbucket for the build status
[06:17:26.144] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:53.772] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:56:0)
[06:17:53.772] Timer tick, asking Buildbucket for the build status
[06:17:54.054] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:54.054] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:58:0) after 1m0s
[06:18:54.121] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:58:0)
[06:18:54.121] Timer tick, asking Buildbucket for the build status
[06:18:54.194] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:54.194] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:59:0) after 1m0s
[06:19:54.250] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:59:0)
[06:19:54.250] Timer tick, asking Buildbucket for the build status
[06:19:54.325] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:54.325] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:60:0) after 1m0s
[06:20:54.426] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:60:0)
[06:20:54.426] Timer tick, asking Buildbucket for the build status
[06:20:54.646] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:54.646] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:61:0) after 1m0s
[06:21:54.693] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:61:0)
[06:21:54.693] Timer tick, asking Buildbucket for the build status
[06:21:54.776] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:54.776] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:62:0) after 1m0s
[06:22:54.845] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:62:0)
[06:22:54.845] Timer tick, asking Buildbucket for the build status
[06:22:54.976] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:54.976] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:63:0) after 1m0s
[06:23:55.022] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:63:0)
[06:23:55.022] Timer tick, asking Buildbucket for the build status
[06:23:55.099] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:55.099] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:64:0) after 1m0s
[06:24:55.123] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:64:0)
[06:24:55.123] Timer tick, asking Buildbucket for the build status
[06:24:55.504] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:55.504] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:65:0) after 1m0s
[06:25:55.550] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:65:0)
[06:25:55.550] Timer tick, asking Buildbucket for the build status
[06:25:55.664] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:55.664] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:66:0) after 1m0s
[06:26:55.728] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:66:0)
[06:26:55.728] Timer tick, asking Buildbucket for the build status
[06:26:55.790] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:55.790] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:67:0) after 1m0s
[06:27:55.837] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:67:0)
[06:27:55.837] Timer tick, asking Buildbucket for the build status
[06:27:56.020] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:56.020] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:68:0) after 1m0s
[06:28:56.123] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:68:0)
[06:28:56.123] Timer tick, asking Buildbucket for the build status
[06:28:56.173] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:56.173] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:69:0) after 1m0s
[06:29:56.274] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:69:0)
[06:29:56.274] Timer tick, asking Buildbucket for the build status
[06:29:56.336] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:56.336] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:70:0) after 1m0s
[06:30:57.032] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:70:0)
[06:30:57.032] Timer tick, asking Buildbucket for the build status
[06:30:57.550] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:57.550] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:71:0) after 1m0s
[06:31:57.677] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:71:0)
[06:31:57.677] Timer tick, asking Buildbucket for the build status
[06:31:57.734] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:57.734] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:72:0) after 1m0s
[06:32:58.114] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:72:0)
[06:32:58.114] Timer tick, asking Buildbucket for the build status
[06:32:58.241] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:58.241] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:73:0) after 1m0s
[06:33:58.384] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:73:0)
[06:33:58.384] Timer tick, asking Buildbucket for the build status
[06:33:58.522] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:58.522] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:74:0) after 1m0s
[06:34:58.635] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:74:0)
[06:34:58.635] Timer tick, asking Buildbucket for the build status
[06:34:58.811] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:58.811] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:75:0) after 1m0s
[06:35:59.039] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:75:0)
[06:35:59.039] Timer tick, asking Buildbucket for the build status
[06:35:59.158] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:59.158] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:76:0) after 1m0s
[06:36:59.213] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:76:0)
[06:36:59.213] Timer tick, asking Buildbucket for the build status
[06:36:59.535] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:59.535] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:77:0) after 1m0s
[06:37:59.674] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:77:0)
[06:37:59.674] Timer tick, asking Buildbucket for the build status
[06:38:01.237] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:01.237] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:78:0) after 1m0s
[06:39:02.324] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:78:0)
[06:39:02.324] Timer tick, asking Buildbucket for the build status
[06:39:02.391] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:02.391] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:79:0) after 1m0s
[06:40:02.498] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:79:0)
[06:40:02.498] Timer tick, asking Buildbucket for the build status
[06:40:02.715] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:02.715] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:80:0) after 1m0s
[06:41:02.752] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:80:0)
[06:41:02.752] Timer tick, asking Buildbucket for the build status
[06:41:02.812] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:02.812] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:81:0) after 1m0s
[06:42:02.879] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:81:0)
[06:42:02.879] Timer tick, asking Buildbucket for the build status
[06:42:03.133] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:03.133] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:82:0) after 1m0s
[06:43:03.159] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:82:0)
[06:43:03.159] Timer tick, asking Buildbucket for the build status
[06:43:03.728] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:03.728] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:83:0) after 1m0s
[06:44:03.776] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:83:0)
[06:44:03.776] Timer tick, asking Buildbucket for the build status
[06:44:03.866] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:03.866] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:84:0) after 1m0s
[06:45:03.973] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:84:0)
[06:45:03.973] Timer tick, asking Buildbucket for the build status
[06:45:04.044] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:04.044] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:85:0) after 1m0s
[06:46:04.060] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:85:0)
[06:46:04.060] Timer tick, asking Buildbucket for the build status
[06:46:05.635] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:05.635] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:86:0) after 1m0s
[06:47:05.718] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:86:0)
[06:47:05.718] Timer tick, asking Buildbucket for the build status
[06:47:06.254] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:06.254] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:87:0) after 1m0s
[06:48:06.292] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:87:0)
[06:48:06.292] Timer tick, asking Buildbucket for the build status
[06:48:06.480] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:06.480] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:88:0) after 1m0s
[06:49:06.511] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:88:0)
[06:49:06.511] Timer tick, asking Buildbucket for the build status
[06:49:06.611] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:06.611] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:89:0) after 1m0s
[06:50:06.654] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:89:0)
[06:50:06.654] Timer tick, asking Buildbucket for the build status
[06:50:06.806] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:06.806] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:90:0) after 1m0s
[06:51:06.886] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:90:0)
[06:51:06.886] Timer tick, asking Buildbucket for the build status
[06:51:06.947] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:06.947] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:91:0) after 1m0s
[06:52:06.985] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:91:0)
[06:52:06.985] Timer tick, asking Buildbucket for the build status
[06:52:07.046] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:07.046] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:92:0) after 1m0s
[06:53:07.092] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:92:0)
[06:53:07.092] Timer tick, asking Buildbucket for the build status
[06:53:07.202] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:07.202] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:93:0) after 1m0s
[06:54:07.377] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:93:0)
[06:54:07.377] Timer tick, asking Buildbucket for the build status
[06:54:07.441] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:07.441] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:94:0) after 1m0s
[06:55:07.494] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:94:0)
[06:55:07.494] Timer tick, asking Buildbucket for the build status
[06:55:07.555] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:07.555] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:95:0) after 1m0s
[06:56:07.636] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:95:0)
[06:56:07.636] Timer tick, asking Buildbucket for the build status
[06:56:07.925] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:07.925] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:96:0) after 1m0s
[06:57:07.974] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:96:0)
[06:57:07.974] Timer tick, asking Buildbucket for the build status
[06:57:08.079] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:08.079] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:97:0) after 1m0s
[06:58:08.104] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:97:0)
[06:58:08.104] Timer tick, asking Buildbucket for the build status
[06:58:08.217] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:08.217] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:98:0) after 1m0s
[06:59:08.251] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:98:0)
[06:59:08.251] Timer tick, asking Buildbucket for the build status
[06:59:08.404] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:08.404] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:99:0) after 1m0s
[07:00:08.427] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:99:0)
[07:00:08.427] Timer tick, asking Buildbucket for the build status
[07:00:08.508] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:08.508] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:100:0) after 1m0s
[07:01:08.560] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:100:0)
[07:01:08.561] Timer tick, asking Buildbucket for the build status
[07:01:08.632] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:08.632] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:101:0) after 1m0s
[07:02:08.656] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:101:0)
[07:02:08.656] Timer tick, asking Buildbucket for the build status
[07:02:08.716] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:08.716] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:102:0) after 1m0s
[07:03:08.744] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:102:0)
[07:03:08.744] Timer tick, asking Buildbucket for the build status
[07:03:08.854] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:08.854] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:103:0) after 1m0s
[07:04:08.892] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:103:0)
[07:04:08.892] Timer tick, asking Buildbucket for the build status
[07:04:08.976] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:08.976] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:104:0) after 1m0s
[07:05:09.033] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:104:0)
[07:05:09.033] Timer tick, asking Buildbucket for the build status
[07:05:09.097] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:09.097] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:105:0) after 1m0s
[07:06:09.133] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:105:0)
[07:06:09.133] Timer tick, asking Buildbucket for the build status
[07:06:09.193] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:09.193] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:106:0) after 1m0s
[07:07:09.242] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:106:0)
[07:07:09.242] Timer tick, asking Buildbucket for the build status
[07:07:09.457] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:09.457] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:107:0) after 1m0s
[07:08:09.464] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:107:0)
[07:08:09.464] Timer tick, asking Buildbucket for the build status
[07:08:09.664] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:09.664] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:108:0) after 1m0s
[07:09:09.685] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:108:0)
[07:09:09.685] Timer tick, asking Buildbucket for the build status
[07:09:09.783] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:09.783] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:109:0) after 1m0s
[07:10:09.794] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:109:0)
[07:10:09.794] Timer tick, asking Buildbucket for the build status
[07:10:09.866] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:09.866] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:110:0) after 1m0s
[07:11:09.851] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:110:0)
[07:11:09.851] Timer tick, asking Buildbucket for the build status
[07:11:09.919] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:09.919] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:111:0) after 1m0s
[07:12:09.900] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:111:0)
[07:12:09.900] Timer tick, asking Buildbucket for the build status
[07:12:09.963] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:09.963] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:112:0) after 1m0s
[07:13:09.989] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:112:0)
[07:13:09.989] Timer tick, asking Buildbucket for the build status
[07:13:10.190] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:10.190] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:113:0) after 1m0s
[07:14:10.242] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:113:0)
[07:14:10.242] Timer tick, asking Buildbucket for the build status
[07:14:10.452] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:10.452] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:114:0) after 1m0s
[07:15:10.472] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:114:0)
[07:15:10.472] Timer tick, asking Buildbucket for the build status
[07:15:10.545] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:10.545] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:115:0) after 1m0s
[07:16:10.633] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:115:0)
[07:16:10.633] Timer tick, asking Buildbucket for the build status
[07:16:10.802] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:10.802] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:116:0) after 1m0s
[07:17:10.847] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:116:0)
[07:17:10.847] Timer tick, asking Buildbucket for the build status
[07:17:10.907] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:10.907] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:117:0) after 1m0s
[07:18:10.981] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:117:0)
[07:18:10.981] Timer tick, asking Buildbucket for the build status
[07:18:11.215] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:11.215] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:118:0) after 1m0s
[07:19:11.287] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:118:0)
[07:19:11.287] Timer tick, asking Buildbucket for the build status
[07:19:11.375] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:11.375] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:119:0) after 1m0s
[07:20:11.395] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:119:0)
[07:20:11.395] Timer tick, asking Buildbucket for the build status
[07:20:11.653] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:11.653] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:120:0) after 1m0s
[07:21:11.677] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:120:0)
[07:21:11.677] Timer tick, asking Buildbucket for the build status
[07:21:11.975] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:11.975] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:121:0) after 1m0s
[07:22:12.023] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:121:0)
[07:22:12.023] Timer tick, asking Buildbucket for the build status
[07:22:12.119] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:12.119] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:122:0) after 1m0s
[07:23:12.146] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:122:0)
[07:23:12.146] Timer tick, asking Buildbucket for the build status
[07:23:12.271] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:12.271] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:123:0) after 1m0s
[07:24:12.292] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:123:0)
[07:24:12.292] Timer tick, asking Buildbucket for the build status
[07:24:12.352] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:12.352] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:124:0) after 1m0s
[07:25:12.536] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:124:0)
[07:25:12.536] Timer tick, asking Buildbucket for the build status
[07:25:12.678] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:12.678] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:125:0) after 1m0s
[07:26:16.315] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:125:0)
[07:26:16.315] Timer tick, asking Buildbucket for the build status
[07:26:16.372] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:16.372] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:126:0) after 1m0s
[07:27:16.417] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:126:0)
[07:27:16.417] Timer tick, asking Buildbucket for the build status
[07:27:16.534] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:16.534] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:127:0) after 1m0s
[07:28:16.559] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:127:0)
[07:28:16.559] Timer tick, asking Buildbucket for the build status
[07:28:16.669] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:16.670] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:128:0) after 1m0s
[07:29:16.696] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:128:0)
[07:29:16.696] Timer tick, asking Buildbucket for the build status
[07:29:16.762] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:16.762] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:129:0) after 1m0s
[07:30:16.798] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:129:0)
[07:30:16.798] Timer tick, asking Buildbucket for the build status
[07:30:16.958] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:16.959] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:130:0) after 1m0s
[07:31:17.007] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:130:0)
[07:31:17.007] Timer tick, asking Buildbucket for the build status
[07:31:17.201] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:17.201] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:131:0) after 1m0s
[07:32:17.233] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:131:0)
[07:32:17.233] Timer tick, asking Buildbucket for the build status
[07:32:17.470] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:17.470] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:132:0) after 1m0s
[07:33:17.489] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:132:0)
[07:33:17.489] Timer tick, asking Buildbucket for the build status
[07:33:17.678] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:17.678] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:133:0) after 1m0s
[07:34:17.676] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:133:0)
[07:34:17.676] Timer tick, asking Buildbucket for the build status
[07:34:18.781] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:18.781] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:134:0) after 1m0s
[07:35:18.815] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:134:0)
[07:35:18.815] Timer tick, asking Buildbucket for the build status
[07:35:18.873] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:18.873] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:135:0) after 1m0s
[07:36:19.020] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:135:0)
[07:36:19.020] Timer tick, asking Buildbucket for the build status
[07:36:19.131] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:19.131] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:136:0) after 1m0s
[07:37:19.261] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:136:0)
[07:37:19.261] Timer tick, asking Buildbucket for the build status
[07:37:19.339] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:19.339] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:137:0) after 1m0s
[07:38:19.400] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:137:0)
[07:38:19.400] Timer tick, asking Buildbucket for the build status
[07:38:19.501] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:19.501] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:138:0) after 1m0s
[07:39:19.563] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:138:0)
[07:39:19.563] Timer tick, asking Buildbucket for the build status
[07:39:19.664] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:19.664] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:139:0) after 1m0s
[07:40:19.669] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:139:0)
[07:40:19.669] Timer tick, asking Buildbucket for the build status
[07:40:19.725] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:19.725] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:140:0) after 1m0s
[07:41:19.750] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:140:0)
[07:41:19.750] Timer tick, asking Buildbucket for the build status
[07:41:19.812] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:19.812] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:141:0) after 1m0s
[07:42:19.915] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:141:0)
[07:42:19.915] Timer tick, asking Buildbucket for the build status
[07:42:19.989] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:19.989] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:142:0) after 1m0s
[07:43:20.063] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:142:0)
[07:43:20.063] Timer tick, asking Buildbucket for the build status
[07:43:20.601] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:20.601] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:143:0) after 1m0s
[07:44:20.668] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:143:0)
[07:44:20.668] Timer tick, asking Buildbucket for the build status
[07:44:20.754] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:20.754] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:144:0) after 1m0s
[07:45:20.820] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:144:0)
[07:45:20.820] Timer tick, asking Buildbucket for the build status
[07:45:21.771] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:21.771] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:145:0) after 1m0s
[07:46:21.797] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:145:0)
[07:46:21.797] Timer tick, asking Buildbucket for the build status
[07:46:21.853] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:21.853] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:146:0) after 1m0s
[07:47:21.944] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:146:0)
[07:47:21.944] Timer tick, asking Buildbucket for the build status
[07:47:22.017] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:22.017] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:147:0) after 1m0s
[07:48:22.161] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:147:0)
[07:48:22.161] Timer tick, asking Buildbucket for the build status
[07:48:23.424] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:23.424] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:148:0) after 1m0s
[07:49:23.487] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:148:0)
[07:49:23.487] Timer tick, asking Buildbucket for the build status
[07:49:24.331] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:24.331] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:149:0) after 1m0s
[07:50:24.387] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:149:0)
[07:50:24.387] Timer tick, asking Buildbucket for the build status
[07:50:24.458] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:24.458] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:150:0) after 1m0s
[07:51:24.523] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:150:0)
[07:51:24.523] Timer tick, asking Buildbucket for the build status
[07:51:24.720] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:24.720] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:151:0) after 1m0s
[07:52:24.744] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:151:0)
[07:52:24.744] Timer tick, asking Buildbucket for the build status
[07:52:24.926] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:24.926] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:152:0) after 1m0s
[07:53:24.957] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:152:0)
[07:53:24.957] Timer tick, asking Buildbucket for the build status
[07:53:25.173] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:25.173] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:153:0) after 1m0s
[07:54:25.257] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:153:0)
[07:54:25.257] Timer tick, asking Buildbucket for the build status
[07:54:25.321] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:25.321] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:154:0) after 1m0s
[07:55:25.404] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:154:0)
[07:55:25.404] Timer tick, asking Buildbucket for the build status
[07:55:25.700] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:25.700] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:155:0) after 1m0s
[07:56:25.800] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:155:0)
[07:56:25.800] Timer tick, asking Buildbucket for the build status
[07:56:25.858] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:25.858] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:156:0) after 1m0s
[07:57:26.026] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:156:0)
[07:57:26.026] Timer tick, asking Buildbucket for the build status
[07:57:26.454] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:26.454] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:157:0) after 1m0s
[07:58:26.561] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:157:0)
[07:58:26.561] Timer tick, asking Buildbucket for the build status
[07:58:26.662] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:26.662] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:158:0) after 1m0s
[07:59:26.702] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:158:0)
[07:59:26.702] Timer tick, asking Buildbucket for the build status
[07:59:26.766] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:26.766] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:159:0) after 1m0s
[08:00:26.997] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:159:0)
[08:00:26.997] Timer tick, asking Buildbucket for the build status
[08:00:27.067] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:27.067] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:160:0) after 1m0s
[08:01:27.209] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:160:0)
[08:01:27.209] Timer tick, asking Buildbucket for the build status
[08:01:27.403] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:27.403] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:161:0) after 1m0s
[08:02:27.415] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:161:0)
[08:02:27.415] Timer tick, asking Buildbucket for the build status
[08:02:27.471] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:27.471] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:162:0) after 1m0s
[08:03:27.525] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:162:0)
[08:03:27.525] Timer tick, asking Buildbucket for the build status
[08:03:27.628] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:27.628] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:163:0) after 1m0s
[08:04:27.662] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:163:0)
[08:04:27.662] Timer tick, asking Buildbucket for the build status
[08:04:27.797] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:27.797] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:164:0) after 1m0s
[08:05:27.891] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:164:0)
[08:05:27.891] Timer tick, asking Buildbucket for the build status
[08:05:28.155] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:28.155] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:165:0) after 1m0s
[08:06:28.190] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:165:0)
[08:06:28.190] Timer tick, asking Buildbucket for the build status
[08:06:28.256] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:28.256] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:166:0) after 1m0s
[08:07:28.392] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:166:0)
[08:07:28.392] Timer tick, asking Buildbucket for the build status
[08:07:28.595] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:28.595] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:167:0) after 1m0s
[08:08:28.805] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:167:0)
[08:08:28.805] Timer tick, asking Buildbucket for the build status
[08:08:28.940] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:28.940] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:168:0) after 1m0s
[08:09:28.992] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:168:0)
[08:09:28.992] Timer tick, asking Buildbucket for the build status
[08:09:29.141] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:29.141] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:169:0) after 1m0s
[08:10:29.202] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:169:0)
[08:10:29.202] Timer tick, asking Buildbucket for the build status
[08:10:29.288] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:29.288] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:170:0) after 1m0s
[08:11:29.307] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:170:0)
[08:11:29.307] Timer tick, asking Buildbucket for the build status
[08:11:29.436] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:29.437] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:171:0) after 1m0s
[08:12:29.619] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:171:0)
[08:12:29.619] Timer tick, asking Buildbucket for the build status
[08:12:29.882] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:29.882] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:172:0) after 1m0s
[08:13:29.918] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:172:0)
[08:13:29.918] Timer tick, asking Buildbucket for the build status
[08:13:30.027] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:30.028] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:173:0) after 1m0s
[08:14:30.009] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:173:0)
[08:14:30.009] Timer tick, asking Buildbucket for the build status
[08:14:30.069] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:30.069] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:174:0) after 1m0s
[08:15:30.293] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:174:0)
[08:15:30.293] Timer tick, asking Buildbucket for the build status
[08:15:30.348] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:30.348] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:175:0) after 1m0s
[08:16:30.534] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:175:0)
[08:16:30.534] Timer tick, asking Buildbucket for the build status
[08:16:30.595] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:30.595] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:176:0) after 1m0s
[08:17:30.712] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:176:0)
[08:17:30.712] Timer tick, asking Buildbucket for the build status
[08:17:30.767] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:30.767] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:177:0) after 1m0s
[08:18:30.833] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:177:0)
[08:18:30.833] Timer tick, asking Buildbucket for the build status
[08:18:30.934] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:30.934] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:178:0) after 1m0s
[08:19:30.996] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:178:0)
[08:19:30.996] Timer tick, asking Buildbucket for the build status
[08:19:31.115] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:31.115] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:179:0) after 1m0s
[08:20:31.176] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:179:0)
[08:20:31.176] Timer tick, asking Buildbucket for the build status
[08:20:31.243] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:31.243] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:180:0) after 1m0s
[08:21:31.280] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:180:0)
[08:21:31.280] Timer tick, asking Buildbucket for the build status
[08:21:31.367] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:31.367] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:181:0) after 1m0s
[08:22:31.380] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:181:0)
[08:22:31.380] Timer tick, asking Buildbucket for the build status
[08:22:31.460] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:31.460] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:182:0) after 1m0s
[08:23:31.483] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:182:0)
[08:23:31.483] Timer tick, asking Buildbucket for the build status
[08:23:31.650] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:31.650] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:183:0) after 1m0s
[08:24:31.678] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:183:0)
[08:24:31.678] Timer tick, asking Buildbucket for the build status
[08:24:31.771] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:31.771] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:184:0) after 1m0s
[08:25:31.800] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:184:0)
[08:25:31.800] Timer tick, asking Buildbucket for the build status
[08:25:31.887] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:31.887] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:185:0) after 1m0s
[08:26:31.911] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:185:0)
[08:26:31.911] Timer tick, asking Buildbucket for the build status
[08:26:31.974] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:31.974] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:186:0) after 1m0s
[08:27:32.001] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:186:0)
[08:27:32.002] Timer tick, asking Buildbucket for the build status
[08:27:32.778] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:32.778] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:187:0) after 1m0s
[08:28:32.804] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:187:0)
[08:28:32.804] Timer tick, asking Buildbucket for the build status
[08:28:32.948] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:32.948] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:188:0) after 1m0s
[08:29:32.935] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:188:0)
[08:29:32.935] Timer tick, asking Buildbucket for the build status
[08:29:33.109] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:33.109] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:189:0) after 1m0s
[08:30:33.138] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:189:0)
[08:30:33.138] Timer tick, asking Buildbucket for the build status
[08:30:33.200] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:33.200] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:190:0) after 1m0s
[08:31:33.243] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:190:0)
[08:31:33.243] Timer tick, asking Buildbucket for the build status
[08:31:33.317] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:33.317] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:191:0) after 1m0s
[08:32:33.441] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:191:0)
[08:32:33.441] Timer tick, asking Buildbucket for the build status
[08:32:33.649] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:33.649] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:192:0) after 1m0s
[08:33:33.694] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:192:0)
[08:33:33.694] Timer tick, asking Buildbucket for the build status
[08:33:34.277] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:34.277] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:193:0) after 1m0s
[08:34:34.335] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:193:0)
[08:34:34.335] Timer tick, asking Buildbucket for the build status
[08:34:34.512] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:34.512] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:194:0) after 1m0s
[08:35:34.624] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:194:0)
[08:35:34.624] Timer tick, asking Buildbucket for the build status
[08:35:34.685] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:34.685] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:195:0) after 1m0s
[08:36:34.705] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:195:0)
[08:36:34.705] Timer tick, asking Buildbucket for the build status
[08:36:34.768] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:34.768] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:196:0) after 1m0s
[08:37:34.821] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:196:0)
[08:37:34.821] Timer tick, asking Buildbucket for the build status
[08:37:35.084] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:35.084] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:197:0) after 1m0s
[08:38:35.125] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:197:0)
[08:38:35.125] Timer tick, asking Buildbucket for the build status
[08:38:35.223] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:35.223] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:198:0) after 1m0s
[08:39:35.287] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:198:0)
[08:39:35.287] Timer tick, asking Buildbucket for the build status
[08:39:35.356] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:35.356] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:199:0) after 1m0s
[08:40:35.444] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:199:0)
[08:40:35.444] Timer tick, asking Buildbucket for the build status
[08:40:35.617] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:35.617] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:200:0) after 1m0s
[08:41:35.623] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:200:0)
[08:41:35.623] Timer tick, asking Buildbucket for the build status
[08:41:35.798] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:35.798] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:201:0) after 1m0s
[08:42:36.811] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:201:0)
[08:42:36.811] Timer tick, asking Buildbucket for the build status
[08:42:36.883] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:36.883] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:202:0) after 1m0s
[08:43:37.087] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:202:0)
[08:43:37.087] Timer tick, asking Buildbucket for the build status
[08:43:37.460] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:37.460] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:203:0) after 1m0s
[08:44:37.601] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:203:0)
[08:44:37.601] Timer tick, asking Buildbucket for the build status
[08:44:37.658] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:37.658] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:204:0) after 1m0s
[08:45:37.884] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:204:0)
[08:45:37.884] Timer tick, asking Buildbucket for the build status
[08:45:37.939] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:37.939] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:205:0) after 1m0s
[08:46:38.152] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:205:0)
[08:46:38.152] Timer tick, asking Buildbucket for the build status
[08:46:38.323] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:38.323] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:206:0) after 1m0s
[08:47:38.354] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:206:0)
[08:47:38.354] Timer tick, asking Buildbucket for the build status
[08:47:38.409] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:38.409] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:207:0) after 1m0s
[08:48:38.565] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:207:0)
[08:48:38.565] Timer tick, asking Buildbucket for the build status
[08:48:38.660] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:38.660] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:208:0) after 1m0s
[08:49:38.775] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:208:0)
[08:49:38.775] Timer tick, asking Buildbucket for the build status
[08:49:38.897] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:38.897] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:209:0) after 1m0s
[08:50:39.065] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:209:0)
[08:50:39.065] Timer tick, asking Buildbucket for the build status
[08:50:39.143] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:39.143] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:210:0) after 1m0s
[08:51:39.861] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:210:0)
[08:51:39.861] Timer tick, asking Buildbucket for the build status
[08:51:39.921] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:39.921] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:211:0) after 1m0s
[08:52:39.970] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:211:0)
[08:52:39.970] Timer tick, asking Buildbucket for the build status
[08:52:40.055] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:40.055] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:212:0) after 1m0s
[08:53:40.187] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:212:0)
[08:53:40.187] Timer tick, asking Buildbucket for the build status
[08:53:40.381] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:40.381] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:213:0) after 1m0s
[08:54:40.430] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:213:0)
[08:54:40.430] Timer tick, asking Buildbucket for the build status
[08:54:40.902] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:40.902] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:214:0) after 1m0s
[08:55:40.935] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:214:0)
[08:55:40.936] Timer tick, asking Buildbucket for the build status
[08:55:41.000] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:41.001] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:215:0) after 1m0s
[08:56:41.066] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:215:0)
[08:56:41.066] Timer tick, asking Buildbucket for the build status
[08:56:41.154] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:41.154] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:216:0) after 1m0s
[08:57:41.181] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:216:0)
[08:57:41.181] Timer tick, asking Buildbucket for the build status
[08:57:41.500] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:41.500] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:217:0) after 1m0s
[08:58:41.642] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:217:0)
[08:58:41.642] Timer tick, asking Buildbucket for the build status
[08:58:41.983] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:41.984] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:218:0) after 1m0s
[08:59:42.018] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:218:0)
[08:59:42.018] Timer tick, asking Buildbucket for the build status
[08:59:42.075] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:42.075] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:219:0) after 1m0s
[09:00:42.168] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:219:0)
[09:00:42.168] Timer tick, asking Buildbucket for the build status
[09:00:42.454] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:42.454] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:220:0) after 1m0s
[09:01:42.516] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:220:0)
[09:01:42.516] Timer tick, asking Buildbucket for the build status
[09:01:42.580] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:42.580] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:221:0) after 1m0s
[09:02:42.643] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:221:0)
[09:02:42.643] Timer tick, asking Buildbucket for the build status
[09:02:42.810] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:42.810] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:222:0) after 1m0s
[09:03:42.929] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:222:0)
[09:03:42.929] Timer tick, asking Buildbucket for the build status
[09:03:43.024] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:43.024] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:223:0) after 1m0s
[09:04:43.121] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:223:0)
[09:04:43.121] Timer tick, asking Buildbucket for the build status
[09:04:43.398] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:43.398] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:224:0) after 1m0s
[09:05:43.461] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:224:0)
[09:05:43.461] Timer tick, asking Buildbucket for the build status
[09:05:43.523] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:43.523] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:225:0) after 1m0s
[09:06:43.763] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:225:0)
[09:06:43.763] Timer tick, asking Buildbucket for the build status
[09:06:43.834] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:43.834] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:226:0) after 1m0s
[09:07:43.933] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:226:0)
[09:07:43.933] Timer tick, asking Buildbucket for the build status
[09:07:44.019] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:44.019] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:227:0) after 1m0s
[09:08:44.156] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:227:0)
[09:08:44.156] Timer tick, asking Buildbucket for the build status
[09:08:44.324] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:44.324] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:228:0) after 1m0s
[09:09:44.356] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:228:0)
[09:09:44.356] Timer tick, asking Buildbucket for the build status
[09:09:44.425] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:44.425] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:229:0) after 1m0s
[09:10:44.590] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:229:0)
[09:10:44.590] Timer tick, asking Buildbucket for the build status
[09:10:44.666] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:44.667] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:230:0) after 1m0s
[09:11:44.784] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:230:0)
[09:11:44.784] Timer tick, asking Buildbucket for the build status
[09:11:44.858] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:44.858] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:231:0) after 1m0s
[09:12:44.899] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:231:0)
[09:12:44.899] Timer tick, asking Buildbucket for the build status
[09:12:44.996] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:44.996] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:232:0) after 1m0s
[09:13:45.052] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:232:0)
[09:13:45.052] Timer tick, asking Buildbucket for the build status
[09:13:45.178] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:45.178] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:233:0) after 1m0s
[09:14:45.205] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:233:0)
[09:14:45.205] Timer tick, asking Buildbucket for the build status
[09:14:45.281] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:45.281] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:234:0) after 1m0s
[09:15:45.380] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:234:0)
[09:15:45.380] Timer tick, asking Buildbucket for the build status
[09:15:45.533] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:45.533] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:235:0) after 1m0s
[09:16:45.660] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:235:0)
[09:16:45.660] Timer tick, asking Buildbucket for the build status
[09:16:45.773] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:45.773] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:236:0) after 1m0s
[09:17:45.811] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:236:0)
[09:17:45.811] Timer tick, asking Buildbucket for the build status
[09:17:45.878] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:45.878] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:237:0) after 1m0s
[09:18:45.939] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:237:0)
[09:18:45.939] Timer tick, asking Buildbucket for the build status
[09:18:46.192] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:46.192] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:238:0) after 1m0s
[09:19:46.254] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:238:0)
[09:19:46.254] Timer tick, asking Buildbucket for the build status
[09:19:46.371] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:46.371] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:239:0) after 1m0s
[09:20:46.398] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:239:0)
[09:20:46.398] Timer tick, asking Buildbucket for the build status
[09:20:46.464] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:46.464] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:240:0) after 1m0s
[09:21:46.602] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:240:0)
[09:21:46.602] Timer tick, asking Buildbucket for the build status
[09:21:46.665] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:46.665] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:241:0) after 1m0s
[09:22:46.810] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:241:0)
[09:22:46.810] Timer tick, asking Buildbucket for the build status
[09:22:47.057] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:47.057] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:242:0) after 1m0s
[09:23:47.243] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:242:0)
[09:23:47.243] Timer tick, asking Buildbucket for the build status
[09:23:47.651] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:47.651] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:243:0) after 1m0s
[09:24:47.718] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:243:0)
[09:24:47.718] Timer tick, asking Buildbucket for the build status
[09:24:47.805] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:47.805] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:244:0) after 1m0s
[09:25:47.938] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:244:0)
[09:25:47.938] Timer tick, asking Buildbucket for the build status
[09:25:48.378] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:48.378] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:245:0) after 1m0s
[09:26:48.408] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:245:0)
[09:26:48.408] Timer tick, asking Buildbucket for the build status
[09:26:48.736] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:48.736] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:246:0) after 1m0s
[09:27:48.771] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:246:0)
[09:27:48.771] Timer tick, asking Buildbucket for the build status
[09:27:49.203] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:49.204] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:247:0) after 1m0s
[09:28:49.322] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:247:0)
[09:28:49.322] Timer tick, asking Buildbucket for the build status
[09:28:49.705] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:49.705] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:248:0) after 1m0s
[09:29:49.734] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:248:0)
[09:29:49.734] Timer tick, asking Buildbucket for the build status
[09:29:49.792] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:49.792] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:249:0) after 1m0s
[09:30:49.842] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:249:0)
[09:30:49.842] Timer tick, asking Buildbucket for the build status
[09:30:49.914] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:49.914] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:250:0) after 1m0s
[09:31:49.981] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:250:0)
[09:31:49.981] Timer tick, asking Buildbucket for the build status
[09:31:50.050] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:50.050] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:251:0) after 1m0s
[09:32:50.103] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:251:0)
[09:32:50.103] Timer tick, asking Buildbucket for the build status
[09:32:50.183] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:50.183] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:252:0) after 1m0s
[09:33:50.278] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:252:0)
[09:33:50.278] Timer tick, asking Buildbucket for the build status
[09:33:50.488] Build 8857611782031948608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:50.488] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023041844273424016:253:0) after 1m0s
[09:34:48.958] Received PubSub notification, asking Buildbucket for the build status
[09:34:49.094] Build 8857611782031948608: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:34:49.094] Buildbucket build:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary": true,
    "canary_preference": "CANARY",
    "completed_ts": "1611135288409275",
    "created_by": "project:chromium",
    "created_ts": "1611120160986044",
    "id": "8857611782031948608",
    "parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2d2177301ae88d98d0b8c76cc117bc816c873d9c\"}}",
    "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\": \"2d2177301ae88d98d0b8c76cc117bc816c873d9c\", \"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-6-ndrv\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 1420, \"got_angle_revision\": \"2e0490eedcc809bcd6359de6afdb9e40bd9f731a\", \"got_dawn_revision\": \"4b316994ad01ab6b87032c5fd9b53c6d18956d8d\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"2d2177301ae88d98d0b8c76cc117bc816c873d9c\", \"got_revision_cp\": \"refs/heads/master@{#845015}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"89fd1480b47e8c8668dfd3c24302c53b76ba4c88\", \"got_v8_revision\": \"69c461e9bd40c5c45d553d3d19bb2771e32b4d64\", \"got_v8_revision_cp\": \"refs/heads/9.0.18@{#1}\", \"got_webrtc_revision\": \"5eb527cf7fb28e22d0687c0295cb9f1bb458160c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33034}\", \"mirrored_builders\": [\"tryserver.chromium:win-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2d2177301ae88d98d0b8c76cc117bc816c873d9c\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_f99b6c393baeca5d0493b8341f177ea0239e45dd6dfe829b6aea97f6876ba96c_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-6-ndrv\"], \"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\": [\"5666-679c9bd\"], \"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": "1611123445486423",
    "status": "COMPLETED",
    "status_changed_ts": "1611135288709813",
    "tags": [
      "build_address:luci.chromium.ci/win-official/1420",
      "builder:win-official",
      "buildset:commit/git/2d2177301ae88d98d0b8c76cc117bc816c873d9c",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2d2177301ae88d98d0b8c76cc117bc816c873d9c",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9023041844273424016",
      "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/8857611782031948608/+/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:5137103b4e4cbc10",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1611135288714433",
    "url": "https://ci.chromium.org/b/8857611782031948608",
    "utcnow_ts": "1611135289082013"
  }
}
[09:34:49.094] Invocation finished in 4h12m9.629898295s with status SUCCEEDED