[22:33:27.550] New invocation is queued and will start shortly
[22:33:29.950] Starting the invocation (attempt 1)
[22:33:30.002] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:33:30.002] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:33:30.002] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018718934474160336",
"parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"b9ad3ff31faac231c602a9465f0094205c27e1bc\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-official",
"scheduler_invocation_id:9018718934474160336",
"scheduler_job_id:chromium/win-official",
"user_agent:luci-scheduler",
"buildset:commit/git/b9ad3ff31faac231c602a9465f0094205c27e1bc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b9ad3ff31faac231c602a9465f0094205c27e1bc",
"gitiles_ref:refs/heads/master"
]
}
[22:33:30.640] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615242810089067",
"id": "8853288871125934544",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b9ad3ff31faac231c602a9465f0094205c27e1bc\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615242810541324",
"tags": [
"build_address:luci.chromium.ci/win-official/1716",
"builder:win-official",
"buildset:commit/git/b9ad3ff31faac231c602a9465f0094205c27e1bc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b9ad3ff31faac231c602a9465f0094205c27e1bc",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018718934474160336",
"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/8853288871125934544/+/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": "1615242810541427",
"url": "https://ci.chromium.org/b/8853288871125934544",
"utcnow_ts": "1615242810633959"
}
}
[22:33:30.640] Task URL: https://ci.chromium.org/b/8853288871125934544
[22:33:30.640] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:2:0) after 1m0s
[22:33:33.743] Received PubSub notification, asking Buildbucket for the build status
[22:33:33.905] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:31.360] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:2:0)
[22:34:31.360] Timer tick, asking Buildbucket for the build status
[22:34:31.462] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:31.462] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:4:0) after 1m0s
[22:35:31.648] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:4:0)
[22:35:31.648] Timer tick, asking Buildbucket for the build status
[22:35:31.712] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:31.712] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:5:0) after 1m0s
[22:36:31.929] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:5:0)
[22:36:31.929] Timer tick, asking Buildbucket for the build status
[22:36:32.007] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:32.007] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:6:0) after 1m0s
[22:37:32.228] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:6:0)
[22:37:32.228] Timer tick, asking Buildbucket for the build status
[22:37:32.310] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:32.310] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:7:0) after 1m0s
[22:38:32.451] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:7:0)
[22:38:32.451] Timer tick, asking Buildbucket for the build status
[22:38:32.961] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:32.961] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:8:0) after 1m0s
[22:39:33.174] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:8:0)
[22:39:33.174] Timer tick, asking Buildbucket for the build status
[22:39:33.617] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:33.617] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:9:0) after 1m0s
[22:40:33.936] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:9:0)
[22:40:33.936] Timer tick, asking Buildbucket for the build status
[22:40:34.066] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:34.066] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:10:0) after 1m0s
[22:41:34.132] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:10:0)
[22:41:34.132] Timer tick, asking Buildbucket for the build status
[22:41:34.263] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:34.263] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:11:0) after 1m0s
[22:42:34.295] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:11:0)
[22:42:34.295] Timer tick, asking Buildbucket for the build status
[22:42:34.564] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:34.564] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:12:0) after 1m0s
[22:43:34.585] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:12:0)
[22:43:34.585] Timer tick, asking Buildbucket for the build status
[22:43:34.686] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:34.686] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:13:0) after 1m0s
[22:44:34.697] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:13:0)
[22:44:34.697] Timer tick, asking Buildbucket for the build status
[22:44:34.903] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:34.903] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:14:0) after 1m0s
[22:45:35.118] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:14:0)
[22:45:35.118] Timer tick, asking Buildbucket for the build status
[22:45:35.184] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:35.184] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:15:0) after 1m0s
[22:46:35.216] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:15:0)
[22:46:35.216] Timer tick, asking Buildbucket for the build status
[22:46:35.443] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:35.443] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:16:0) after 1m0s
[22:47:35.593] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:16:0)
[22:47:35.593] Timer tick, asking Buildbucket for the build status
[22:47:35.682] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:35.682] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:17:0) after 1m0s
[22:48:35.878] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:17:0)
[22:48:35.878] Timer tick, asking Buildbucket for the build status
[22:48:35.948] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:35.948] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:18:0) after 1m0s
[22:49:35.979] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:18:0)
[22:49:35.979] Timer tick, asking Buildbucket for the build status
[22:49:36.135] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:36.135] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:19:0) after 1m0s
[22:50:36.196] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:19:0)
[22:50:36.196] Timer tick, asking Buildbucket for the build status
[22:50:36.291] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:36.291] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:20:0) after 1m0s
[22:51:36.398] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:20:0)
[22:51:36.398] Timer tick, asking Buildbucket for the build status
[22:51:36.507] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:36.507] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:21:0) after 1m0s
[22:52:36.633] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:21:0)
[22:52:36.633] Timer tick, asking Buildbucket for the build status
[22:52:36.706] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:36.706] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:22:0) after 1m0s
[22:53:36.745] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:22:0)
[22:53:36.745] Timer tick, asking Buildbucket for the build status
[22:53:36.829] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:36.829] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:23:0) after 1m0s
[22:54:38.040] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:23:0)
[22:54:38.040] Timer tick, asking Buildbucket for the build status
[22:54:38.142] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:38.142] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:24:0) after 1m0s
[22:55:38.332] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:24:0)
[22:55:38.332] Timer tick, asking Buildbucket for the build status
[22:55:38.408] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:38.408] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:25:0) after 1m0s
[22:56:38.876] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:25:0)
[22:56:38.876] Timer tick, asking Buildbucket for the build status
[22:56:40.538] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:40.538] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:26:0) after 1m0s
[22:57:40.711] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:26:0)
[22:57:40.711] Timer tick, asking Buildbucket for the build status
[22:57:40.854] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:40.854] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:27:0) after 1m0s
[22:58:41.096] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:27:0)
[22:58:41.096] Timer tick, asking Buildbucket for the build status
[22:58:41.233] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:41.233] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:28:0) after 1m0s
[22:59:41.316] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:28:0)
[22:59:41.316] Timer tick, asking Buildbucket for the build status
[22:59:41.448] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:41.448] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:29:0) after 1m0s
[23:00:43.370] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:29:0)
[23:00:43.370] Timer tick, asking Buildbucket for the build status
[23:00:43.513] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:43.513] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:30:0) after 1m0s
[23:01:43.770] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:30:0)
[23:01:43.770] Timer tick, asking Buildbucket for the build status
[23:01:44.171] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:44.171] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:31:0) after 1m0s
[23:02:44.207] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:31:0)
[23:02:44.207] Timer tick, asking Buildbucket for the build status
[23:02:44.513] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:44.513] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:32:0) after 1m0s
[23:03:44.543] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:32:0)
[23:03:44.543] Timer tick, asking Buildbucket for the build status
[23:03:44.620] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:44.620] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:33:0) after 1m0s
[23:04:44.662] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:33:0)
[23:04:44.662] Timer tick, asking Buildbucket for the build status
[23:04:44.772] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:44.772] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:34:0) after 1m0s
[23:05:44.835] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:34:0)
[23:05:44.835] Timer tick, asking Buildbucket for the build status
[23:05:44.948] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:44.948] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:35:0) after 1m0s
[23:06:45.135] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:35:0)
[23:06:45.135] Timer tick, asking Buildbucket for the build status
[23:06:45.418] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:45.418] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:36:0) after 1m0s
[23:07:45.449] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:36:0)
[23:07:45.449] Timer tick, asking Buildbucket for the build status
[23:07:45.600] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:45.600] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:37:0) after 1m0s
[23:08:45.620] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:37:0)
[23:08:45.620] Timer tick, asking Buildbucket for the build status
[23:08:45.912] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:45.912] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:38:0) after 1m0s
[23:09:45.951] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:38:0)
[23:09:45.951] Timer tick, asking Buildbucket for the build status
[23:09:46.092] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:46.092] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:39:0) after 1m0s
[23:10:46.183] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:39:0)
[23:10:46.183] Timer tick, asking Buildbucket for the build status
[23:10:46.294] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:46.294] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:40:0) after 1m0s
[23:11:46.309] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:40:0)
[23:11:46.309] Timer tick, asking Buildbucket for the build status
[23:11:46.382] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:46.382] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:41:0) after 1m0s
[23:12:46.415] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:41:0)
[23:12:46.415] Timer tick, asking Buildbucket for the build status
[23:12:46.529] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:46.529] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:42:0) after 1m0s
[23:13:46.557] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:42:0)
[23:13:46.557] Timer tick, asking Buildbucket for the build status
[23:13:46.650] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:46.650] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:43:0) after 1m0s
[23:14:46.711] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:43:0)
[23:14:46.711] Timer tick, asking Buildbucket for the build status
[23:14:46.831] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:46.831] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:44:0) after 1m0s
[23:15:48.061] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:44:0)
[23:15:48.061] Timer tick, asking Buildbucket for the build status
[23:15:48.139] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:48.139] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:45:0) after 1m0s
[23:16:48.350] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:45:0)
[23:16:48.350] Timer tick, asking Buildbucket for the build status
[23:16:48.431] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:48.431] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:46:0) after 1m0s
[23:17:48.574] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:46:0)
[23:17:48.574] Timer tick, asking Buildbucket for the build status
[23:17:48.827] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:48.827] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:47:0) after 1m0s
[23:18:48.939] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:47:0)
[23:18:48.939] Timer tick, asking Buildbucket for the build status
[23:18:49.030] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:49.030] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:48:0) after 1m0s
[23:19:49.013] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:48:0)
[23:19:49.013] Timer tick, asking Buildbucket for the build status
[23:19:49.088] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:49.088] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:49:0) after 1m0s
[23:20:49.454] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:49:0)
[23:20:49.454] Timer tick, asking Buildbucket for the build status
[23:20:49.573] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:49.573] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:50:0) after 1m0s
[23:21:49.588] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:50:0)
[23:21:49.588] Timer tick, asking Buildbucket for the build status
[23:21:49.655] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:49.655] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:51:0) after 1m0s
[23:22:49.682] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:51:0)
[23:22:49.682] Timer tick, asking Buildbucket for the build status
[23:22:49.757] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:49.757] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:52:0) after 1m0s
[23:23:49.834] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:52:0)
[23:23:49.834] Timer tick, asking Buildbucket for the build status
[23:23:50.188] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:50.188] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:53:0) after 1m0s
[23:24:50.315] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:53:0)
[23:24:50.315] Timer tick, asking Buildbucket for the build status
[23:24:50.389] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:50.389] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:54:0) after 1m0s
[23:25:50.650] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:54:0)
[23:25:50.650] Timer tick, asking Buildbucket for the build status
[23:25:50.717] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:50.717] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:55:0) after 1m0s
[23:26:51.447] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:55:0)
[23:26:51.447] Timer tick, asking Buildbucket for the build status
[23:26:51.785] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:51.785] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:56:0) after 1m0s
[23:27:51.824] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:56:0)
[23:27:51.824] Timer tick, asking Buildbucket for the build status
[23:27:52.026] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:52.026] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:57:0) after 1m0s
[23:28:52.045] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:57:0)
[23:28:52.045] Timer tick, asking Buildbucket for the build status
[23:28:52.133] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:52.133] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:58:0) after 1m0s
[23:29:52.794] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:58:0)
[23:29:52.794] Timer tick, asking Buildbucket for the build status
[23:29:52.947] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:52.947] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:59:0) after 1m0s
[23:30:53.279] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:59:0)
[23:30:53.279] Timer tick, asking Buildbucket for the build status
[23:30:53.445] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:53.445] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:60:0) after 1m0s
[23:31:53.641] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:60:0)
[23:31:53.641] Timer tick, asking Buildbucket for the build status
[23:31:53.694] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:53.694] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:61:0) after 1m0s
[23:32:53.792] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:61:0)
[23:32:53.792] Timer tick, asking Buildbucket for the build status
[23:32:53.863] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:53.863] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:62:0) after 1m0s
[23:33:53.969] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:62:0)
[23:33:53.969] Timer tick, asking Buildbucket for the build status
[23:33:54.041] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:54.041] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:63:0) after 1m0s
[23:34:54.169] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:63:0)
[23:34:54.169] Timer tick, asking Buildbucket for the build status
[23:34:54.226] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:54.226] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:64:0) after 1m0s
[23:35:54.317] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:64:0)
[23:35:54.317] Timer tick, asking Buildbucket for the build status
[23:35:54.446] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:54.446] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:65:0) after 1m0s
[23:36:54.581] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:65:0)
[23:36:54.581] Timer tick, asking Buildbucket for the build status
[23:36:55.304] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:55.304] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:66:0) after 1m0s
[23:37:55.368] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:66:0)
[23:37:55.368] Timer tick, asking Buildbucket for the build status
[23:37:55.449] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:55.449] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:67:0) after 1m0s
[23:38:55.519] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:67:0)
[23:38:55.519] Timer tick, asking Buildbucket for the build status
[23:38:55.610] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:55.610] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:68:0) after 1m0s
[23:39:55.765] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:68:0)
[23:39:55.765] Timer tick, asking Buildbucket for the build status
[23:39:55.831] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:55.831] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:69:0) after 1m0s
[23:40:55.998] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:69:0)
[23:40:55.998] Timer tick, asking Buildbucket for the build status
[23:40:56.166] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:56.166] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:70:0) after 1m0s
[23:41:56.199] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:70:0)
[23:41:56.199] Timer tick, asking Buildbucket for the build status
[23:41:56.579] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:56.579] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:71:0) after 1m0s
[23:42:56.664] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:71:0)
[23:42:56.665] Timer tick, asking Buildbucket for the build status
[23:42:56.731] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:56.731] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:72:0) after 1m0s
[23:43:56.794] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:72:0)
[23:43:56.794] Timer tick, asking Buildbucket for the build status
[23:43:56.931] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:56.931] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:73:0) after 1m0s
[23:44:56.935] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:73:0)
[23:44:56.935] Timer tick, asking Buildbucket for the build status
[23:44:57.246] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:57.246] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:74:0) after 1m0s
[23:45:57.254] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:74:0)
[23:45:57.254] Timer tick, asking Buildbucket for the build status
[23:45:57.511] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:57.511] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:75:0) after 1m0s
[23:46:57.573] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:75:0)
[23:46:57.573] Timer tick, asking Buildbucket for the build status
[23:46:57.750] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:57.750] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:76:0) after 1m0s
[23:47:57.771] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:76:0)
[23:47:57.771] Timer tick, asking Buildbucket for the build status
[23:47:57.868] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:57.868] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:77:0) after 1m0s
[23:48:57.876] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:77:0)
[23:48:57.876] Timer tick, asking Buildbucket for the build status
[23:48:58.012] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:58.012] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:78:0) after 1m0s
[23:49:58.024] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:78:0)
[23:49:58.024] Timer tick, asking Buildbucket for the build status
[23:49:58.183] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:58.183] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:79:0) after 1m0s
[23:50:58.226] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:79:0)
[23:50:58.226] Timer tick, asking Buildbucket for the build status
[23:50:58.317] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:58.317] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:80:0) after 1m0s
[23:51:58.323] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:80:0)
[23:51:58.323] Timer tick, asking Buildbucket for the build status
[23:51:58.478] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:58.478] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:81:0) after 1m0s
[23:52:58.494] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:81:0)
[23:52:58.494] Timer tick, asking Buildbucket for the build status
[23:52:58.547] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:58.547] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:82:0) after 1m0s
[23:53:58.623] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:82:0)
[23:53:58.623] Timer tick, asking Buildbucket for the build status
[23:53:58.686] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:58.686] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:83:0) after 1m0s
[23:54:58.827] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:83:0)
[23:54:58.827] Timer tick, asking Buildbucket for the build status
[23:54:58.888] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:58.888] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:84:0) after 1m0s
[23:55:59.011] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:84:0)
[23:55:59.011] Timer tick, asking Buildbucket for the build status
[23:55:59.175] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:59.175] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:85:0) after 1m0s
[23:56:59.227] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:85:0)
[23:56:59.227] Timer tick, asking Buildbucket for the build status
[23:56:59.362] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:59.362] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:86:0) after 1m0s
[23:57:59.749] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:86:0)
[23:57:59.749] Timer tick, asking Buildbucket for the build status
[23:57:59.815] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:59.815] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:87:0) after 1m0s
[23:59:00.408] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:87:0)
[23:59:00.408] Timer tick, asking Buildbucket for the build status
[23:59:00.655] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:00.655] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:88:0) after 1m0s
[00:00:01.038] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:88:0)
[00:00:01.038] Timer tick, asking Buildbucket for the build status
[00:00:01.315] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:01.315] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:89:0) after 1m0s
[00:01:01.336] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:89:0)
[00:01:01.336] Timer tick, asking Buildbucket for the build status
[00:01:01.522] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:01.522] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:90:0) after 1m0s
[00:02:01.635] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:90:0)
[00:02:01.635] Timer tick, asking Buildbucket for the build status
[00:02:01.733] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:01.733] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:91:0) after 1m0s
[00:03:02.172] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:91:0)
[00:03:02.172] Timer tick, asking Buildbucket for the build status
[00:03:02.441] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:02.441] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:92:0) after 1m0s
[00:04:02.549] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:92:0)
[00:04:02.549] Timer tick, asking Buildbucket for the build status
[00:04:02.649] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:02.649] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:93:0) after 1m0s
[00:05:02.675] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:93:0)
[00:05:02.675] Timer tick, asking Buildbucket for the build status
[00:05:02.745] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:02.745] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:94:0) after 1m0s
[00:06:02.829] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:94:0)
[00:06:02.829] Timer tick, asking Buildbucket for the build status
[00:06:02.934] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:02.934] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:95:0) after 1m0s
[00:07:03.003] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:95:0)
[00:07:03.003] Timer tick, asking Buildbucket for the build status
[00:07:03.086] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:03.086] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:96:0) after 1m0s
[00:08:03.373] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:96:0)
[00:08:03.373] Timer tick, asking Buildbucket for the build status
[00:08:03.470] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:03.470] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:97:0) after 1m0s
[00:09:04.358] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:97:0)
[00:09:04.358] Timer tick, asking Buildbucket for the build status
[00:09:04.423] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:04.423] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:98:0) after 1m0s
[00:10:04.452] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:98:0)
[00:10:04.452] Timer tick, asking Buildbucket for the build status
[00:10:04.521] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:04.521] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:99:0) after 1m0s
[00:11:05.126] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:99:0)
[00:11:05.126] Timer tick, asking Buildbucket for the build status
[00:11:05.225] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:05.225] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:100:0) after 1m0s
[00:12:05.494] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:100:0)
[00:12:05.494] Timer tick, asking Buildbucket for the build status
[00:12:05.557] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:05.557] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:101:0) after 1m0s
[00:13:05.642] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:101:0)
[00:13:05.642] Timer tick, asking Buildbucket for the build status
[00:13:05.722] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:05.722] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:102:0) after 1m0s
[00:14:05.882] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:102:0)
[00:14:05.882] Timer tick, asking Buildbucket for the build status
[00:14:07.340] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:07.340] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:103:0) after 1m0s
[00:15:07.549] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:103:0)
[00:15:07.549] Timer tick, asking Buildbucket for the build status
[00:15:07.718] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:07.718] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:104:0) after 1m0s
[00:16:07.938] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:104:0)
[00:16:07.938] Timer tick, asking Buildbucket for the build status
[00:16:08.107] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:08.107] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:105:0) after 1m0s
[00:17:08.271] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:105:0)
[00:17:08.271] Timer tick, asking Buildbucket for the build status
[00:17:08.379] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:08.379] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:106:0) after 1m0s
[00:18:08.393] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:106:0)
[00:18:08.393] Timer tick, asking Buildbucket for the build status
[00:18:08.483] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:08.483] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:107:0) after 1m0s
[00:19:08.501] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:107:0)
[00:19:08.501] Timer tick, asking Buildbucket for the build status
[00:19:25.882] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:25.882] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:108:0) after 1m0s
[00:20:25.882] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:108:0)
[00:20:25.882] Timer tick, asking Buildbucket for the build status
[00:20:25.974] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:25.974] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:109:0) after 1m0s
[00:21:25.999] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:109:0)
[00:21:25.999] Timer tick, asking Buildbucket for the build status
[00:21:26.094] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:26.094] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:110:0) after 1m0s
[00:22:26.081] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:110:0)
[00:22:26.081] Timer tick, asking Buildbucket for the build status
[00:22:26.152] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:26.152] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:111:0) after 1m0s
[00:23:26.250] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:111:0)
[00:23:26.250] Timer tick, asking Buildbucket for the build status
[00:23:26.324] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:26.324] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:112:0) after 1m0s
[00:24:26.442] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:112:0)
[00:24:26.442] Timer tick, asking Buildbucket for the build status
[00:24:26.540] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:26.540] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:113:0) after 1m0s
[00:25:26.552] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:113:0)
[00:25:26.552] Timer tick, asking Buildbucket for the build status
[00:25:26.846] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:26.846] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:114:0) after 1m0s
[00:26:26.906] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:114:0)
[00:26:26.906] Timer tick, asking Buildbucket for the build status
[00:26:27.045] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:27.045] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:115:0) after 1m0s
[00:27:27.083] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:115:0)
[00:27:27.083] Timer tick, asking Buildbucket for the build status
[00:27:27.262] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:27.262] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:116:0) after 1m0s
[00:28:27.308] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:116:0)
[00:28:27.308] Timer tick, asking Buildbucket for the build status
[00:28:27.448] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:27.448] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:117:0) after 1m0s
[00:29:27.488] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:117:0)
[00:29:27.488] Timer tick, asking Buildbucket for the build status
[00:29:27.633] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:27.633] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:118:0) after 1m0s
[00:30:27.655] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:118:0)
[00:30:27.655] Timer tick, asking Buildbucket for the build status
[00:30:27.736] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:27.736] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:119:0) after 1m0s
[00:31:27.805] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:119:0)
[00:31:27.805] Timer tick, asking Buildbucket for the build status
[00:31:27.962] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:27.962] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:120:0) after 1m0s
[00:32:27.986] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:120:0)
[00:32:27.986] Timer tick, asking Buildbucket for the build status
[00:32:28.115] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:28.115] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:121:0) after 1m0s
[00:33:28.564] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:121:0)
[00:33:28.564] Timer tick, asking Buildbucket for the build status
[00:33:28.848] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:28.848] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:122:0) after 1m0s
[00:34:29.093] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:122:0)
[00:34:29.093] Timer tick, asking Buildbucket for the build status
[00:34:29.336] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:29.336] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:123:0) after 1m0s
[00:35:29.440] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:123:0)
[00:35:29.440] Timer tick, asking Buildbucket for the build status
[00:35:31.572] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:31.572] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:124:0) after 1m0s
[00:36:31.695] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:124:0)
[00:36:31.695] Timer tick, asking Buildbucket for the build status
[00:36:35.164] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:35.164] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:125:0) after 1m0s
[00:37:36.218] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:125:0)
[00:37:36.218] Timer tick, asking Buildbucket for the build status
[00:37:36.291] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:36.291] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:126:0) after 1m0s
[00:38:36.303] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:126:0)
[00:38:36.303] Timer tick, asking Buildbucket for the build status
[00:38:36.397] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:36.397] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:127:0) after 1m0s
[00:39:36.685] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:127:0)
[00:39:36.685] Timer tick, asking Buildbucket for the build status
[00:39:36.818] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:36.818] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:128:0) after 1m0s
[00:40:36.887] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:128:0)
[00:40:36.887] Timer tick, asking Buildbucket for the build status
[00:40:36.974] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:36.974] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:129:0) after 1m0s
[00:41:37.161] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:129:0)
[00:41:37.161] Timer tick, asking Buildbucket for the build status
[00:41:37.308] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:37.308] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:130:0) after 1m0s
[00:42:37.435] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:130:0)
[00:42:37.435] Timer tick, asking Buildbucket for the build status
[00:42:37.576] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:37.576] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:131:0) after 1m0s
[00:43:37.639] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:131:0)
[00:43:37.639] Timer tick, asking Buildbucket for the build status
[00:43:37.724] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:37.724] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:132:0) after 1m0s
[00:44:37.779] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:132:0)
[00:44:37.779] Timer tick, asking Buildbucket for the build status
[00:44:37.863] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:37.863] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:133:0) after 1m0s
[00:45:37.901] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:133:0)
[00:45:37.901] Timer tick, asking Buildbucket for the build status
[00:45:38.099] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:38.099] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:134:0) after 1m0s
[00:46:38.128] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:134:0)
[00:46:38.128] Timer tick, asking Buildbucket for the build status
[00:46:38.224] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:38.224] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:135:0) after 1m0s
[00:47:38.282] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:135:0)
[00:47:38.282] Timer tick, asking Buildbucket for the build status
[00:47:38.346] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:38.346] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:136:0) after 1m0s
[00:48:38.368] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:136:0)
[00:48:38.368] Timer tick, asking Buildbucket for the build status
[00:48:38.541] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:38.541] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:137:0) after 1m0s
[00:49:38.612] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:137:0)
[00:49:38.612] Timer tick, asking Buildbucket for the build status
[00:49:38.681] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:38.681] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:138:0) after 1m0s
[00:50:38.663] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:138:0)
[00:50:38.663] Timer tick, asking Buildbucket for the build status
[00:50:38.733] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:38.733] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:139:0) after 1m0s
[00:51:38.772] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:139:0)
[00:51:38.772] Timer tick, asking Buildbucket for the build status
[00:51:38.881] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:38.881] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:140:0) after 1m0s
[00:52:38.902] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:140:0)
[00:52:38.902] Timer tick, asking Buildbucket for the build status
[00:52:39.029] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:39.029] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:141:0) after 1m0s
[00:53:39.055] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:141:0)
[00:53:39.055] Timer tick, asking Buildbucket for the build status
[00:53:39.329] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:39.329] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:142:0) after 1m0s
[00:54:39.359] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:142:0)
[00:54:39.359] Timer tick, asking Buildbucket for the build status
[00:54:39.516] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:39.516] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:143:0) after 1m0s
[00:55:39.662] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:143:0)
[00:55:39.662] Timer tick, asking Buildbucket for the build status
[00:55:39.961] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:39.961] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:144:0) after 1m0s
[00:56:39.988] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:144:0)
[00:56:39.988] Timer tick, asking Buildbucket for the build status
[00:56:40.512] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:40.512] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:145:0) after 1m0s
[00:57:40.536] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:145:0)
[00:57:40.536] Timer tick, asking Buildbucket for the build status
[00:57:40.666] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:40.666] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:146:0) after 1m0s
[00:58:40.712] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:146:0)
[00:58:40.712] Timer tick, asking Buildbucket for the build status
[00:58:40.822] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:40.822] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:147:0) after 1m0s
[00:59:40.910] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:147:0)
[00:59:40.910] Timer tick, asking Buildbucket for the build status
[00:59:41.249] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:41.249] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:148:0) after 1m0s
[01:00:41.267] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:148:0)
[01:00:41.267] Timer tick, asking Buildbucket for the build status
[01:00:41.367] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:41.367] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:149:0) after 1m0s
[01:01:41.418] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:149:0)
[01:01:41.418] Timer tick, asking Buildbucket for the build status
[01:01:41.506] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:41.506] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:150:0) after 1m0s
[01:02:41.553] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:150:0)
[01:02:41.553] Timer tick, asking Buildbucket for the build status
[01:02:41.624] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:41.624] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:151:0) after 1m0s
[01:03:41.691] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:151:0)
[01:03:41.691] Timer tick, asking Buildbucket for the build status
[01:03:41.762] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:41.762] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:152:0) after 1m0s
[01:04:41.783] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:152:0)
[01:04:41.783] Timer tick, asking Buildbucket for the build status
[01:04:42.243] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:42.243] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:153:0) after 1m0s
[01:05:42.317] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:153:0)
[01:05:42.317] Timer tick, asking Buildbucket for the build status
[01:05:42.616] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:42.616] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:154:0) after 1m0s
[01:06:42.639] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:154:0)
[01:06:42.639] Timer tick, asking Buildbucket for the build status
[01:06:43.221] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:43.221] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:155:0) after 1m0s
[01:07:43.246] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:155:0)
[01:07:43.246] Timer tick, asking Buildbucket for the build status
[01:07:43.325] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:43.325] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:156:0) after 1m0s
[01:08:43.426] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:156:0)
[01:08:43.426] Timer tick, asking Buildbucket for the build status
[01:08:43.573] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:43.573] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:157:0) after 1m0s
[01:09:43.696] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:157:0)
[01:09:43.696] Timer tick, asking Buildbucket for the build status
[01:09:44.227] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:44.227] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:158:0) after 1m0s
[01:10:44.822] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:158:0)
[01:10:44.822] Timer tick, asking Buildbucket for the build status
[01:10:44.893] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:44.893] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:159:0) after 1m0s
[01:11:45.047] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:159:0)
[01:11:45.047] Timer tick, asking Buildbucket for the build status
[01:11:45.247] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:45.248] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:160:0) after 1m0s
[01:12:45.304] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:160:0)
[01:12:45.304] Timer tick, asking Buildbucket for the build status
[01:12:45.637] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:45.637] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:161:0) after 1m0s
[01:13:45.697] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:161:0)
[01:13:45.697] Timer tick, asking Buildbucket for the build status
[01:13:45.958] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:45.958] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:162:0) after 1m0s
[01:14:45.996] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:162:0)
[01:14:45.996] Timer tick, asking Buildbucket for the build status
[01:14:46.233] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:46.233] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:163:0) after 1m0s
[01:15:46.309] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:163:0)
[01:15:46.309] Timer tick, asking Buildbucket for the build status
[01:15:46.374] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:46.374] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:164:0) after 1m0s
[01:16:46.506] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:164:0)
[01:16:46.506] Timer tick, asking Buildbucket for the build status
[01:16:46.714] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:46.714] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:165:0) after 1m0s
[01:17:46.744] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:165:0)
[01:17:46.744] Timer tick, asking Buildbucket for the build status
[01:17:46.825] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:46.825] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:166:0) after 1m0s
[01:18:46.861] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:166:0)
[01:18:46.861] Timer tick, asking Buildbucket for the build status
[01:18:46.970] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:46.970] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:167:0) after 1m0s
[01:19:46.954] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:167:0)
[01:19:46.954] Timer tick, asking Buildbucket for the build status
[01:19:47.041] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:47.041] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:168:0) after 1m0s
[01:20:47.089] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:168:0)
[01:20:47.089] Timer tick, asking Buildbucket for the build status
[01:20:47.173] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:47.173] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:169:0) after 1m0s
[01:21:47.246] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:169:0)
[01:21:47.246] Timer tick, asking Buildbucket for the build status
[01:21:47.357] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:47.357] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:170:0) after 1m0s
[01:22:47.624] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:170:0)
[01:22:47.624] Timer tick, asking Buildbucket for the build status
[01:22:47.691] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:47.691] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:171:0) after 1m0s
[01:23:47.893] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:171:0)
[01:23:47.893] Timer tick, asking Buildbucket for the build status
[01:23:47.958] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:47.958] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:172:0) after 1m0s
[01:24:48.208] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:172:0)
[01:24:48.208] Timer tick, asking Buildbucket for the build status
[01:24:48.324] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:48.324] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:173:0) after 1m0s
[01:25:48.333] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:173:0)
[01:25:48.333] Timer tick, asking Buildbucket for the build status
[01:25:48.412] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:48.412] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:174:0) after 1m0s
[01:26:48.807] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:174:0)
[01:26:48.807] Timer tick, asking Buildbucket for the build status
[01:26:48.936] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:48.936] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:175:0) after 1m0s
[01:27:49.028] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:175:0)
[01:27:49.028] Timer tick, asking Buildbucket for the build status
[01:27:49.103] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:49.103] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:176:0) after 1m0s
[01:28:49.211] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:176:0)
[01:28:49.211] Timer tick, asking Buildbucket for the build status
[01:28:49.289] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:49.289] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:177:0) after 1m0s
[01:29:49.773] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:177:0)
[01:29:49.773] Timer tick, asking Buildbucket for the build status
[01:29:49.960] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:49.960] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:178:0) after 1m0s
[01:30:50.151] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:178:0)
[01:30:50.151] Timer tick, asking Buildbucket for the build status
[01:30:50.227] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:50.227] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:179:0) after 1m0s
[01:31:50.524] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:179:0)
[01:31:50.524] Timer tick, asking Buildbucket for the build status
[01:31:50.770] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:50.770] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:180:0) after 1m0s
[01:32:51.589] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:180:0)
[01:32:51.590] Timer tick, asking Buildbucket for the build status
[01:32:51.660] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:51.660] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:181:0) after 1m0s
[01:33:51.808] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:181:0)
[01:33:51.808] Timer tick, asking Buildbucket for the build status
[01:33:52.201] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:52.201] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:182:0) after 1m0s
[01:34:52.293] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:182:0)
[01:34:52.293] Timer tick, asking Buildbucket for the build status
[01:34:52.436] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:52.436] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:183:0) after 1m0s
[01:35:52.578] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:183:0)
[01:35:52.579] Timer tick, asking Buildbucket for the build status
[01:35:52.745] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:52.745] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:184:0) after 1m0s
[01:36:52.794] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:184:0)
[01:36:52.794] Timer tick, asking Buildbucket for the build status
[01:36:52.999] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:52.999] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:185:0) after 1m0s
[01:37:53.140] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:185:0)
[01:37:53.140] Timer tick, asking Buildbucket for the build status
[01:37:53.230] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:53.230] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:186:0) after 1m0s
[01:38:53.383] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:186:0)
[01:38:53.383] Timer tick, asking Buildbucket for the build status
[01:38:53.475] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:53.475] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:187:0) after 1m0s
[01:39:53.836] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:187:0)
[01:39:53.836] Timer tick, asking Buildbucket for the build status
[01:39:53.902] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:53.902] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:188:0) after 1m0s
[01:40:54.081] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:188:0)
[01:40:54.081] Timer tick, asking Buildbucket for the build status
[01:40:54.183] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:54.183] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:189:0) after 1m0s
[01:41:54.296] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:189:0)
[01:41:54.296] Timer tick, asking Buildbucket for the build status
[01:41:54.437] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:54.437] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:190:0) after 1m0s
[01:42:54.525] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:190:0)
[01:42:54.525] Timer tick, asking Buildbucket for the build status
[01:42:54.721] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:54.721] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:191:0) after 1m0s
[01:43:54.749] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:191:0)
[01:43:54.749] Timer tick, asking Buildbucket for the build status
[01:43:54.853] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:54.853] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:192:0) after 1m0s
[01:44:54.879] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:192:0)
[01:44:54.879] Timer tick, asking Buildbucket for the build status
[01:44:55.213] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:55.213] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:193:0) after 1m0s
[01:45:55.338] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:193:0)
[01:45:55.338] Timer tick, asking Buildbucket for the build status
[01:45:55.421] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:55.421] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:194:0) after 1m0s
[01:46:55.504] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:194:0)
[01:46:55.504] Timer tick, asking Buildbucket for the build status
[01:46:55.710] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:55.710] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:195:0) after 1m0s
[01:47:55.761] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:195:0)
[01:47:55.761] Timer tick, asking Buildbucket for the build status
[01:47:55.857] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:55.857] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:196:0) after 1m0s
[01:48:55.950] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:196:0)
[01:48:55.950] Timer tick, asking Buildbucket for the build status
[01:48:56.008] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:56.008] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:197:0) after 1m0s
[01:49:56.300] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:197:0)
[01:49:56.300] Timer tick, asking Buildbucket for the build status
[01:49:56.764] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:56.764] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:198:0) after 1m0s
[01:50:56.797] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:198:0)
[01:50:56.797] Timer tick, asking Buildbucket for the build status
[01:50:56.896] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:56.896] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:199:0) after 1m0s
[01:51:56.919] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:199:0)
[01:51:56.919] Timer tick, asking Buildbucket for the build status
[01:51:56.980] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:56.980] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:200:0) after 1m0s
[01:52:57.053] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:200:0)
[01:52:57.053] Timer tick, asking Buildbucket for the build status
[01:52:57.134] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:57.134] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:201:0) after 1m0s
[01:53:57.189] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:201:0)
[01:53:57.189] Timer tick, asking Buildbucket for the build status
[01:53:57.268] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:57.268] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:202:0) after 1m0s
[01:54:57.448] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:202:0)
[01:54:57.448] Timer tick, asking Buildbucket for the build status
[01:54:57.508] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:57.508] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:203:0) after 1m0s
[01:55:57.645] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:203:0)
[01:55:57.645] Timer tick, asking Buildbucket for the build status
[01:55:57.717] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:57.717] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:204:0) after 1m0s
[01:56:57.791] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:204:0)
[01:56:57.792] Timer tick, asking Buildbucket for the build status
[01:56:57.954] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:57.954] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:205:0) after 1m0s
[01:57:58.186] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:205:0)
[01:57:58.186] Timer tick, asking Buildbucket for the build status
[01:57:58.373] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:58.373] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:206:0) after 1m0s
[01:58:58.468] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:206:0)
[01:58:58.468] Timer tick, asking Buildbucket for the build status
[01:58:58.542] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:58.542] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:207:0) after 1m0s
[01:59:58.698] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:207:0)
[01:59:58.698] Timer tick, asking Buildbucket for the build status
[01:59:58.794] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:58.794] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:208:0) after 1m0s
[02:00:58.916] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:208:0)
[02:00:58.916] Timer tick, asking Buildbucket for the build status
[02:00:59.190] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:59.190] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:209:0) after 1m0s
[02:01:59.361] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:209:0)
[02:01:59.361] Timer tick, asking Buildbucket for the build status
[02:01:59.674] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:59.674] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:210:0) after 1m0s
[02:02:59.709] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:210:0)
[02:02:59.709] Timer tick, asking Buildbucket for the build status
[02:02:59.816] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:59.817] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:211:0) after 1m0s
[02:04:00.299] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:211:0)
[02:04:00.299] Timer tick, asking Buildbucket for the build status
[02:04:00.506] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:00.506] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:212:0) after 1m0s
[02:05:00.779] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:212:0)
[02:05:00.779] Timer tick, asking Buildbucket for the build status
[02:05:00.876] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:00.876] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:213:0) after 1m0s
[02:06:01.423] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:213:0)
[02:06:01.423] Timer tick, asking Buildbucket for the build status
[02:06:01.554] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:01.554] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:214:0) after 1m0s
[02:07:01.879] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:214:0)
[02:07:01.879] Timer tick, asking Buildbucket for the build status
[02:07:02.559] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:02.559] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:215:0) after 1m0s
[02:08:03.211] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:215:0)
[02:08:03.211] Timer tick, asking Buildbucket for the build status
[02:08:03.424] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:03.424] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:216:0) after 1m0s
[02:09:03.796] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:216:0)
[02:09:03.796] Timer tick, asking Buildbucket for the build status
[02:09:04.011] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:04.011] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:217:0) after 1m0s
[02:10:04.115] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:217:0)
[02:10:04.115] Timer tick, asking Buildbucket for the build status
[02:10:04.389] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:04.389] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:218:0) after 1m0s
[02:11:04.573] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:218:0)
[02:11:04.573] Timer tick, asking Buildbucket for the build status
[02:11:04.659] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:04.659] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:219:0) after 1m0s
[02:12:04.968] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:219:0)
[02:12:04.968] Timer tick, asking Buildbucket for the build status
[02:12:05.067] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:05.067] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:220:0) after 1m0s
[02:13:05.550] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:220:0)
[02:13:05.550] Timer tick, asking Buildbucket for the build status
[02:13:05.641] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:05.641] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:221:0) after 1m0s
[02:14:05.717] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:221:0)
[02:14:05.717] Timer tick, asking Buildbucket for the build status
[02:14:05.868] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:05.868] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:222:0) after 1m0s
[02:15:06.188] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:222:0)
[02:15:06.188] Timer tick, asking Buildbucket for the build status
[02:15:06.526] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:06.526] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:223:0) after 1m0s
[02:16:06.603] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:223:0)
[02:16:06.603] Timer tick, asking Buildbucket for the build status
[02:16:06.776] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:06.776] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:224:0) after 1m0s
[02:17:06.997] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:224:0)
[02:17:06.997] Timer tick, asking Buildbucket for the build status
[02:17:07.072] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:07.072] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:225:0) after 1m0s
[02:18:07.287] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:225:0)
[02:18:07.287] Timer tick, asking Buildbucket for the build status
[02:18:07.457] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:07.457] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:226:0) after 1m0s
[02:19:07.539] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:226:0)
[02:19:07.539] Timer tick, asking Buildbucket for the build status
[02:19:07.616] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:07.616] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:227:0) after 1m0s
[02:20:07.763] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:227:0)
[02:20:07.763] Timer tick, asking Buildbucket for the build status
[02:20:08.052] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:08.052] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:228:0) after 1m0s
[02:21:08.156] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:228:0)
[02:21:08.156] Timer tick, asking Buildbucket for the build status
[02:21:08.546] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:08.546] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:229:0) after 1m0s
[02:22:08.755] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:229:0)
[02:22:08.755] Timer tick, asking Buildbucket for the build status
[02:22:08.927] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:08.927] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:230:0) after 1m0s
[02:23:09.009] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:230:0)
[02:23:09.009] Timer tick, asking Buildbucket for the build status
[02:23:09.522] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:09.522] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:231:0) after 1m0s
[02:24:09.675] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:231:0)
[02:24:09.675] Timer tick, asking Buildbucket for the build status
[02:24:09.750] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:09.750] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:232:0) after 1m0s
[02:25:09.814] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:232:0)
[02:25:09.814] Timer tick, asking Buildbucket for the build status
[02:25:10.064] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:10.064] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:233:0) after 1m0s
[02:26:10.331] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:233:0)
[02:26:10.331] Timer tick, asking Buildbucket for the build status
[02:26:12.200] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:12.200] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:234:0) after 1m0s
[02:27:12.278] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:234:0)
[02:27:12.278] Timer tick, asking Buildbucket for the build status
[02:27:12.340] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:12.340] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:235:0) after 1m0s
[02:28:12.381] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:235:0)
[02:28:12.381] Timer tick, asking Buildbucket for the build status
[02:28:12.451] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:12.451] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:236:0) after 1m0s
[02:29:12.559] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:236:0)
[02:29:12.559] Timer tick, asking Buildbucket for the build status
[02:29:12.737] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:12.737] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:237:0) after 1m0s
[02:30:12.832] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:237:0)
[02:30:12.832] Timer tick, asking Buildbucket for the build status
[02:30:13.038] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:13.038] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:238:0) after 1m0s
[02:31:13.135] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:238:0)
[02:31:13.136] Timer tick, asking Buildbucket for the build status
[02:31:15.441] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:15.441] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:239:0) after 1m0s
[02:32:15.647] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:239:0)
[02:32:15.647] Timer tick, asking Buildbucket for the build status
[02:32:15.747] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:15.747] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:240:0) after 1m0s
[02:33:16.017] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:240:0)
[02:33:16.017] Timer tick, asking Buildbucket for the build status
[02:33:16.087] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:16.087] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:241:0) after 1m0s
[02:34:16.185] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:241:0)
[02:34:16.185] Timer tick, asking Buildbucket for the build status
[02:34:16.360] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:16.360] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:242:0) after 1m0s
[02:35:16.420] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:242:0)
[02:35:16.420] Timer tick, asking Buildbucket for the build status
[02:35:16.557] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:16.557] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:243:0) after 1m0s
[02:36:16.692] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:243:0)
[02:36:16.692] Timer tick, asking Buildbucket for the build status
[02:36:16.800] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:16.800] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:244:0) after 1m0s
[02:37:16.920] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:244:0)
[02:37:16.920] Timer tick, asking Buildbucket for the build status
[02:37:16.983] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:16.983] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:245:0) after 1m0s
[02:38:17.498] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:245:0)
[02:38:17.498] Timer tick, asking Buildbucket for the build status
[02:38:17.568] Build 8853288871125934544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:17.568] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018718934474160336:246:0) after 1m0s
[02:38:59.607] Received PubSub notification, asking Buildbucket for the build status
[02:38:59.700] Build 8853288871125934544: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:38:59.701] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615257538473013",
"created_by": "project:chromium",
"created_ts": "1615242810089067",
"id": "8853288871125934544",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b9ad3ff31faac231c602a9465f0094205c27e1bc\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"b9ad3ff31faac231c602a9465f0094205c27e1bc\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"win-dbg-4-qubl\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 1716, \"got_angle_revision\": \"9bc86c50f283560a3294c256bacccc1accb5bc94\", \"got_dawn_revision\": \"7c3b5740db6be782ca4d2e78139568b67db1fc0f\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"b9ad3ff31faac231c602a9465f0094205c27e1bc\", \"got_revision_cp\": \"refs/heads/master@{#860892}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"de7d5775ab25234a2c14d061e0cda342248a0e6d\", \"got_v8_revision\": \"ad7609182d57f01afd2e2769869b7c3e23282119\", \"got_v8_revision_cp\": \"refs/heads/9.1.65@{#1}\", \"got_webrtc_revision\": \"3208bf102b75e8ec1eaa6640dfa3b545310b1e02\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33382}\", \"is_cached\": true, \"mirrored_builders\": [\"tryserver.chromium:win-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b9ad3ff31faac231c602a9465f0094205c27e1bc\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_9b3ebe5fd1c5be87380c40d216747346a59b28cf26de183f0e8e2b32e944d3c8_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-4-qubl\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5744-5c0a4b4\"], \"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": "1615242813104198",
"status": "COMPLETED",
"status_changed_ts": "1615257539112690",
"tags": [
"build_address:luci.chromium.ci/win-official/1716",
"builder:win-official",
"buildset:commit/git/b9ad3ff31faac231c602a9465f0094205c27e1bc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b9ad3ff31faac231c602a9465f0094205c27e1bc",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018718934474160336",
"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/8853288871125934544/+/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:522ccadde6c66b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1615257539136028",
"url": "https://ci.chromium.org/b/8853288871125934544",
"utcnow_ts": "1615257539691978"
}
}
[02:38:59.702] Invocation finished in 4h5m32.188707275s with status SUCCEEDED