[08:57:35.520] New invocation is queued and will start shortly
[08:57:36.686] Starting the invocation (attempt 1)
[08:57:36.729] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:57:36.729] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:57:36.729] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027014588318528224",
"parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"c008e4d4010d603c5216e619081fba7be0514aa4\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-official",
"scheduler_invocation_id:9027014588318528224",
"scheduler_job_id:chromium/win-official",
"user_agent:luci-scheduler",
"buildset:commit/git/c008e4d4010d603c5216e619081fba7be0514aa4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c008e4d4010d603c5216e619081fba7be0514aa4",
"gitiles_ref:refs/heads/master"
]
}
[08:57:40.929] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1607331457013249",
"id": "8861584526089812208",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c008e4d4010d603c5216e619081fba7be0514aa4\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1607331459909621",
"tags": [
"build_address:luci.chromium.ci/win-official/1134",
"builder:win-official",
"buildset:commit/git/c008e4d4010d603c5216e619081fba7be0514aa4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c008e4d4010d603c5216e619081fba7be0514aa4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027014588318528224",
"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/8861584526089812208/+/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": "1607331459909789",
"url": "https://ci.chromium.org/b/8861584526089812208",
"utcnow_ts": "1607331460905147"
}
}
[08:57:40.929] Task URL: https://ci.chromium.org/b/8861584526089812208
[08:57:40.929] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:2:0) after 1m0s
[08:58:40.934] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:2:0)
[08:58:40.934] Timer tick, asking Buildbucket for the build status
[08:58:42.104] Build 8861584526089812208: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:58:42.104] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:3:0) after 1m0s
[08:59:42.207] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:3:0)
[08:59:42.207] Timer tick, asking Buildbucket for the build status
[08:59:42.390] Build 8861584526089812208: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:59:42.390] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:4:0) after 1m0s
[09:00:42.444] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:4:0)
[09:00:42.444] Timer tick, asking Buildbucket for the build status
[09:00:43.993] Build 8861584526089812208: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:00:43.993] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:5:0) after 1m0s
[09:01:07.233] Received PubSub notification, asking Buildbucket for the build status
[09:01:07.571] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:44.017] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:5:0)
[09:01:44.017] Timer tick, asking Buildbucket for the build status
[09:01:44.119] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:44.119] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:7:0) after 1m0s
[09:02:44.162] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:7:0)
[09:02:44.162] Timer tick, asking Buildbucket for the build status
[09:02:44.306] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:44.306] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:8:0) after 1m0s
[09:03:44.370] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:8:0)
[09:03:44.370] Timer tick, asking Buildbucket for the build status
[09:03:44.499] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:44.499] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:9:0) after 1m0s
[09:04:44.596] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:9:0)
[09:04:44.596] Timer tick, asking Buildbucket for the build status
[09:04:47.716] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:47.716] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:10:0) after 1m0s
[09:05:47.732] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:10:0)
[09:05:47.732] Timer tick, asking Buildbucket for the build status
[09:05:48.067] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:48.067] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:11:0) after 1m0s
[09:06:48.129] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:11:0)
[09:06:48.129] Timer tick, asking Buildbucket for the build status
[09:06:48.356] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:48.356] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:12:0) after 1m0s
[09:07:48.377] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:12:0)
[09:07:48.377] Timer tick, asking Buildbucket for the build status
[09:07:48.612] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:48.612] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:13:0) after 1m0s
[09:08:48.642] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:13:0)
[09:08:48.642] Timer tick, asking Buildbucket for the build status
[09:08:48.754] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:48.754] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:14:0) after 1m0s
[09:09:48.793] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:14:0)
[09:09:48.793] Timer tick, asking Buildbucket for the build status
[09:09:49.201] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:49.201] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:15:0) after 1m0s
[09:10:49.255] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:15:0)
[09:10:49.255] Timer tick, asking Buildbucket for the build status
[09:10:49.467] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:49.467] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:16:0) after 1m0s
[09:11:49.485] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:16:0)
[09:11:49.485] Timer tick, asking Buildbucket for the build status
[09:11:49.553] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:49.553] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:17:0) after 1m0s
[09:12:49.564] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:17:0)
[09:12:49.564] Timer tick, asking Buildbucket for the build status
[09:12:49.786] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:49.786] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:18:0) after 1m0s
[09:13:49.837] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:18:0)
[09:13:49.837] Timer tick, asking Buildbucket for the build status
[09:13:50.030] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:50.030] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:19:0) after 1m0s
[09:14:50.048] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:19:0)
[09:14:50.048] Timer tick, asking Buildbucket for the build status
[09:14:50.126] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:50.126] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:20:0) after 1m0s
[09:15:50.135] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:20:0)
[09:15:50.135] Timer tick, asking Buildbucket for the build status
[09:15:50.490] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:50.490] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:21:0) after 1m0s
[09:16:50.512] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:21:0)
[09:16:50.512] Timer tick, asking Buildbucket for the build status
[09:16:50.687] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:50.687] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:22:0) after 1m0s
[09:17:50.682] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:22:0)
[09:17:50.682] Timer tick, asking Buildbucket for the build status
[09:17:52.156] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:52.156] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:23:0) after 1m0s
[09:18:52.326] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:23:0)
[09:18:52.326] Timer tick, asking Buildbucket for the build status
[09:18:53.373] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:53.373] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:24:0) after 1m0s
[09:19:53.395] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:24:0)
[09:19:53.395] Timer tick, asking Buildbucket for the build status
[09:19:53.566] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:53.566] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:25:0) after 1m0s
[09:20:53.618] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:25:0)
[09:20:53.618] Timer tick, asking Buildbucket for the build status
[09:20:54.689] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:54.689] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:26:0) after 1m0s
[09:21:54.708] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:26:0)
[09:21:54.708] Timer tick, asking Buildbucket for the build status
[09:21:54.795] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:54.795] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:27:0) after 1m0s
[09:22:54.883] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:27:0)
[09:22:54.883] Timer tick, asking Buildbucket for the build status
[09:22:56.970] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:56.970] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:28:0) after 1m0s
[09:23:56.948] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:28:0)
[09:23:56.948] Timer tick, asking Buildbucket for the build status
[09:23:57.086] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:57.086] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:29:0) after 1m0s
[09:24:57.071] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:29:0)
[09:24:57.071] Timer tick, asking Buildbucket for the build status
[09:24:57.153] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:57.153] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:30:0) after 1m0s
[09:25:57.226] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:30:0)
[09:25:57.226] Timer tick, asking Buildbucket for the build status
[09:25:57.357] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:57.357] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:31:0) after 1m0s
[09:26:57.427] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:31:0)
[09:26:57.427] Timer tick, asking Buildbucket for the build status
[09:26:59.741] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:59.741] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:32:0) after 1m0s
[09:27:59.756] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:32:0)
[09:27:59.756] Timer tick, asking Buildbucket for the build status
[09:27:59.987] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:59.987] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:33:0) after 1m0s
[09:29:00.216] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:33:0)
[09:29:00.216] Timer tick, asking Buildbucket for the build status
[09:29:00.363] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:00.363] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:34:0) after 1m0s
[09:30:00.433] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:34:0)
[09:30:00.433] Timer tick, asking Buildbucket for the build status
[09:30:00.568] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:00.568] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:35:0) after 1m0s
[09:31:00.605] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:35:0)
[09:31:00.605] Timer tick, asking Buildbucket for the build status
[09:31:01.036] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:01.036] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:36:0) after 1m0s
[09:32:01.866] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:36:0)
[09:32:01.866] Timer tick, asking Buildbucket for the build status
[09:32:02.147] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:02.147] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:37:0) after 1m0s
[09:33:02.258] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:37:0)
[09:33:02.258] Timer tick, asking Buildbucket for the build status
[09:33:02.742] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:02.742] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:38:0) after 1m0s
[09:34:02.818] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:38:0)
[09:34:02.818] Timer tick, asking Buildbucket for the build status
[09:34:03.446] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:03.446] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:39:0) after 1m0s
[09:35:03.540] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:39:0)
[09:35:03.540] Timer tick, asking Buildbucket for the build status
[09:35:03.730] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:03.730] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:40:0) after 1m0s
[09:36:03.757] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:40:0)
[09:36:03.757] Timer tick, asking Buildbucket for the build status
[09:36:05.682] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:05.683] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:41:0) after 1m0s
[09:37:05.956] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:41:0)
[09:37:05.956] Timer tick, asking Buildbucket for the build status
[09:37:06.771] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:06.771] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:42:0) after 1m0s
[09:38:06.914] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:42:0)
[09:38:06.914] Timer tick, asking Buildbucket for the build status
[09:38:07.462] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:07.462] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:43:0) after 1m0s
[09:39:07.529] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:43:0)
[09:39:07.529] Timer tick, asking Buildbucket for the build status
[09:39:07.630] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:07.630] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:44:0) after 1m0s
[09:40:07.671] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:44:0)
[09:40:07.671] Timer tick, asking Buildbucket for the build status
[09:40:07.808] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:07.808] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:45:0) after 1m0s
[09:41:07.942] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:45:0)
[09:41:07.942] Timer tick, asking Buildbucket for the build status
[09:41:09.568] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:09.568] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:46:0) after 1m0s
[09:42:09.584] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:46:0)
[09:42:09.584] Timer tick, asking Buildbucket for the build status
[09:42:09.709] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:09.709] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:47:0) after 1m0s
[09:43:09.942] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:47:0)
[09:43:09.942] Timer tick, asking Buildbucket for the build status
[09:43:10.224] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:10.224] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:48:0) after 1m0s
[09:44:10.310] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:48:0)
[09:44:10.310] Timer tick, asking Buildbucket for the build status
[09:44:10.746] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:10.746] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:49:0) after 1m0s
[09:45:10.851] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:49:0)
[09:45:10.851] Timer tick, asking Buildbucket for the build status
[09:45:11.246] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:11.246] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:50:0) after 1m0s
[09:46:11.510] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:50:0)
[09:46:11.510] Timer tick, asking Buildbucket for the build status
[09:46:12.298] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:12.298] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:51:0) after 1m0s
[09:47:12.519] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:51:0)
[09:47:12.519] Timer tick, asking Buildbucket for the build status
[09:47:12.686] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:12.686] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:52:0) after 1m0s
[09:48:12.849] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:52:0)
[09:48:12.849] Timer tick, asking Buildbucket for the build status
[09:48:13.208] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:13.208] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:53:0) after 1m0s
[09:49:13.246] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:53:0)
[09:49:13.246] Timer tick, asking Buildbucket for the build status
[09:49:13.780] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:13.780] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:54:0) after 1m0s
[09:50:13.853] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:54:0)
[09:50:13.853] Timer tick, asking Buildbucket for the build status
[09:50:13.928] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:13.928] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:55:0) after 1m0s
[09:51:14.023] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:55:0)
[09:51:14.023] Timer tick, asking Buildbucket for the build status
[09:51:14.095] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:14.095] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:56:0) after 1m0s
[09:52:14.098] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:56:0)
[09:52:14.098] Timer tick, asking Buildbucket for the build status
[09:52:14.481] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:14.481] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:57:0) after 1m0s
[09:53:14.546] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:57:0)
[09:53:14.546] Timer tick, asking Buildbucket for the build status
[09:53:15.577] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:15.577] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:58:0) after 1m0s
[09:54:15.701] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:58:0)
[09:54:15.701] Timer tick, asking Buildbucket for the build status
[09:54:16.317] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:16.317] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:59:0) after 1m0s
[09:55:16.361] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:59:0)
[09:55:16.361] Timer tick, asking Buildbucket for the build status
[09:55:16.451] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:16.451] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:60:0) after 1m0s
[09:56:16.484] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:60:0)
[09:56:16.484] Timer tick, asking Buildbucket for the build status
[09:56:17.367] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:17.367] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:61:0) after 1m0s
[09:57:17.420] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:61:0)
[09:57:17.420] Timer tick, asking Buildbucket for the build status
[09:57:18.265] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:18.265] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:62:0) after 1m0s
[09:58:18.312] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:62:0)
[09:58:18.312] Timer tick, asking Buildbucket for the build status
[09:58:18.535] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:18.535] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:63:0) after 1m0s
[09:59:18.585] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:63:0)
[09:59:18.585] Timer tick, asking Buildbucket for the build status
[09:59:18.996] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:18.996] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:64:0) after 1m0s
[10:00:19.196] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:64:0)
[10:00:19.196] Timer tick, asking Buildbucket for the build status
[10:00:19.294] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:19.294] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:65:0) after 1m0s
[10:01:20.340] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:65:0)
[10:01:20.340] Timer tick, asking Buildbucket for the build status
[10:01:20.550] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:20.550] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:66:0) after 1m0s
[10:02:20.731] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:66:0)
[10:02:20.731] Timer tick, asking Buildbucket for the build status
[10:02:21.365] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:21.366] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:67:0) after 1m0s
[10:03:21.965] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:67:0)
[10:03:21.965] Timer tick, asking Buildbucket for the build status
[10:03:23.059] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:23.059] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:68:0) after 1m0s
[10:04:23.173] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:68:0)
[10:04:23.173] Timer tick, asking Buildbucket for the build status
[10:04:25.904] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:25.905] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:69:0) after 1m0s
[10:05:26.004] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:69:0)
[10:05:26.004] Timer tick, asking Buildbucket for the build status
[10:05:26.367] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:26.367] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:70:0) after 1m0s
[10:06:26.660] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:70:0)
[10:06:26.660] Timer tick, asking Buildbucket for the build status
[10:06:27.018] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:27.018] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:71:0) after 1m0s
[10:07:27.143] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:71:0)
[10:07:27.143] Timer tick, asking Buildbucket for the build status
[10:07:28.257] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:28.257] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:72:0) after 1m0s
[10:08:28.386] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:72:0)
[10:08:28.386] Timer tick, asking Buildbucket for the build status
[10:08:28.500] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:28.500] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:73:0) after 1m0s
[10:09:28.532] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:73:0)
[10:09:28.532] Timer tick, asking Buildbucket for the build status
[10:09:28.650] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:28.650] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:74:0) after 1m0s
[10:10:28.718] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:74:0)
[10:10:28.718] Timer tick, asking Buildbucket for the build status
[10:10:28.830] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:28.830] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:75:0) after 1m0s
[10:11:28.858] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:75:0)
[10:11:28.858] Timer tick, asking Buildbucket for the build status
[10:11:29.892] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:29.892] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:76:0) after 1m0s
[10:12:29.933] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:76:0)
[10:12:29.933] Timer tick, asking Buildbucket for the build status
[10:12:30.777] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:30.777] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:77:0) after 1m0s
[10:13:30.795] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:77:0)
[10:13:30.795] Timer tick, asking Buildbucket for the build status
[10:13:31.910] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:31.910] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:78:0) after 1m0s
[10:14:31.902] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:78:0)
[10:14:31.902] Timer tick, asking Buildbucket for the build status
[10:14:32.364] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:32.364] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:79:0) after 1m0s
[10:15:32.415] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:79:0)
[10:15:32.415] Timer tick, asking Buildbucket for the build status
[10:15:33.753] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:33.753] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:80:0) after 1m0s
[10:16:33.789] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:80:0)
[10:16:33.789] Timer tick, asking Buildbucket for the build status
[10:16:33.905] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:33.905] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:81:0) after 1m0s
[10:17:33.928] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:81:0)
[10:17:33.928] Timer tick, asking Buildbucket for the build status
[10:17:35.001] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:35.001] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:82:0) after 1m0s
[10:18:35.108] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:82:0)
[10:18:35.108] Timer tick, asking Buildbucket for the build status
[10:18:35.980] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:35.980] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:83:0) after 1m0s
[10:19:36.092] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:83:0)
[10:19:36.092] Timer tick, asking Buildbucket for the build status
[10:19:36.716] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:36.716] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:84:0) after 1m0s
[10:20:36.766] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:84:0)
[10:20:36.766] Timer tick, asking Buildbucket for the build status
[10:20:36.867] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:36.867] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:85:0) after 1m0s
[10:21:36.866] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:85:0)
[10:21:36.866] Timer tick, asking Buildbucket for the build status
[10:21:37.132] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:37.132] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:86:0) after 1m0s
[10:22:37.171] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:86:0)
[10:22:37.171] Timer tick, asking Buildbucket for the build status
[10:22:37.286] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:37.286] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:87:0) after 1m0s
[10:23:37.312] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:87:0)
[10:23:37.312] Timer tick, asking Buildbucket for the build status
[10:23:37.809] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:37.809] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:88:0) after 1m0s
[10:24:37.833] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:88:0)
[10:24:37.833] Timer tick, asking Buildbucket for the build status
[10:24:37.986] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:37.986] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:89:0) after 1m0s
[10:25:38.096] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:89:0)
[10:25:38.096] Timer tick, asking Buildbucket for the build status
[10:25:38.210] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:38.210] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:90:0) after 1m0s
[10:26:38.248] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:90:0)
[10:26:38.248] Timer tick, asking Buildbucket for the build status
[10:26:38.474] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:38.474] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:91:0) after 1m0s
[10:27:38.501] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:91:0)
[10:27:38.501] Timer tick, asking Buildbucket for the build status
[10:27:38.596] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:38.596] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:92:0) after 1m0s
[10:28:38.753] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:92:0)
[10:28:38.753] Timer tick, asking Buildbucket for the build status
[10:28:39.523] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:39.523] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:93:0) after 1m0s
[10:29:39.854] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:93:0)
[10:29:39.854] Timer tick, asking Buildbucket for the build status
[10:29:40.003] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:40.003] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:94:0) after 1m0s
[10:30:40.241] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:94:0)
[10:30:40.241] Timer tick, asking Buildbucket for the build status
[10:30:41.164] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:41.164] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:95:0) after 1m0s
[10:31:41.366] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:95:0)
[10:31:41.366] Timer tick, asking Buildbucket for the build status
[10:31:41.691] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:41.691] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:96:0) after 1m0s
[10:32:41.859] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:96:0)
[10:32:41.859] Timer tick, asking Buildbucket for the build status
[10:32:42.047] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:42.047] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:97:0) after 1m0s
[10:33:42.249] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:97:0)
[10:33:42.249] Timer tick, asking Buildbucket for the build status
[10:33:42.473] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:42.473] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:98:0) after 1m0s
[10:34:42.631] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:98:0)
[10:34:42.631] Timer tick, asking Buildbucket for the build status
[10:34:42.741] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:42.741] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:99:0) after 1m0s
[10:35:42.783] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:99:0)
[10:35:42.783] Timer tick, asking Buildbucket for the build status
[10:35:42.904] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:42.904] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:100:0) after 1m0s
[10:36:43.112] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:100:0)
[10:36:43.112] Timer tick, asking Buildbucket for the build status
[10:36:43.373] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:43.373] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:101:0) after 1m0s
[10:37:43.469] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:101:0)
[10:37:43.469] Timer tick, asking Buildbucket for the build status
[10:37:43.861] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:43.861] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:102:0) after 1m0s
[10:38:43.983] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:102:0)
[10:38:43.983] Timer tick, asking Buildbucket for the build status
[10:38:45.608] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:45.608] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:103:0) after 1m0s
[10:39:45.658] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:103:0)
[10:39:45.658] Timer tick, asking Buildbucket for the build status
[10:39:51.138] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:51.138] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:104:0) after 1m0s
[10:40:51.268] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:104:0)
[10:40:51.268] Timer tick, asking Buildbucket for the build status
[10:40:51.372] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:51.372] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:105:0) after 1m0s
[10:41:51.458] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:105:0)
[10:41:51.458] Timer tick, asking Buildbucket for the build status
[10:41:52.566] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:52.566] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:106:0) after 1m0s
[10:42:52.655] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:106:0)
[10:42:52.655] Timer tick, asking Buildbucket for the build status
[10:42:53.114] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:53.114] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:107:0) after 1m0s
[10:43:53.120] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:107:0)
[10:43:53.120] Timer tick, asking Buildbucket for the build status
[10:43:53.182] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:53.182] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:108:0) after 1m0s
[10:44:53.204] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:108:0)
[10:44:53.205] Timer tick, asking Buildbucket for the build status
[10:44:53.357] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:53.357] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:109:0) after 1m0s
[10:45:53.382] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:109:0)
[10:45:53.382] Timer tick, asking Buildbucket for the build status
[10:45:54.906] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:54.906] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:110:0) after 1m0s
[10:46:55.026] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:110:0)
[10:46:55.026] Timer tick, asking Buildbucket for the build status
[10:46:55.167] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:55.167] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:111:0) after 1m0s
[10:47:55.228] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:111:0)
[10:47:55.228] Timer tick, asking Buildbucket for the build status
[10:47:56.216] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:56.216] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:112:0) after 1m0s
[10:48:56.338] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:112:0)
[10:48:56.338] Timer tick, asking Buildbucket for the build status
[10:48:57.403] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:57.403] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:113:0) after 1m0s
[10:49:58.348] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:113:0)
[10:49:58.348] Timer tick, asking Buildbucket for the build status
[10:49:58.551] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:58.551] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:114:0) after 1m0s
[10:50:59.411] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:114:0)
[10:50:59.411] Timer tick, asking Buildbucket for the build status
[10:50:59.497] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:59.498] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:115:0) after 1m0s
[10:51:59.602] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:115:0)
[10:51:59.602] Timer tick, asking Buildbucket for the build status
[10:52:00.265] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:00.265] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:116:0) after 1m0s
[10:53:00.244] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:116:0)
[10:53:00.244] Timer tick, asking Buildbucket for the build status
[10:53:00.610] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:00.610] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:117:0) after 1m0s
[10:54:00.651] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:117:0)
[10:54:00.651] Timer tick, asking Buildbucket for the build status
[10:54:00.780] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:00.780] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:118:0) after 1m0s
[10:55:01.710] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:118:0)
[10:55:01.710] Timer tick, asking Buildbucket for the build status
[10:55:01.844] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:01.844] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:119:0) after 1m0s
[10:56:02.193] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:119:0)
[10:56:02.193] Timer tick, asking Buildbucket for the build status
[10:56:06.570] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:06.570] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:120:0) after 1m0s
[10:57:06.798] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:120:0)
[10:57:06.798] Timer tick, asking Buildbucket for the build status
[10:57:06.878] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:06.878] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:121:0) after 1m0s
[10:58:06.950] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:121:0)
[10:58:06.950] Timer tick, asking Buildbucket for the build status
[10:58:07.274] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:07.274] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:122:0) after 1m0s
[10:59:07.345] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:122:0)
[10:59:07.345] Timer tick, asking Buildbucket for the build status
[10:59:07.432] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:07.432] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:123:0) after 1m0s
[11:00:07.461] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:123:0)
[11:00:07.461] Timer tick, asking Buildbucket for the build status
[11:00:07.773] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:07.774] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:124:0) after 1m0s
[11:01:07.889] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:124:0)
[11:01:07.889] Timer tick, asking Buildbucket for the build status
[11:01:08.367] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:08.367] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:125:0) after 1m0s
[11:02:08.386] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:125:0)
[11:02:08.386] Timer tick, asking Buildbucket for the build status
[11:02:10.520] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:10.520] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:126:0) after 1m0s
[11:03:10.562] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:126:0)
[11:03:10.562] Timer tick, asking Buildbucket for the build status
[11:03:11.184] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:11.184] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:127:0) after 1m0s
[11:04:11.209] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:127:0)
[11:04:11.209] Timer tick, asking Buildbucket for the build status
[11:04:12.017] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:12.017] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:128:0) after 1m0s
[11:05:12.048] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:128:0)
[11:05:12.048] Timer tick, asking Buildbucket for the build status
[11:05:12.325] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:12.325] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:129:0) after 1m0s
[11:06:12.386] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:129:0)
[11:06:12.386] Timer tick, asking Buildbucket for the build status
[11:06:13.168] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:13.168] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:130:0) after 1m0s
[11:07:13.208] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:130:0)
[11:07:13.208] Timer tick, asking Buildbucket for the build status
[11:07:13.305] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:13.305] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:131:0) after 1m0s
[11:08:13.375] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:131:0)
[11:08:13.375] Timer tick, asking Buildbucket for the build status
[11:08:13.469] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:13.469] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:132:0) after 1m0s
[11:09:13.494] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:132:0)
[11:09:13.494] Timer tick, asking Buildbucket for the build status
[11:09:13.868] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:13.868] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:133:0) after 1m0s
[11:10:14.009] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:133:0)
[11:10:14.009] Timer tick, asking Buildbucket for the build status
[11:10:14.459] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:14.459] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:134:0) after 1m0s
[11:11:14.484] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:134:0)
[11:11:14.484] Timer tick, asking Buildbucket for the build status
[11:11:14.576] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:14.576] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:135:0) after 1m0s
[11:12:14.601] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:135:0)
[11:12:14.601] Timer tick, asking Buildbucket for the build status
[11:12:14.679] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:14.679] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:136:0) after 1m0s
[11:13:14.719] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:136:0)
[11:13:14.719] Timer tick, asking Buildbucket for the build status
[11:13:14.865] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:14.865] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:137:0) after 1m0s
[11:14:14.863] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:137:0)
[11:14:14.863] Timer tick, asking Buildbucket for the build status
[11:14:15.041] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:15.041] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:138:0) after 1m0s
[11:15:15.039] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:138:0)
[11:15:15.039] Timer tick, asking Buildbucket for the build status
[11:15:15.207] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:15.207] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:139:0) after 1m0s
[11:16:15.234] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:139:0)
[11:16:15.234] Timer tick, asking Buildbucket for the build status
[11:16:15.334] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:15.334] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:140:0) after 1m0s
[11:17:15.400] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:140:0)
[11:17:15.400] Timer tick, asking Buildbucket for the build status
[11:17:15.486] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:15.486] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:141:0) after 1m0s
[11:18:15.511] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:141:0)
[11:18:15.511] Timer tick, asking Buildbucket for the build status
[11:18:15.630] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:15.630] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:142:0) after 1m0s
[11:19:15.692] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:142:0)
[11:19:15.692] Timer tick, asking Buildbucket for the build status
[11:19:15.865] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:15.865] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:143:0) after 1m0s
[11:20:15.904] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:143:0)
[11:20:15.904] Timer tick, asking Buildbucket for the build status
[11:20:16.271] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:16.271] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:144:0) after 1m0s
[11:21:16.329] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:144:0)
[11:21:16.329] Timer tick, asking Buildbucket for the build status
[11:21:16.388] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:16.388] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:145:0) after 1m0s
[11:22:16.481] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:145:0)
[11:22:16.481] Timer tick, asking Buildbucket for the build status
[11:22:16.636] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:16.636] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:146:0) after 1m0s
[11:23:16.821] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:146:0)
[11:23:16.821] Timer tick, asking Buildbucket for the build status
[11:23:16.923] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:16.923] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:147:0) after 1m0s
[11:24:17.006] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:147:0)
[11:24:17.006] Timer tick, asking Buildbucket for the build status
[11:24:17.058] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:17.058] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:148:0) after 1m0s
[11:25:17.122] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:148:0)
[11:25:17.122] Timer tick, asking Buildbucket for the build status
[11:25:17.219] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:17.219] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:149:0) after 1m0s
[11:26:17.315] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:149:0)
[11:26:17.315] Timer tick, asking Buildbucket for the build status
[11:26:17.417] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:17.417] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:150:0) after 1m0s
[11:27:17.613] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:150:0)
[11:27:17.613] Timer tick, asking Buildbucket for the build status
[11:27:18.108] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:18.108] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:151:0) after 1m0s
[11:28:18.193] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:151:0)
[11:28:18.193] Timer tick, asking Buildbucket for the build status
[11:28:18.314] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:18.314] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:152:0) after 1m0s
[11:29:18.393] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:152:0)
[11:29:18.393] Timer tick, asking Buildbucket for the build status
[11:29:18.610] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:18.610] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:153:0) after 1m0s
[11:30:18.691] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:153:0)
[11:30:18.691] Timer tick, asking Buildbucket for the build status
[11:30:18.789] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:18.789] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:154:0) after 1m0s
[11:31:18.893] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:154:0)
[11:31:18.893] Timer tick, asking Buildbucket for the build status
[11:31:19.152] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:19.152] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:155:0) after 1m0s
[11:32:19.177] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:155:0)
[11:32:19.177] Timer tick, asking Buildbucket for the build status
[11:32:19.268] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:19.268] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:156:0) after 1m0s
[11:33:19.334] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:156:0)
[11:33:19.334] Timer tick, asking Buildbucket for the build status
[11:33:19.453] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:19.453] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:157:0) after 1m0s
[11:34:19.478] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:157:0)
[11:34:19.478] Timer tick, asking Buildbucket for the build status
[11:34:19.540] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:19.540] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:158:0) after 1m0s
[11:35:19.584] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:158:0)
[11:35:19.584] Timer tick, asking Buildbucket for the build status
[11:35:19.637] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:19.637] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:159:0) after 1m0s
[11:36:19.752] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:159:0)
[11:36:19.752] Timer tick, asking Buildbucket for the build status
[11:36:20.030] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:20.030] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:160:0) after 1m0s
[11:37:20.077] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:160:0)
[11:37:20.077] Timer tick, asking Buildbucket for the build status
[11:37:20.423] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:20.423] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:161:0) after 1m0s
[11:38:20.452] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:161:0)
[11:38:20.452] Timer tick, asking Buildbucket for the build status
[11:38:20.599] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:20.599] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:162:0) after 1m0s
[11:39:20.687] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:162:0)
[11:39:20.687] Timer tick, asking Buildbucket for the build status
[11:39:21.464] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:21.464] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:163:0) after 1m0s
[11:40:22.634] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:163:0)
[11:40:22.634] Timer tick, asking Buildbucket for the build status
[11:40:22.711] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:22.711] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:164:0) after 1m0s
[11:41:22.782] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:164:0)
[11:41:22.782] Timer tick, asking Buildbucket for the build status
[11:41:22.931] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:22.931] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:165:0) after 1m0s
[11:42:22.942] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:165:0)
[11:42:22.942] Timer tick, asking Buildbucket for the build status
[11:42:23.126] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:23.126] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:166:0) after 1m0s
[11:43:23.218] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:166:0)
[11:43:23.218] Timer tick, asking Buildbucket for the build status
[11:43:23.341] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:23.341] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:167:0) after 1m0s
[11:44:23.380] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:167:0)
[11:44:23.380] Timer tick, asking Buildbucket for the build status
[11:44:23.545] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:23.545] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:168:0) after 1m0s
[11:45:23.655] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:168:0)
[11:45:23.655] Timer tick, asking Buildbucket for the build status
[11:45:23.804] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:23.804] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:169:0) after 1m0s
[11:46:23.970] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:169:0)
[11:46:23.970] Timer tick, asking Buildbucket for the build status
[11:46:24.187] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:24.187] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:170:0) after 1m0s
[11:47:25.886] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:170:0)
[11:47:25.886] Timer tick, asking Buildbucket for the build status
[11:47:25.973] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:25.973] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:171:0) after 1m0s
[11:48:26.044] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:171:0)
[11:48:26.044] Timer tick, asking Buildbucket for the build status
[11:48:26.722] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:26.722] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:172:0) after 1m0s
[11:49:26.791] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:172:0)
[11:49:26.791] Timer tick, asking Buildbucket for the build status
[11:49:27.073] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:27.073] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:173:0) after 1m0s
[11:50:27.101] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:173:0)
[11:50:27.101] Timer tick, asking Buildbucket for the build status
[11:50:27.186] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:27.186] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:174:0) after 1m0s
[11:51:27.735] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:174:0)
[11:51:27.735] Timer tick, asking Buildbucket for the build status
[11:51:28.012] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:28.012] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:175:0) after 1m0s
[11:52:28.043] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:175:0)
[11:52:28.043] Timer tick, asking Buildbucket for the build status
[11:52:28.280] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:28.280] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:176:0) after 1m0s
[11:53:28.306] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:176:0)
[11:53:28.306] Timer tick, asking Buildbucket for the build status
[11:53:28.399] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:28.399] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:177:0) after 1m0s
[11:54:28.495] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:177:0)
[11:54:28.495] Timer tick, asking Buildbucket for the build status
[11:54:28.572] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:28.572] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:178:0) after 1m0s
[11:55:28.646] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:178:0)
[11:55:28.646] Timer tick, asking Buildbucket for the build status
[11:55:28.826] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:28.826] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:179:0) after 1m0s
[11:56:28.802] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:179:0)
[11:56:28.802] Timer tick, asking Buildbucket for the build status
[11:56:28.896] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:28.897] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:180:0) after 1m0s
[11:57:28.924] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:180:0)
[11:57:28.924] Timer tick, asking Buildbucket for the build status
[11:57:28.984] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:28.984] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:181:0) after 1m0s
[11:58:29.036] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:181:0)
[11:58:29.036] Timer tick, asking Buildbucket for the build status
[11:58:29.287] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:29.287] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:182:0) after 1m0s
[11:59:29.319] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:182:0)
[11:59:29.319] Timer tick, asking Buildbucket for the build status
[11:59:29.375] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:29.375] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:183:0) after 1m0s
[12:00:29.555] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:183:0)
[12:00:29.555] Timer tick, asking Buildbucket for the build status
[12:00:30.109] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:30.109] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:184:0) after 1m0s
[12:01:30.144] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:184:0)
[12:01:30.144] Timer tick, asking Buildbucket for the build status
[12:01:30.206] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:30.206] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:185:0) after 1m0s
[12:02:30.317] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:185:0)
[12:02:30.317] Timer tick, asking Buildbucket for the build status
[12:02:30.401] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:30.401] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:186:0) after 1m0s
[12:03:30.445] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:186:0)
[12:03:30.445] Timer tick, asking Buildbucket for the build status
[12:03:30.769] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:30.769] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:187:0) after 1m0s
[12:04:30.797] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:187:0)
[12:04:30.798] Timer tick, asking Buildbucket for the build status
[12:04:30.874] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:30.874] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:188:0) after 1m0s
[12:05:30.954] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:188:0)
[12:05:30.954] Timer tick, asking Buildbucket for the build status
[12:05:31.038] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:31.038] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:189:0) after 1m0s
[12:06:31.107] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:189:0)
[12:06:31.107] Timer tick, asking Buildbucket for the build status
[12:06:31.413] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:31.413] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:190:0) after 1m0s
[12:07:31.447] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:190:0)
[12:07:31.447] Timer tick, asking Buildbucket for the build status
[12:07:31.507] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:31.508] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:191:0) after 1m0s
[12:08:31.516] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:191:0)
[12:08:31.516] Timer tick, asking Buildbucket for the build status
[12:08:31.988] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:31.988] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:192:0) after 1m0s
[12:09:32.097] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:192:0)
[12:09:32.097] Timer tick, asking Buildbucket for the build status
[12:09:33.079] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:33.079] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:193:0) after 1m0s
[12:10:33.125] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:193:0)
[12:10:33.125] Timer tick, asking Buildbucket for the build status
[12:10:33.347] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:33.347] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:194:0) after 1m0s
[12:11:33.373] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:194:0)
[12:11:33.373] Timer tick, asking Buildbucket for the build status
[12:11:33.475] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:33.475] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:195:0) after 1m0s
[12:12:33.541] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:195:0)
[12:12:33.541] Timer tick, asking Buildbucket for the build status
[12:12:33.601] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:33.601] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:196:0) after 1m0s
[12:13:33.647] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:196:0)
[12:13:33.647] Timer tick, asking Buildbucket for the build status
[12:13:34.005] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:34.005] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:197:0) after 1m0s
[12:14:34.065] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:197:0)
[12:14:34.065] Timer tick, asking Buildbucket for the build status
[12:14:34.141] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:34.141] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:198:0) after 1m0s
[12:15:34.209] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:198:0)
[12:15:34.209] Timer tick, asking Buildbucket for the build status
[12:15:34.347] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:34.347] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:199:0) after 1m0s
[12:16:34.361] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:199:0)
[12:16:34.361] Timer tick, asking Buildbucket for the build status
[12:16:34.448] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:34.448] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:200:0) after 1m0s
[12:17:34.446] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:200:0)
[12:17:34.446] Timer tick, asking Buildbucket for the build status
[12:17:34.518] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:34.518] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:201:0) after 1m0s
[12:18:34.601] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:201:0)
[12:18:34.601] Timer tick, asking Buildbucket for the build status
[12:18:34.737] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:34.737] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:202:0) after 1m0s
[12:19:34.827] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:202:0)
[12:19:34.827] Timer tick, asking Buildbucket for the build status
[12:19:37.477] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:37.477] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:203:0) after 1m0s
[12:20:37.504] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:203:0)
[12:20:37.504] Timer tick, asking Buildbucket for the build status
[12:20:37.565] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:37.565] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:204:0) after 1m0s
[12:21:37.612] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:204:0)
[12:21:37.612] Timer tick, asking Buildbucket for the build status
[12:21:37.677] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:37.677] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:205:0) after 1m0s
[12:22:37.677] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:205:0)
[12:22:37.677] Timer tick, asking Buildbucket for the build status
[12:22:37.753] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:37.753] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:206:0) after 1m0s
[12:23:37.868] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:206:0)
[12:23:37.868] Timer tick, asking Buildbucket for the build status
[12:23:37.983] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:37.983] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:207:0) after 1m0s
[12:24:38.072] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:207:0)
[12:24:38.072] Timer tick, asking Buildbucket for the build status
[12:24:38.257] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:38.257] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:208:0) after 1m0s
[12:25:38.299] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:208:0)
[12:25:38.299] Timer tick, asking Buildbucket for the build status
[12:25:38.384] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:38.384] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:209:0) after 1m0s
[12:26:38.445] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:209:0)
[12:26:38.445] Timer tick, asking Buildbucket for the build status
[12:26:38.610] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:38.610] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:210:0) after 1m0s
[12:27:38.677] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:210:0)
[12:27:38.677] Timer tick, asking Buildbucket for the build status
[12:27:38.730] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:38.730] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:211:0) after 1m0s
[12:28:38.809] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:211:0)
[12:28:38.809] Timer tick, asking Buildbucket for the build status
[12:28:38.905] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:38.905] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:212:0) after 1m0s
[12:29:38.933] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:212:0)
[12:29:38.933] Timer tick, asking Buildbucket for the build status
[12:29:39.402] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:39.402] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:213:0) after 1m0s
[12:30:39.479] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:213:0)
[12:30:39.479] Timer tick, asking Buildbucket for the build status
[12:30:39.566] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:39.566] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:214:0) after 1m0s
[12:31:42.225] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:214:0)
[12:31:42.225] Timer tick, asking Buildbucket for the build status
[12:31:42.362] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:42.362] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:215:0) after 1m0s
[12:32:42.469] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:215:0)
[12:32:42.469] Timer tick, asking Buildbucket for the build status
[12:32:42.535] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:42.535] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:216:0) after 1m0s
[12:33:42.629] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:216:0)
[12:33:42.629] Timer tick, asking Buildbucket for the build status
[12:33:42.733] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:42.733] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:217:0) after 1m0s
[12:34:42.799] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:217:0)
[12:34:42.799] Timer tick, asking Buildbucket for the build status
[12:34:42.888] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:42.888] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:218:0) after 1m0s
[12:35:43.074] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:218:0)
[12:35:43.074] Timer tick, asking Buildbucket for the build status
[12:35:43.166] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:43.166] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:219:0) after 1m0s
[12:36:43.198] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:219:0)
[12:36:43.198] Timer tick, asking Buildbucket for the build status
[12:36:43.335] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:43.335] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:220:0) after 1m0s
[12:37:43.438] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:220:0)
[12:37:43.438] Timer tick, asking Buildbucket for the build status
[12:37:43.588] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:43.589] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:221:0) after 1m0s
[12:38:43.639] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:221:0)
[12:38:43.639] Timer tick, asking Buildbucket for the build status
[12:38:43.769] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:43.769] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:222:0) after 1m0s
[12:39:43.785] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:222:0)
[12:39:43.785] Timer tick, asking Buildbucket for the build status
[12:39:44.117] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:44.117] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:223:0) after 1m0s
[12:40:44.188] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:223:0)
[12:40:44.188] Timer tick, asking Buildbucket for the build status
[12:40:44.291] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:44.291] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:224:0) after 1m0s
[12:41:44.314] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:224:0)
[12:41:44.314] Timer tick, asking Buildbucket for the build status
[12:41:44.475] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:44.475] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:225:0) after 1m0s
[12:42:44.605] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:225:0)
[12:42:44.605] Timer tick, asking Buildbucket for the build status
[12:42:44.706] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:44.706] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:226:0) after 1m0s
[12:43:44.935] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:226:0)
[12:43:44.935] Timer tick, asking Buildbucket for the build status
[12:43:45.404] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:45.404] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:227:0) after 1m0s
[12:44:45.693] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:227:0)
[12:44:45.693] Timer tick, asking Buildbucket for the build status
[12:44:46.032] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:46.032] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:228:0) after 1m0s
[12:45:46.344] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:228:0)
[12:45:46.344] Timer tick, asking Buildbucket for the build status
[12:45:46.417] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:46.417] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:229:0) after 1m0s
[12:46:46.621] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:229:0)
[12:46:46.621] Timer tick, asking Buildbucket for the build status
[12:46:46.705] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:46.705] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:230:0) after 1m0s
[12:47:46.911] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:230:0)
[12:47:46.911] Timer tick, asking Buildbucket for the build status
[12:47:46.976] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:46.976] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:231:0) after 1m0s
[12:48:47.162] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:231:0)
[12:48:47.162] Timer tick, asking Buildbucket for the build status
[12:48:47.285] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:47.285] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:232:0) after 1m0s
[12:49:47.492] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:232:0)
[12:49:47.492] Timer tick, asking Buildbucket for the build status
[12:49:47.569] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:47.569] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:233:0) after 1m0s
[12:50:47.761] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:233:0)
[12:50:47.761] Timer tick, asking Buildbucket for the build status
[12:50:47.841] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:47.841] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:234:0) after 1m0s
[12:51:47.885] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:234:0)
[12:51:47.885] Timer tick, asking Buildbucket for the build status
[12:51:47.942] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:47.942] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:235:0) after 1m0s
[12:52:48.089] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:235:0)
[12:52:48.089] Timer tick, asking Buildbucket for the build status
[12:52:48.152] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:48.152] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:236:0) after 1m0s
[12:53:48.218] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:236:0)
[12:53:48.218] Timer tick, asking Buildbucket for the build status
[12:53:48.329] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:48.329] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:237:0) after 1m0s
[12:54:48.408] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:237:0)
[12:54:48.408] Timer tick, asking Buildbucket for the build status
[12:54:48.479] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:48.479] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:238:0) after 1m0s
[12:55:48.739] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:238:0)
[12:55:48.739] Timer tick, asking Buildbucket for the build status
[12:55:48.956] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:48.957] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:239:0) after 1m0s
[12:56:49.114] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:239:0)
[12:56:49.114] Timer tick, asking Buildbucket for the build status
[12:56:49.198] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:49.198] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:240:0) after 1m0s
[12:57:49.317] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:240:0)
[12:57:49.317] Timer tick, asking Buildbucket for the build status
[12:57:49.380] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:49.380] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:241:0) after 1m0s
[12:58:49.445] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:241:0)
[12:58:49.445] Timer tick, asking Buildbucket for the build status
[12:58:49.572] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:49.572] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:242:0) after 1m0s
[12:59:49.601] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:242:0)
[12:59:49.601] Timer tick, asking Buildbucket for the build status
[12:59:49.673] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:49.673] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:243:0) after 1m0s
[13:00:49.665] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:243:0)
[13:00:49.665] Timer tick, asking Buildbucket for the build status
[13:00:49.736] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:49.736] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:244:0) after 1m0s
[13:01:49.836] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:244:0)
[13:01:49.836] Timer tick, asking Buildbucket for the build status
[13:01:49.919] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:49.919] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:245:0) after 1m0s
[13:02:50.152] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:245:0)
[13:02:50.152] Timer tick, asking Buildbucket for the build status
[13:02:50.249] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:50.249] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:246:0) after 1m0s
[13:03:50.345] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:246:0)
[13:03:50.345] Timer tick, asking Buildbucket for the build status
[13:03:50.467] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:50.467] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:247:0) after 1m0s
[13:04:50.832] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:247:0)
[13:04:50.832] Timer tick, asking Buildbucket for the build status
[13:04:50.915] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:50.915] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:248:0) after 1m0s
[13:05:51.109] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:248:0)
[13:05:51.109] Timer tick, asking Buildbucket for the build status
[13:05:51.175] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:51.175] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:249:0) after 1m0s
[13:06:51.226] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:249:0)
[13:06:51.226] Timer tick, asking Buildbucket for the build status
[13:06:51.293] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:51.293] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:250:0) after 1m0s
[13:07:51.323] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:250:0)
[13:07:51.323] Timer tick, asking Buildbucket for the build status
[13:07:51.408] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:51.408] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:251:0) after 1m0s
[13:08:51.574] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:251:0)
[13:08:51.574] Timer tick, asking Buildbucket for the build status
[13:08:51.862] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:51.862] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:252:0) after 1m0s
[13:09:51.919] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:252:0)
[13:09:51.919] Timer tick, asking Buildbucket for the build status
[13:09:52.136] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:52.136] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:253:0) after 1m0s
[13:10:52.258] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:253:0)
[13:10:52.258] Timer tick, asking Buildbucket for the build status
[13:10:52.356] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:52.356] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:254:0) after 1m0s
[13:11:52.524] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:254:0)
[13:11:52.524] Timer tick, asking Buildbucket for the build status
[13:11:52.608] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:52.608] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:255:0) after 1m0s
[13:12:52.797] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:255:0)
[13:12:52.797] Timer tick, asking Buildbucket for the build status
[13:12:52.856] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:52.856] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:256:0) after 1m0s
[13:13:52.924] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:256:0)
[13:13:52.924] Timer tick, asking Buildbucket for the build status
[13:13:53.163] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:53.163] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:257:0) after 1m0s
[13:14:53.322] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:257:0)
[13:14:53.322] Timer tick, asking Buildbucket for the build status
[13:14:53.463] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:53.463] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:258:0) after 1m0s
[13:15:53.685] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:258:0)
[13:15:53.685] Timer tick, asking Buildbucket for the build status
[13:15:53.760] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:53.760] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:259:0) after 1m0s
[13:16:53.881] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:259:0)
[13:16:53.881] Timer tick, asking Buildbucket for the build status
[13:16:53.958] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:53.958] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:260:0) after 1m0s
[13:17:53.987] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:260:0)
[13:17:53.987] Timer tick, asking Buildbucket for the build status
[13:17:54.061] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:54.061] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:261:0) after 1m0s
[13:18:54.068] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:261:0)
[13:18:54.068] Timer tick, asking Buildbucket for the build status
[13:18:54.173] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:54.173] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:262:0) after 1m0s
[13:19:54.208] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:262:0)
[13:19:54.208] Timer tick, asking Buildbucket for the build status
[13:19:54.433] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:54.433] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:263:0) after 1m0s
[13:20:54.483] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:263:0)
[13:20:54.483] Timer tick, asking Buildbucket for the build status
[13:20:54.566] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:54.567] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:264:0) after 1m0s
[13:21:54.610] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:264:0)
[13:21:54.610] Timer tick, asking Buildbucket for the build status
[13:21:54.676] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:54.676] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:265:0) after 1m0s
[13:22:54.679] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:265:0)
[13:22:54.679] Timer tick, asking Buildbucket for the build status
[13:22:54.766] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:54.766] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:266:0) after 1m0s
[13:23:54.811] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:266:0)
[13:23:54.811] Timer tick, asking Buildbucket for the build status
[13:23:55.126] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:55.126] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:267:0) after 1m0s
[13:24:55.136] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:267:0)
[13:24:55.137] Timer tick, asking Buildbucket for the build status
[13:24:55.836] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:55.836] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:268:0) after 1m0s
[13:25:55.861] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:268:0)
[13:25:55.861] Timer tick, asking Buildbucket for the build status
[13:25:55.990] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:55.990] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:269:0) after 1m0s
[13:26:56.052] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:269:0)
[13:26:56.052] Timer tick, asking Buildbucket for the build status
[13:26:56.200] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:56.200] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:270:0) after 1m0s
[13:27:56.252] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:270:0)
[13:27:56.252] Timer tick, asking Buildbucket for the build status
[13:27:56.436] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:56.436] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:271:0) after 1m0s
[13:28:56.486] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:271:0)
[13:28:56.486] Timer tick, asking Buildbucket for the build status
[13:28:56.560] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:56.560] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:272:0) after 1m0s
[13:29:56.601] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:272:0)
[13:29:56.601] Timer tick, asking Buildbucket for the build status
[13:29:56.774] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:56.774] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:273:0) after 1m0s
[13:30:56.832] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:273:0)
[13:30:56.832] Timer tick, asking Buildbucket for the build status
[13:30:57.264] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:57.264] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:274:0) after 1m0s
[13:31:57.324] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:274:0)
[13:31:57.324] Timer tick, asking Buildbucket for the build status
[13:31:57.396] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:57.396] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:275:0) after 1m0s
[13:32:57.388] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:275:0)
[13:32:57.388] Timer tick, asking Buildbucket for the build status
[13:32:57.481] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:57.481] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:276:0) after 1m0s
[13:33:57.572] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:276:0)
[13:33:57.572] Timer tick, asking Buildbucket for the build status
[13:33:58.023] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:58.023] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:277:0) after 1m0s
[13:34:58.096] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:277:0)
[13:34:58.096] Timer tick, asking Buildbucket for the build status
[13:34:58.181] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:58.181] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:278:0) after 1m0s
[13:35:58.238] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:278:0)
[13:35:58.238] Timer tick, asking Buildbucket for the build status
[13:35:58.300] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:58.300] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:279:0) after 1m0s
[13:36:58.337] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:279:0)
[13:36:58.337] Timer tick, asking Buildbucket for the build status
[13:36:58.392] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:58.392] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:280:0) after 1m0s
[13:37:58.424] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:280:0)
[13:37:58.424] Timer tick, asking Buildbucket for the build status
[13:37:58.533] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:58.533] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:281:0) after 1m0s
[13:38:58.579] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:281:0)
[13:38:58.579] Timer tick, asking Buildbucket for the build status
[13:38:58.999] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:58.999] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:282:0) after 1m0s
[13:39:58.990] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:282:0)
[13:39:58.990] Timer tick, asking Buildbucket for the build status
[13:39:59.129] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:59.129] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:283:0) after 1m0s
[13:40:59.157] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:283:0)
[13:40:59.157] Timer tick, asking Buildbucket for the build status
[13:40:59.284] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:59.284] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:284:0) after 1m0s
[13:41:59.322] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:284:0)
[13:41:59.322] Timer tick, asking Buildbucket for the build status
[13:41:59.391] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:59.391] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:285:0) after 1m0s
[13:42:59.426] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:285:0)
[13:42:59.426] Timer tick, asking Buildbucket for the build status
[13:42:59.523] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:59.523] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:286:0) after 1m0s
[13:43:59.639] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:286:0)
[13:43:59.639] Timer tick, asking Buildbucket for the build status
[13:43:59.741] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:59.741] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:287:0) after 1m0s
[13:44:59.816] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:287:0)
[13:44:59.816] Timer tick, asking Buildbucket for the build status
[13:44:59.923] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:59.923] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:288:0) after 1m0s
[13:45:59.981] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:288:0)
[13:45:59.981] Timer tick, asking Buildbucket for the build status
[13:46:00.130] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:00.130] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:289:0) after 1m0s
[13:47:00.164] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:289:0)
[13:47:00.164] Timer tick, asking Buildbucket for the build status
[13:47:00.235] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:00.235] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:290:0) after 1m0s
[13:48:00.860] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:290:0)
[13:48:00.860] Timer tick, asking Buildbucket for the build status
[13:48:01.011] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:01.011] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:291:0) after 1m0s
[13:49:02.494] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:291:0)
[13:49:02.494] Timer tick, asking Buildbucket for the build status
[13:49:02.587] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:02.587] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:292:0) after 1m0s
[13:50:02.655] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:292:0)
[13:50:02.655] Timer tick, asking Buildbucket for the build status
[13:50:02.731] Build 8861584526089812208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:02.731] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027014588318528224:293:0) after 1m0s
[13:50:30.034] Received PubSub notification, asking Buildbucket for the build status
[13:50:30.095] Build 8861584526089812208: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[13:50:30.095] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1607349029099061",
"created_by": "project:chromium",
"created_ts": "1607331457013249",
"id": "8861584526089812208",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c008e4d4010d603c5216e619081fba7be0514aa4\"}}",
"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}, \"$kitchen/crbug_1150511_keys_with_int_value\": [\"$recipe_engine/buildbucket.build.infra.swarming.priority\", \"$recipe_engine/buildbucket.build.number\", \"buildnumber\"], \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"c008e4d4010d603c5216e619081fba7be0514aa4\", \"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-3-t6xb\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 1134, \"got_angle_revision\": \"251ba5cb119ff2fed0e861cbc9b096c45004c1fa\", \"got_dawn_revision\": \"d63d562d1b26e01b369d9a58eddeaccfaa688a02\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"c008e4d4010d603c5216e619081fba7be0514aa4\", \"got_revision_cp\": \"refs/heads/master@{#834146}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"7c84426d2abe231f3087a2942fd831137eb3b0aa\", \"got_v8_revision\": \"61f3e61408129afc0d9e1268d3354a283ea3c881\", \"got_v8_revision_cp\": \"refs/heads/8.9.100@{#1}\", \"got_webrtc_revision\": \"393159147685c9294e423eb8b2bdc92dc78acfd4\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32780}\", \"mirrored_builders\": [\"tryserver.chromium:win-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c008e4d4010d603c5216e619081fba7be0514aa4\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_9b3ebe5fd1c5be87380c40d216747346a59b28cf26de183f0e8e2b32e944d3c8_v2\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-3-t6xb\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5640-d0eb544\"], \"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": "1607331666358645",
"status": "COMPLETED",
"status_changed_ts": "1607349029823335",
"tags": [
"build_address:luci.chromium.ci/win-official/1134",
"builder:win-official",
"buildset:commit/git/c008e4d4010d603c5216e619081fba7be0514aa4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c008e4d4010d603c5216e619081fba7be0514aa4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027014588318528224",
"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/8861584526089812208/+/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:50553d3dac210510",
"user_agent:luci-scheduler"
],
"updated_ts": "1607349029828572",
"url": "https://ci.chromium.org/b/8861584526089812208",
"utcnow_ts": "1607349030086788"
}
}
[13:50:30.095] Invocation finished in 4h52m54.590859533s with status SUCCEEDED