[09:26:14.932] New invocation is queued and will start shortly
[09:26:16.097] Starting the invocation (attempt 1)
[09:26:16.136] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:26:16.136] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:26:16.136] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028371739881673456",
"parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"93f8fa9ab5d7288fd984f90c0eef8d9c5f8c801a\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-official",
"scheduler_invocation_id:9028371739881673456",
"scheduler_job_id:chromium/win-official",
"user_agent:luci-scheduler",
"buildset:commit/git/93f8fa9ab5d7288fd984f90c0eef8d9c5f8c801a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/93f8fa9ab5d7288fd984f90c0eef8d9c5f8c801a",
"gitiles_ref:refs/heads/master"
]
}
[09:26:16.898] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606037176237976",
"id": "8862941677848208848",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"93f8fa9ab5d7288fd984f90c0eef8d9c5f8c801a\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606037176759031",
"tags": [
"build_address:luci.chromium.ci/win-official/1058",
"builder:win-official",
"buildset:commit/git/93f8fa9ab5d7288fd984f90c0eef8d9c5f8c801a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/93f8fa9ab5d7288fd984f90c0eef8d9c5f8c801a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028371739881673456",
"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/8862941677848208848/+/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": "1606037176759164",
"url": "https://ci.chromium.org/b/8862941677848208848",
"utcnow_ts": "1606037176888754"
}
}
[09:26:16.898] Task URL: https://ci.chromium.org/b/8862941677848208848
[09:26:16.898] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:2:0) after 1m0s
[09:26:22.981] Received PubSub notification, asking Buildbucket for the build status
[09:26:23.062] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:16.981] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:2:0)
[09:27:16.981] Timer tick, asking Buildbucket for the build status
[09:27:17.061] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:17.061] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:4:0) after 1m0s
[09:28:17.264] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:4:0)
[09:28:17.264] Timer tick, asking Buildbucket for the build status
[09:28:17.330] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:17.330] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:5:0) after 1m0s
[09:29:17.511] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:5:0)
[09:29:17.511] Timer tick, asking Buildbucket for the build status
[09:29:17.584] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:17.584] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:6:0) after 1m0s
[09:30:17.639] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:6:0)
[09:30:17.639] Timer tick, asking Buildbucket for the build status
[09:30:17.785] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:17.785] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:7:0) after 1m0s
[09:31:17.838] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:7:0)
[09:31:17.838] Timer tick, asking Buildbucket for the build status
[09:31:17.920] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:17.921] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:8:0) after 1m0s
[09:32:17.944] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:8:0)
[09:32:17.944] Timer tick, asking Buildbucket for the build status
[09:32:18.045] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:18.045] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:9:0) after 1m0s
[09:33:18.041] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:9:0)
[09:33:18.041] Timer tick, asking Buildbucket for the build status
[09:33:18.112] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:18.112] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:10:0) after 1m0s
[09:34:18.160] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:10:0)
[09:34:18.160] Timer tick, asking Buildbucket for the build status
[09:34:18.235] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:18.235] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:11:0) after 1m0s
[09:35:18.266] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:11:0)
[09:35:18.266] Timer tick, asking Buildbucket for the build status
[09:35:18.414] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:18.414] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:12:0) after 1m0s
[09:36:18.435] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:12:0)
[09:36:18.435] Timer tick, asking Buildbucket for the build status
[09:36:18.700] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:18.700] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:13:0) after 1m0s
[09:37:23.108] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:13:0)
[09:37:23.108] Timer tick, asking Buildbucket for the build status
[09:37:23.268] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:23.268] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:14:0) after 1m0s
[09:38:23.356] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:14:0)
[09:38:23.356] Timer tick, asking Buildbucket for the build status
[09:38:23.442] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:23.442] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:15:0) after 1m0s
[09:39:23.502] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:15:0)
[09:39:23.502] Timer tick, asking Buildbucket for the build status
[09:39:23.636] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:23.636] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:16:0) after 1m0s
[09:40:23.690] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:16:0)
[09:40:23.690] Timer tick, asking Buildbucket for the build status
[09:40:23.764] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:23.764] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:17:0) after 1m0s
[09:41:23.747] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:17:0)
[09:41:23.748] Timer tick, asking Buildbucket for the build status
[09:41:23.858] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:23.858] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:18:0) after 1m0s
[09:42:23.885] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:18:0)
[09:42:23.885] Timer tick, asking Buildbucket for the build status
[09:42:24.234] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:24.234] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:19:0) after 1m0s
[09:43:24.215] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:19:0)
[09:43:24.215] Timer tick, asking Buildbucket for the build status
[09:43:24.300] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:24.300] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:20:0) after 1m0s
[09:44:24.320] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:20:0)
[09:44:24.320] Timer tick, asking Buildbucket for the build status
[09:44:24.411] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:24.411] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:21:0) after 1m0s
[09:45:24.431] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:21:0)
[09:45:24.431] Timer tick, asking Buildbucket for the build status
[09:45:24.535] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:24.535] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:22:0) after 1m0s
[09:46:24.554] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:22:0)
[09:46:24.554] Timer tick, asking Buildbucket for the build status
[09:46:24.994] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:24.994] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:23:0) after 1m0s
[09:47:25.040] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:23:0)
[09:47:25.040] Timer tick, asking Buildbucket for the build status
[09:47:25.127] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:25.127] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:24:0) after 1m0s
[09:48:25.152] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:24:0)
[09:48:25.152] Timer tick, asking Buildbucket for the build status
[09:48:25.213] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:25.213] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:25:0) after 1m0s
[09:49:25.265] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:25:0)
[09:49:25.265] Timer tick, asking Buildbucket for the build status
[09:49:25.350] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:25.350] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:26:0) after 1m0s
[09:50:25.521] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:26:0)
[09:50:25.521] Timer tick, asking Buildbucket for the build status
[09:50:25.583] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:25.583] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:27:0) after 1m0s
[09:51:25.632] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:27:0)
[09:51:25.633] Timer tick, asking Buildbucket for the build status
[09:51:25.715] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:25.715] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:28:0) after 1m0s
[09:52:25.809] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:28:0)
[09:52:25.809] Timer tick, asking Buildbucket for the build status
[09:52:25.874] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:25.874] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:29:0) after 1m0s
[09:53:25.946] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:29:0)
[09:53:25.946] Timer tick, asking Buildbucket for the build status
[09:53:26.162] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:26.162] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:30:0) after 1m0s
[09:54:26.236] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:30:0)
[09:54:26.236] Timer tick, asking Buildbucket for the build status
[09:54:26.368] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:26.368] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:31:0) after 1m0s
[09:55:26.367] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:31:0)
[09:55:26.367] Timer tick, asking Buildbucket for the build status
[09:55:26.485] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:26.485] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:32:0) after 1m0s
[09:56:26.592] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:32:0)
[09:56:26.592] Timer tick, asking Buildbucket for the build status
[09:56:26.690] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:26.690] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:33:0) after 1m0s
[09:57:26.826] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:33:0)
[09:57:26.826] Timer tick, asking Buildbucket for the build status
[09:57:27.088] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:27.088] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:34:0) after 1m0s
[09:58:27.200] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:34:0)
[09:58:27.200] Timer tick, asking Buildbucket for the build status
[09:58:27.289] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:27.289] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:35:0) after 1m0s
[09:59:27.530] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:35:0)
[09:59:27.530] Timer tick, asking Buildbucket for the build status
[09:59:27.595] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:27.595] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:36:0) after 1m0s
[10:00:27.638] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:36:0)
[10:00:27.638] Timer tick, asking Buildbucket for the build status
[10:00:27.787] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:27.787] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:37:0) after 1m0s
[10:01:27.921] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:37:0)
[10:01:27.921] Timer tick, asking Buildbucket for the build status
[10:01:28.082] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:28.082] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:38:0) after 1m0s
[10:02:28.120] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:38:0)
[10:02:28.120] Timer tick, asking Buildbucket for the build status
[10:02:28.216] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:28.216] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:39:0) after 1m0s
[10:03:28.281] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:39:0)
[10:03:28.281] Timer tick, asking Buildbucket for the build status
[10:03:28.346] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:28.346] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:40:0) after 1m0s
[10:04:28.411] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:40:0)
[10:04:28.411] Timer tick, asking Buildbucket for the build status
[10:04:28.481] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:28.481] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:41:0) after 1m0s
[10:05:28.490] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:41:0)
[10:05:28.490] Timer tick, asking Buildbucket for the build status
[10:05:28.698] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:28.698] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:42:0) after 1m0s
[10:06:28.756] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:42:0)
[10:06:28.756] Timer tick, asking Buildbucket for the build status
[10:06:28.870] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:28.870] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:43:0) after 1m0s
[10:07:28.937] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:43:0)
[10:07:28.937] Timer tick, asking Buildbucket for the build status
[10:07:29.055] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:29.055] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:44:0) after 1m0s
[10:08:29.071] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:44:0)
[10:08:29.071] Timer tick, asking Buildbucket for the build status
[10:08:29.181] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:29.181] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:45:0) after 1m0s
[10:09:29.226] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:45:0)
[10:09:29.226] Timer tick, asking Buildbucket for the build status
[10:09:30.328] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:30.328] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:46:0) after 1m0s
[10:10:30.359] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:46:0)
[10:10:30.359] Timer tick, asking Buildbucket for the build status
[10:10:30.419] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:30.419] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:47:0) after 1m0s
[10:11:30.510] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:47:0)
[10:11:30.510] Timer tick, asking Buildbucket for the build status
[10:11:30.900] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:30.900] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:48:0) after 1m0s
[10:12:30.923] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:48:0)
[10:12:30.923] Timer tick, asking Buildbucket for the build status
[10:12:31.062] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:31.062] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:49:0) after 1m0s
[10:13:31.096] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:49:0)
[10:13:31.096] Timer tick, asking Buildbucket for the build status
[10:13:31.227] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:31.227] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:50:0) after 1m0s
[10:14:31.249] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:50:0)
[10:14:31.249] Timer tick, asking Buildbucket for the build status
[10:14:31.314] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:31.314] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:51:0) after 1m0s
[10:15:31.332] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:51:0)
[10:15:31.332] Timer tick, asking Buildbucket for the build status
[10:15:31.441] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:31.441] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:52:0) after 1m0s
[10:16:31.495] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:52:0)
[10:16:31.495] Timer tick, asking Buildbucket for the build status
[10:16:31.917] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:31.917] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:53:0) after 1m0s
[10:17:32.021] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:53:0)
[10:17:32.021] Timer tick, asking Buildbucket for the build status
[10:17:32.108] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:32.108] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:54:0) after 1m0s
[10:18:32.292] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:54:0)
[10:18:32.292] Timer tick, asking Buildbucket for the build status
[10:18:32.352] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:32.352] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:55:0) after 1m0s
[10:19:32.427] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:55:0)
[10:19:32.427] Timer tick, asking Buildbucket for the build status
[10:19:32.495] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:32.495] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:56:0) after 1m0s
[10:20:32.660] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:56:0)
[10:20:32.660] Timer tick, asking Buildbucket for the build status
[10:20:32.734] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:32.734] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:57:0) after 1m0s
[10:21:32.892] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:57:0)
[10:21:32.892] Timer tick, asking Buildbucket for the build status
[10:21:32.986] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:32.986] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:58:0) after 1m0s
[10:22:33.094] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:58:0)
[10:22:33.094] Timer tick, asking Buildbucket for the build status
[10:22:33.201] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:33.201] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:59:0) after 1m0s
[10:23:33.255] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:59:0)
[10:23:33.255] Timer tick, asking Buildbucket for the build status
[10:23:33.339] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:33.339] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:60:0) after 1m0s
[10:24:33.364] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:60:0)
[10:24:33.364] Timer tick, asking Buildbucket for the build status
[10:24:33.423] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:33.423] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:61:0) after 1m0s
[10:25:33.485] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:61:0)
[10:25:33.485] Timer tick, asking Buildbucket for the build status
[10:25:33.582] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:33.582] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:62:0) after 1m0s
[10:26:33.567] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:62:0)
[10:26:33.567] Timer tick, asking Buildbucket for the build status
[10:26:33.939] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:33.939] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:63:0) after 1m0s
[10:27:33.960] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:63:0)
[10:27:33.960] Timer tick, asking Buildbucket for the build status
[10:27:34.512] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:34.512] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:64:0) after 1m0s
[10:28:34.547] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:64:0)
[10:28:34.547] Timer tick, asking Buildbucket for the build status
[10:28:34.633] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:34.633] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:65:0) after 1m0s
[10:29:34.616] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:65:0)
[10:29:34.616] Timer tick, asking Buildbucket for the build status
[10:29:34.741] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:34.741] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:66:0) after 1m0s
[10:30:34.781] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:66:0)
[10:30:34.781] Timer tick, asking Buildbucket for the build status
[10:30:34.858] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:34.858] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:67:0) after 1m0s
[10:31:34.937] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:67:0)
[10:31:34.937] Timer tick, asking Buildbucket for the build status
[10:31:35.375] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:35.375] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:68:0) after 1m0s
[10:32:35.395] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:68:0)
[10:32:35.395] Timer tick, asking Buildbucket for the build status
[10:32:36.142] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:36.142] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:69:0) after 1m0s
[10:33:36.263] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:69:0)
[10:33:36.263] Timer tick, asking Buildbucket for the build status
[10:33:36.399] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:36.399] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:70:0) after 1m0s
[10:34:36.429] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:70:0)
[10:34:36.429] Timer tick, asking Buildbucket for the build status
[10:34:36.488] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:36.489] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:71:0) after 1m0s
[10:35:36.550] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:71:0)
[10:35:36.550] Timer tick, asking Buildbucket for the build status
[10:35:36.724] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:36.725] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:72:0) after 1m0s
[10:36:36.715] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:72:0)
[10:36:36.715] Timer tick, asking Buildbucket for the build status
[10:36:36.811] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:36.811] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:73:0) after 1m0s
[10:37:36.834] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:73:0)
[10:37:36.834] Timer tick, asking Buildbucket for the build status
[10:37:36.895] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:36.895] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:74:0) after 1m0s
[10:38:36.910] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:74:0)
[10:38:36.910] Timer tick, asking Buildbucket for the build status
[10:38:37.052] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:37.052] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:75:0) after 1m0s
[10:39:37.117] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:75:0)
[10:39:37.117] Timer tick, asking Buildbucket for the build status
[10:39:37.212] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:37.212] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:76:0) after 1m0s
[10:40:37.234] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:76:0)
[10:40:37.234] Timer tick, asking Buildbucket for the build status
[10:40:37.742] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:37.742] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:77:0) after 1m0s
[10:41:37.805] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:77:0)
[10:41:37.805] Timer tick, asking Buildbucket for the build status
[10:41:37.915] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:37.915] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:78:0) after 1m0s
[10:42:37.941] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:78:0)
[10:42:37.941] Timer tick, asking Buildbucket for the build status
[10:42:38.038] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:38.038] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:79:0) after 1m0s
[10:43:38.198] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:79:0)
[10:43:38.198] Timer tick, asking Buildbucket for the build status
[10:43:38.419] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:38.419] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:80:0) after 1m0s
[10:44:40.129] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:80:0)
[10:44:40.130] Timer tick, asking Buildbucket for the build status
[10:44:40.224] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:40.224] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:81:0) after 1m0s
[10:45:40.484] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:81:0)
[10:45:40.484] Timer tick, asking Buildbucket for the build status
[10:45:40.558] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:40.558] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:82:0) after 1m0s
[10:46:40.641] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:82:0)
[10:46:40.641] Timer tick, asking Buildbucket for the build status
[10:46:40.739] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:40.739] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:83:0) after 1m0s
[10:47:41.097] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:83:0)
[10:47:41.097] Timer tick, asking Buildbucket for the build status
[10:47:41.174] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:41.174] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:84:0) after 1m0s
[10:48:42.094] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:84:0)
[10:48:42.094] Timer tick, asking Buildbucket for the build status
[10:48:42.159] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:42.159] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:85:0) after 1m0s
[10:49:42.450] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:85:0)
[10:49:42.450] Timer tick, asking Buildbucket for the build status
[10:49:42.637] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:42.637] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:86:0) after 1m0s
[10:50:42.716] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:86:0)
[10:50:42.716] Timer tick, asking Buildbucket for the build status
[10:50:42.773] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:42.773] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:87:0) after 1m0s
[10:51:42.850] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:87:0)
[10:51:42.850] Timer tick, asking Buildbucket for the build status
[10:51:42.958] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:42.958] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:88:0) after 1m0s
[10:52:43.054] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:88:0)
[10:52:43.054] Timer tick, asking Buildbucket for the build status
[10:52:43.116] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:43.116] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:89:0) after 1m0s
[10:53:43.250] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:89:0)
[10:53:43.250] Timer tick, asking Buildbucket for the build status
[10:53:43.401] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:43.401] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:90:0) after 1m0s
[10:54:43.458] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:90:0)
[10:54:43.458] Timer tick, asking Buildbucket for the build status
[10:54:43.520] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:43.520] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:91:0) after 1m0s
[10:55:43.583] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:91:0)
[10:55:43.583] Timer tick, asking Buildbucket for the build status
[10:55:43.652] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:43.652] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:92:0) after 1m0s
[10:56:43.905] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:92:0)
[10:56:43.905] Timer tick, asking Buildbucket for the build status
[10:56:44.007] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:44.007] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:93:0) after 1m0s
[10:57:44.108] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:93:0)
[10:57:44.108] Timer tick, asking Buildbucket for the build status
[10:57:44.171] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:44.171] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:94:0) after 1m0s
[10:58:44.163] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:94:0)
[10:58:44.163] Timer tick, asking Buildbucket for the build status
[10:58:44.218] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:44.218] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:95:0) after 1m0s
[10:59:44.367] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:95:0)
[10:59:44.367] Timer tick, asking Buildbucket for the build status
[10:59:44.424] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:44.424] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:96:0) after 1m0s
[11:00:44.665] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:96:0)
[11:00:44.665] Timer tick, asking Buildbucket for the build status
[11:00:44.747] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:44.747] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:97:0) after 1m0s
[11:01:44.931] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:97:0)
[11:01:44.931] Timer tick, asking Buildbucket for the build status
[11:01:45.027] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:45.027] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:98:0) after 1m0s
[11:02:45.247] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:98:0)
[11:02:45.247] Timer tick, asking Buildbucket for the build status
[11:02:45.546] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:45.546] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:99:0) after 1m0s
[11:03:45.530] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:99:0)
[11:03:45.530] Timer tick, asking Buildbucket for the build status
[11:03:45.596] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:45.596] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:100:0) after 1m0s
[11:04:45.651] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:100:0)
[11:04:45.651] Timer tick, asking Buildbucket for the build status
[11:04:45.712] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:45.712] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:101:0) after 1m0s
[11:05:45.735] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:101:0)
[11:05:45.735] Timer tick, asking Buildbucket for the build status
[11:05:45.892] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:45.892] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:102:0) after 1m0s
[11:06:45.996] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:102:0)
[11:06:45.996] Timer tick, asking Buildbucket for the build status
[11:06:46.140] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:46.140] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:103:0) after 1m0s
[11:07:46.168] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:103:0)
[11:07:46.168] Timer tick, asking Buildbucket for the build status
[11:07:46.227] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:46.227] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:104:0) after 1m0s
[11:08:46.331] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:104:0)
[11:08:46.331] Timer tick, asking Buildbucket for the build status
[11:08:46.461] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:46.461] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:105:0) after 1m0s
[11:09:46.536] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:105:0)
[11:09:46.536] Timer tick, asking Buildbucket for the build status
[11:09:46.589] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:46.589] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:106:0) after 1m0s
[11:10:46.619] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:106:0)
[11:10:46.619] Timer tick, asking Buildbucket for the build status
[11:10:46.709] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:46.709] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:107:0) after 1m0s
[11:11:46.809] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:107:0)
[11:11:46.809] Timer tick, asking Buildbucket for the build status
[11:11:47.228] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:47.228] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:108:0) after 1m0s
[11:12:47.307] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:108:0)
[11:12:47.307] Timer tick, asking Buildbucket for the build status
[11:12:49.132] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:49.133] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:109:0) after 1m0s
[11:13:49.188] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:109:0)
[11:13:49.188] Timer tick, asking Buildbucket for the build status
[11:13:49.687] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:49.687] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:110:0) after 1m0s
[11:14:49.871] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:110:0)
[11:14:49.871] Timer tick, asking Buildbucket for the build status
[11:14:49.941] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:49.941] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:111:0) after 1m0s
[11:15:50.039] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:111:0)
[11:15:50.039] Timer tick, asking Buildbucket for the build status
[11:15:50.109] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:50.109] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:112:0) after 1m0s
[11:16:50.137] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:112:0)
[11:16:50.137] Timer tick, asking Buildbucket for the build status
[11:16:50.237] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:50.237] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:113:0) after 1m0s
[11:17:50.297] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:113:0)
[11:17:50.297] Timer tick, asking Buildbucket for the build status
[11:17:51.336] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:51.336] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:114:0) after 1m0s
[11:18:51.668] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:114:0)
[11:18:51.668] Timer tick, asking Buildbucket for the build status
[11:18:51.740] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:51.740] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:115:0) after 1m0s
[11:19:51.829] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:115:0)
[11:19:51.829] Timer tick, asking Buildbucket for the build status
[11:19:51.888] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:51.888] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:116:0) after 1m0s
[11:20:52.088] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:116:0)
[11:20:52.088] Timer tick, asking Buildbucket for the build status
[11:20:52.205] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:52.205] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:117:0) after 1m0s
[11:21:52.280] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:117:0)
[11:21:52.280] Timer tick, asking Buildbucket for the build status
[11:21:52.429] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:52.429] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:118:0) after 1m0s
[11:22:52.494] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:118:0)
[11:22:52.494] Timer tick, asking Buildbucket for the build status
[11:22:52.711] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:52.711] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:119:0) after 1m0s
[11:23:52.889] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:119:0)
[11:23:52.889] Timer tick, asking Buildbucket for the build status
[11:23:52.963] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:52.963] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:120:0) after 1m0s
[11:24:53.075] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:120:0)
[11:24:53.075] Timer tick, asking Buildbucket for the build status
[11:24:53.161] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:53.161] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:121:0) after 1m0s
[11:25:53.289] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:121:0)
[11:25:53.289] Timer tick, asking Buildbucket for the build status
[11:25:53.623] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:53.623] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:122:0) after 1m0s
[11:26:53.704] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:122:0)
[11:26:53.704] Timer tick, asking Buildbucket for the build status
[11:26:53.824] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:53.824] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:123:0) after 1m0s
[11:27:53.846] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:123:0)
[11:27:53.846] Timer tick, asking Buildbucket for the build status
[11:27:53.920] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:53.920] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:124:0) after 1m0s
[11:28:53.989] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:124:0)
[11:28:53.989] Timer tick, asking Buildbucket for the build status
[11:28:54.049] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:54.049] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:125:0) after 1m0s
[11:29:54.079] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:125:0)
[11:29:54.079] Timer tick, asking Buildbucket for the build status
[11:29:54.261] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:54.261] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:126:0) after 1m0s
[11:30:54.295] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:126:0)
[11:30:54.295] Timer tick, asking Buildbucket for the build status
[11:30:54.601] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:54.601] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:127:0) after 1m0s
[11:31:54.652] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:127:0)
[11:31:54.652] Timer tick, asking Buildbucket for the build status
[11:31:54.755] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:54.755] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:128:0) after 1m0s
[11:32:54.788] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:128:0)
[11:32:54.788] Timer tick, asking Buildbucket for the build status
[11:32:54.866] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:54.866] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:129:0) after 1m0s
[11:33:54.979] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:129:0)
[11:33:54.979] Timer tick, asking Buildbucket for the build status
[11:33:55.165] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:55.165] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:130:0) after 1m0s
[11:34:55.202] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:130:0)
[11:34:55.202] Timer tick, asking Buildbucket for the build status
[11:34:55.265] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:55.265] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:131:0) after 1m0s
[11:35:55.370] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:131:0)
[11:35:55.370] Timer tick, asking Buildbucket for the build status
[11:35:55.433] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:55.433] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:132:0) after 1m0s
[11:36:55.434] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:132:0)
[11:36:55.434] Timer tick, asking Buildbucket for the build status
[11:36:55.748] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:55.748] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:133:0) after 1m0s
[11:37:55.770] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:133:0)
[11:37:55.770] Timer tick, asking Buildbucket for the build status
[11:37:55.831] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:55.832] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:134:0) after 1m0s
[11:38:55.829] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:134:0)
[11:38:55.830] Timer tick, asking Buildbucket for the build status
[11:38:55.891] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:55.891] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:135:0) after 1m0s
[11:39:55.929] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:135:0)
[11:39:55.929] Timer tick, asking Buildbucket for the build status
[11:39:56.077] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:56.077] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:136:0) after 1m0s
[11:40:56.108] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:136:0)
[11:40:56.108] Timer tick, asking Buildbucket for the build status
[11:40:56.375] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:56.375] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:137:0) after 1m0s
[11:41:56.410] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:137:0)
[11:41:56.410] Timer tick, asking Buildbucket for the build status
[11:41:56.522] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:56.522] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:138:0) after 1m0s
[11:42:56.548] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:138:0)
[11:42:56.548] Timer tick, asking Buildbucket for the build status
[11:42:56.611] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:56.611] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:139:0) after 1m0s
[11:43:56.644] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:139:0)
[11:43:56.644] Timer tick, asking Buildbucket for the build status
[11:43:56.726] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:56.742] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:140:0) after 1m0s
[11:44:56.783] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:140:0)
[11:44:56.783] Timer tick, asking Buildbucket for the build status
[11:44:56.843] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:56.843] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:141:0) after 1m0s
[11:45:56.823] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:141:0)
[11:45:56.823] Timer tick, asking Buildbucket for the build status
[11:45:56.886] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:56.886] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:142:0) after 1m0s
[11:46:56.874] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:142:0)
[11:46:56.874] Timer tick, asking Buildbucket for the build status
[11:46:57.062] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:57.062] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:143:0) after 1m0s
[11:47:57.108] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:143:0)
[11:47:57.108] Timer tick, asking Buildbucket for the build status
[11:47:57.175] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:57.175] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:144:0) after 1m0s
[11:48:57.281] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:144:0)
[11:48:57.281] Timer tick, asking Buildbucket for the build status
[11:48:57.351] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:57.351] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:145:0) after 1m0s
[11:49:57.330] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:145:0)
[11:49:57.330] Timer tick, asking Buildbucket for the build status
[11:49:57.637] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:57.637] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:146:0) after 1m0s
[11:50:57.653] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:146:0)
[11:50:57.654] Timer tick, asking Buildbucket for the build status
[11:50:57.708] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:57.708] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:147:0) after 1m0s
[11:51:57.775] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:147:0)
[11:51:57.775] Timer tick, asking Buildbucket for the build status
[11:51:57.878] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:57.878] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:148:0) after 1m0s
[11:52:57.909] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:148:0)
[11:52:57.909] Timer tick, asking Buildbucket for the build status
[11:52:57.975] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:57.975] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:149:0) after 1m0s
[11:53:58.001] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:149:0)
[11:53:58.001] Timer tick, asking Buildbucket for the build status
[11:53:58.063] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:58.063] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:150:0) after 1m0s
[11:54:58.097] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:150:0)
[11:54:58.097] Timer tick, asking Buildbucket for the build status
[11:54:58.270] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:58.271] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:151:0) after 1m0s
[11:55:58.366] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:151:0)
[11:55:58.366] Timer tick, asking Buildbucket for the build status
[11:55:58.423] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:58.423] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:152:0) after 1m0s
[11:56:58.446] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:152:0)
[11:56:58.446] Timer tick, asking Buildbucket for the build status
[11:56:58.660] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:58.660] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:153:0) after 1m0s
[11:57:58.687] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:153:0)
[11:57:58.687] Timer tick, asking Buildbucket for the build status
[11:57:58.746] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:58.746] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:154:0) after 1m0s
[11:58:58.819] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:154:0)
[11:58:58.819] Timer tick, asking Buildbucket for the build status
[11:58:58.939] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:58.939] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:155:0) after 1m0s
[11:59:59.012] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:155:0)
[11:59:59.012] Timer tick, asking Buildbucket for the build status
[11:59:59.069] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:59.069] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:156:0) after 1m0s
[12:00:59.063] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:156:0)
[12:00:59.063] Timer tick, asking Buildbucket for the build status
[12:00:59.147] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:59.147] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:157:0) after 1m0s
[12:01:59.183] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:157:0)
[12:01:59.183] Timer tick, asking Buildbucket for the build status
[12:01:59.348] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:59.348] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:158:0) after 1m0s
[12:02:59.372] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:158:0)
[12:02:59.372] Timer tick, asking Buildbucket for the build status
[12:02:59.612] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:59.612] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:159:0) after 1m0s
[12:03:59.628] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:159:0)
[12:03:59.628] Timer tick, asking Buildbucket for the build status
[12:03:59.693] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:59.693] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:160:0) after 1m0s
[12:04:59.717] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:160:0)
[12:04:59.717] Timer tick, asking Buildbucket for the build status
[12:04:59.782] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:59.782] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:161:0) after 1m0s
[12:05:59.812] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:161:0)
[12:05:59.812] Timer tick, asking Buildbucket for the build status
[12:05:59.886] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:59.886] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:162:0) after 1m0s
[12:06:59.946] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:162:0)
[12:06:59.946] Timer tick, asking Buildbucket for the build status
[12:07:00.206] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:00.206] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:163:0) after 1m0s
[12:08:00.235] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:163:0)
[12:08:00.235] Timer tick, asking Buildbucket for the build status
[12:08:00.368] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:00.368] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:164:0) after 1m0s
[12:09:00.464] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:164:0)
[12:09:00.464] Timer tick, asking Buildbucket for the build status
[12:09:00.530] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:00.530] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:165:0) after 1m0s
[12:10:00.542] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:165:0)
[12:10:00.542] Timer tick, asking Buildbucket for the build status
[12:10:00.604] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:00.604] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:166:0) after 1m0s
[12:11:00.628] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:166:0)
[12:11:00.628] Timer tick, asking Buildbucket for the build status
[12:11:00.706] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:00.706] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:167:0) after 1m0s
[12:12:00.747] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:167:0)
[12:12:00.748] Timer tick, asking Buildbucket for the build status
[12:12:01.057] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:01.057] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:168:0) after 1m0s
[12:13:01.225] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:168:0)
[12:13:01.225] Timer tick, asking Buildbucket for the build status
[12:13:01.289] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:01.289] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:169:0) after 1m0s
[12:14:01.400] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:169:0)
[12:14:01.400] Timer tick, asking Buildbucket for the build status
[12:14:01.469] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:01.469] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:170:0) after 1m0s
[12:15:01.516] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:170:0)
[12:15:01.516] Timer tick, asking Buildbucket for the build status
[12:15:01.573] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:01.573] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:171:0) after 1m0s
[12:16:01.687] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:171:0)
[12:16:01.687] Timer tick, asking Buildbucket for the build status
[12:16:01.789] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:01.789] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:172:0) after 1m0s
[12:17:01.843] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:172:0)
[12:17:01.843] Timer tick, asking Buildbucket for the build status
[12:17:01.948] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:01.948] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:173:0) after 1m0s
[12:18:01.974] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:173:0)
[12:18:01.974] Timer tick, asking Buildbucket for the build status
[12:18:02.159] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:02.159] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:174:0) after 1m0s
[12:19:02.261] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:174:0)
[12:19:02.261] Timer tick, asking Buildbucket for the build status
[12:19:02.326] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:02.326] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:175:0) after 1m0s
[12:20:02.384] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:175:0)
[12:20:02.384] Timer tick, asking Buildbucket for the build status
[12:20:02.679] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:02.679] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:176:0) after 1m0s
[12:21:02.717] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:176:0)
[12:21:02.717] Timer tick, asking Buildbucket for the build status
[12:21:02.793] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:02.793] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:177:0) after 1m0s
[12:22:02.888] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:177:0)
[12:22:02.888] Timer tick, asking Buildbucket for the build status
[12:22:03.008] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:03.008] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:178:0) after 1m0s
[12:23:03.127] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:178:0)
[12:23:03.127] Timer tick, asking Buildbucket for the build status
[12:23:03.239] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:03.239] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:179:0) after 1m0s
[12:24:03.310] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:179:0)
[12:24:03.310] Timer tick, asking Buildbucket for the build status
[12:24:03.383] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:03.383] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:180:0) after 1m0s
[12:25:03.417] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:180:0)
[12:25:03.417] Timer tick, asking Buildbucket for the build status
[12:25:03.484] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:03.484] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:181:0) after 1m0s
[12:26:03.513] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:181:0)
[12:26:03.513] Timer tick, asking Buildbucket for the build status
[12:26:03.568] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:03.568] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:182:0) after 1m0s
[12:27:03.655] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:182:0)
[12:27:03.655] Timer tick, asking Buildbucket for the build status
[12:27:03.846] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:03.846] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:183:0) after 1m0s
[12:28:03.873] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:183:0)
[12:28:03.873] Timer tick, asking Buildbucket for the build status
[12:28:04.287] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:04.287] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:184:0) after 1m0s
[12:29:04.329] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:184:0)
[12:29:04.329] Timer tick, asking Buildbucket for the build status
[12:29:05.370] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:05.370] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:185:0) after 1m0s
[12:30:05.482] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:185:0)
[12:30:05.482] Timer tick, asking Buildbucket for the build status
[12:30:05.586] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:05.586] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:186:0) after 1m0s
[12:31:06.097] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:186:0)
[12:31:06.097] Timer tick, asking Buildbucket for the build status
[12:31:06.216] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:06.216] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:187:0) after 1m0s
[12:32:06.243] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:187:0)
[12:32:06.243] Timer tick, asking Buildbucket for the build status
[12:32:06.404] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:06.404] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:188:0) after 1m0s
[12:33:06.482] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:188:0)
[12:33:06.482] Timer tick, asking Buildbucket for the build status
[12:33:06.553] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:06.554] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:189:0) after 1m0s
[12:34:06.605] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:189:0)
[12:34:06.605] Timer tick, asking Buildbucket for the build status
[12:34:06.670] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:06.670] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:190:0) after 1m0s
[12:35:06.746] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:190:0)
[12:35:06.746] Timer tick, asking Buildbucket for the build status
[12:35:06.811] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:06.811] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:191:0) after 1m0s
[12:36:06.875] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:191:0)
[12:36:06.875] Timer tick, asking Buildbucket for the build status
[12:36:06.947] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:06.947] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:192:0) after 1m0s
[12:37:07.035] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:192:0)
[12:37:07.035] Timer tick, asking Buildbucket for the build status
[12:37:07.227] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:07.227] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:193:0) after 1m0s
[12:38:07.235] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:193:0)
[12:38:07.235] Timer tick, asking Buildbucket for the build status
[12:38:07.299] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:07.299] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:194:0) after 1m0s
[12:39:07.333] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:194:0)
[12:39:07.333] Timer tick, asking Buildbucket for the build status
[12:39:07.572] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:07.572] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:195:0) after 1m0s
[12:40:07.633] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:195:0)
[12:40:07.633] Timer tick, asking Buildbucket for the build status
[12:40:07.743] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:07.743] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:196:0) after 1m0s
[12:41:07.833] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:196:0)
[12:41:07.833] Timer tick, asking Buildbucket for the build status
[12:41:07.890] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:07.890] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:197:0) after 1m0s
[12:42:07.917] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:197:0)
[12:42:07.917] Timer tick, asking Buildbucket for the build status
[12:42:08.059] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:08.059] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:198:0) after 1m0s
[12:43:08.089] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:198:0)
[12:43:08.089] Timer tick, asking Buildbucket for the build status
[12:43:08.406] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:08.406] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:199:0) after 1m0s
[12:44:08.500] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:199:0)
[12:44:08.500] Timer tick, asking Buildbucket for the build status
[12:44:08.811] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:08.811] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:200:0) after 1m0s
[12:45:08.950] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:200:0)
[12:45:08.950] Timer tick, asking Buildbucket for the build status
[12:45:09.022] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:09.023] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:201:0) after 1m0s
[12:46:09.107] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:201:0)
[12:46:09.107] Timer tick, asking Buildbucket for the build status
[12:46:09.172] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:09.172] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:202:0) after 1m0s
[12:47:09.201] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:202:0)
[12:47:09.201] Timer tick, asking Buildbucket for the build status
[12:47:09.302] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:09.302] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:203:0) after 1m0s
[12:48:09.329] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:203:0)
[12:48:09.329] Timer tick, asking Buildbucket for the build status
[12:48:09.424] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:09.424] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:204:0) after 1m0s
[12:49:09.479] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:204:0)
[12:49:09.479] Timer tick, asking Buildbucket for the build status
[12:49:09.531] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:09.531] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:205:0) after 1m0s
[12:50:09.561] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:205:0)
[12:50:09.561] Timer tick, asking Buildbucket for the build status
[12:50:10.012] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:10.012] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:206:0) after 1m0s
[12:51:10.042] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:206:0)
[12:51:10.042] Timer tick, asking Buildbucket for the build status
[12:51:10.337] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:10.337] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:207:0) after 1m0s
[12:52:10.484] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:207:0)
[12:52:10.484] Timer tick, asking Buildbucket for the build status
[12:52:10.885] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:10.885] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:208:0) after 1m0s
[12:53:10.976] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:208:0)
[12:53:10.976] Timer tick, asking Buildbucket for the build status
[12:53:11.054] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:11.054] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:209:0) after 1m0s
[12:54:11.085] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:209:0)
[12:54:11.085] Timer tick, asking Buildbucket for the build status
[12:54:11.145] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:11.145] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:210:0) after 1m0s
[12:55:11.225] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:210:0)
[12:55:11.225] Timer tick, asking Buildbucket for the build status
[12:55:11.307] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:11.307] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:211:0) after 1m0s
[12:56:11.333] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:211:0)
[12:56:11.333] Timer tick, asking Buildbucket for the build status
[12:56:11.414] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:11.414] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:212:0) after 1m0s
[12:57:11.443] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:212:0)
[12:57:11.443] Timer tick, asking Buildbucket for the build status
[12:57:11.551] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:11.551] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:213:0) after 1m0s
[12:58:11.755] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:213:0)
[12:58:11.755] Timer tick, asking Buildbucket for the build status
[12:58:12.062] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:12.062] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:214:0) after 1m0s
[12:59:12.062] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:214:0)
[12:59:12.062] Timer tick, asking Buildbucket for the build status
[12:59:12.134] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:12.134] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:215:0) after 1m0s
[13:00:12.164] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:215:0)
[13:00:12.164] Timer tick, asking Buildbucket for the build status
[13:00:12.250] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:12.250] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:216:0) after 1m0s
[13:01:12.261] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:216:0)
[13:01:12.261] Timer tick, asking Buildbucket for the build status
[13:01:12.327] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:12.327] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:217:0) after 1m0s
[13:02:12.564] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:217:0)
[13:02:12.564] Timer tick, asking Buildbucket for the build status
[13:02:12.648] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:12.648] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:218:0) after 1m0s
[13:03:12.725] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:218:0)
[13:03:12.725] Timer tick, asking Buildbucket for the build status
[13:03:12.794] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:12.794] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:219:0) after 1m0s
[13:04:12.774] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:219:0)
[13:04:12.774] Timer tick, asking Buildbucket for the build status
[13:04:12.850] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:12.850] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:220:0) after 1m0s
[13:05:12.888] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:220:0)
[13:05:12.888] Timer tick, asking Buildbucket for the build status
[13:05:13.016] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:13.016] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:221:0) after 1m0s
[13:06:13.048] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:221:0)
[13:06:13.048] Timer tick, asking Buildbucket for the build status
[13:06:14.451] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:14.451] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:222:0) after 1m0s
[13:07:14.574] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:222:0)
[13:07:14.574] Timer tick, asking Buildbucket for the build status
[13:07:14.668] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:14.668] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:223:0) after 1m0s
[13:08:14.700] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:223:0)
[13:08:14.700] Timer tick, asking Buildbucket for the build status
[13:08:14.767] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:14.767] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:224:0) after 1m0s
[13:09:14.843] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:224:0)
[13:09:14.843] Timer tick, asking Buildbucket for the build status
[13:09:14.986] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:14.986] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:225:0) after 1m0s
[13:10:15.044] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:225:0)
[13:10:15.044] Timer tick, asking Buildbucket for the build status
[13:10:15.118] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:15.118] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:226:0) after 1m0s
[13:11:15.193] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:226:0)
[13:11:15.193] Timer tick, asking Buildbucket for the build status
[13:11:15.249] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:15.249] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:227:0) after 1m0s
[13:12:15.310] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:227:0)
[13:12:15.310] Timer tick, asking Buildbucket for the build status
[13:12:15.485] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:15.485] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:228:0) after 1m0s
[13:13:15.571] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:228:0)
[13:13:15.571] Timer tick, asking Buildbucket for the build status
[13:13:15.642] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:15.642] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:229:0) after 1m0s
[13:14:15.686] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:229:0)
[13:14:15.686] Timer tick, asking Buildbucket for the build status
[13:14:15.744] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:15.744] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:230:0) after 1m0s
[13:15:15.848] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:230:0)
[13:15:15.848] Timer tick, asking Buildbucket for the build status
[13:15:15.919] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:15.919] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:231:0) after 1m0s
[13:16:15.947] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:231:0)
[13:16:15.947] Timer tick, asking Buildbucket for the build status
[13:16:16.018] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:16.018] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:232:0) after 1m0s
[13:17:16.042] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:232:0)
[13:17:16.042] Timer tick, asking Buildbucket for the build status
[13:17:16.165] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:16.165] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:233:0) after 1m0s
[13:18:16.215] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:233:0)
[13:18:16.215] Timer tick, asking Buildbucket for the build status
[13:18:16.279] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:16.279] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:234:0) after 1m0s
[13:19:16.377] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:234:0)
[13:19:16.377] Timer tick, asking Buildbucket for the build status
[13:19:16.442] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:16.442] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:235:0) after 1m0s
[13:20:16.482] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:235:0)
[13:20:16.482] Timer tick, asking Buildbucket for the build status
[13:20:16.556] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:16.556] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:236:0) after 1m0s
[13:21:16.588] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:236:0)
[13:21:16.588] Timer tick, asking Buildbucket for the build status
[13:21:16.648] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:16.648] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:237:0) after 1m0s
[13:22:16.688] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:237:0)
[13:22:16.688] Timer tick, asking Buildbucket for the build status
[13:22:16.883] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:16.883] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:238:0) after 1m0s
[13:23:16.913] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:238:0)
[13:23:16.913] Timer tick, asking Buildbucket for the build status
[13:23:17.332] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:17.332] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:239:0) after 1m0s
[13:24:17.372] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:239:0)
[13:24:17.372] Timer tick, asking Buildbucket for the build status
[13:24:17.447] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:17.447] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:240:0) after 1m0s
[13:25:17.444] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:240:0)
[13:25:17.444] Timer tick, asking Buildbucket for the build status
[13:25:17.537] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:17.537] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:241:0) after 1m0s
[13:26:17.568] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:241:0)
[13:26:17.568] Timer tick, asking Buildbucket for the build status
[13:26:17.636] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:17.636] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:242:0) after 1m0s
[13:27:17.661] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:242:0)
[13:27:17.661] Timer tick, asking Buildbucket for the build status
[13:27:17.768] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:17.768] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:243:0) after 1m0s
[13:28:17.843] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:243:0)
[13:28:17.843] Timer tick, asking Buildbucket for the build status
[13:28:17.905] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:17.905] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:244:0) after 1m0s
[13:29:18.017] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:244:0)
[13:29:18.017] Timer tick, asking Buildbucket for the build status
[13:29:18.181] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:18.181] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:245:0) after 1m0s
[13:30:18.218] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:245:0)
[13:30:18.218] Timer tick, asking Buildbucket for the build status
[13:30:18.459] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:18.459] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:246:0) after 1m0s
[13:31:18.457] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:246:0)
[13:31:18.457] Timer tick, asking Buildbucket for the build status
[13:31:18.518] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:18.518] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:247:0) after 1m0s
[13:32:18.543] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:247:0)
[13:32:18.543] Timer tick, asking Buildbucket for the build status
[13:32:18.635] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:18.635] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:248:0) after 1m0s
[13:33:18.618] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:248:0)
[13:33:18.618] Timer tick, asking Buildbucket for the build status
[13:33:18.710] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:18.710] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:249:0) after 1m0s
[13:34:18.790] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:249:0)
[13:34:18.790] Timer tick, asking Buildbucket for the build status
[13:34:18.866] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:18.866] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:250:0) after 1m0s
[13:35:19.024] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:250:0)
[13:35:19.024] Timer tick, asking Buildbucket for the build status
[13:35:19.093] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:19.093] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:251:0) after 1m0s
[13:36:19.125] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:251:0)
[13:36:19.125] Timer tick, asking Buildbucket for the build status
[13:36:19.394] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:19.394] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:252:0) after 1m0s
[13:37:19.474] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:252:0)
[13:37:19.474] Timer tick, asking Buildbucket for the build status
[13:37:19.686] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:19.686] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:253:0) after 1m0s
[13:38:19.671] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:253:0)
[13:38:19.671] Timer tick, asking Buildbucket for the build status
[13:38:19.743] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:19.743] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:254:0) after 1m0s
[13:39:19.779] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:254:0)
[13:39:19.779] Timer tick, asking Buildbucket for the build status
[13:39:19.836] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:19.836] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:255:0) after 1m0s
[13:40:19.882] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:255:0)
[13:40:19.882] Timer tick, asking Buildbucket for the build status
[13:40:19.941] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:19.941] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:256:0) after 1m0s
[13:41:19.974] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:256:0)
[13:41:19.974] Timer tick, asking Buildbucket for the build status
[13:41:20.318] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:20.318] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:257:0) after 1m0s
[13:42:20.435] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:257:0)
[13:42:20.435] Timer tick, asking Buildbucket for the build status
[13:42:20.565] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:20.565] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:258:0) after 1m0s
[13:43:20.619] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:258:0)
[13:43:20.619] Timer tick, asking Buildbucket for the build status
[13:43:20.689] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:20.689] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:259:0) after 1m0s
[13:44:20.742] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:259:0)
[13:44:20.742] Timer tick, asking Buildbucket for the build status
[13:44:20.808] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:20.808] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:260:0) after 1m0s
[13:45:20.844] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:260:0)
[13:45:20.844] Timer tick, asking Buildbucket for the build status
[13:45:20.965] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:20.965] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:261:0) after 1m0s
[13:46:21.050] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:261:0)
[13:46:21.050] Timer tick, asking Buildbucket for the build status
[13:46:21.250] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:21.250] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:262:0) after 1m0s
[13:47:21.343] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:262:0)
[13:47:21.343] Timer tick, asking Buildbucket for the build status
[13:47:21.581] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:21.581] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:263:0) after 1m0s
[13:48:21.658] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:263:0)
[13:48:21.658] Timer tick, asking Buildbucket for the build status
[13:48:21.726] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:21.726] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:264:0) after 1m0s
[13:49:21.799] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:264:0)
[13:49:21.799] Timer tick, asking Buildbucket for the build status
[13:49:21.995] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:21.995] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:265:0) after 1m0s
[13:50:22.024] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:265:0)
[13:50:22.024] Timer tick, asking Buildbucket for the build status
[13:50:22.086] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:22.086] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:266:0) after 1m0s
[13:51:22.164] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:266:0)
[13:51:22.164] Timer tick, asking Buildbucket for the build status
[13:51:22.222] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:22.222] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:267:0) after 1m0s
[13:52:22.392] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:267:0)
[13:52:22.392] Timer tick, asking Buildbucket for the build status
[13:52:22.501] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:22.501] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:268:0) after 1m0s
[13:53:22.592] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:268:0)
[13:53:22.592] Timer tick, asking Buildbucket for the build status
[13:53:22.675] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:22.675] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:269:0) after 1m0s
[13:54:22.954] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:269:0)
[13:54:22.954] Timer tick, asking Buildbucket for the build status
[13:54:23.046] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:23.046] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:270:0) after 1m0s
[13:55:23.078] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:270:0)
[13:55:23.078] Timer tick, asking Buildbucket for the build status
[13:55:23.219] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:23.219] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:271:0) after 1m0s
[13:56:23.298] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:271:0)
[13:56:23.298] Timer tick, asking Buildbucket for the build status
[13:56:23.541] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:23.541] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:272:0) after 1m0s
[13:57:23.842] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:272:0)
[13:57:23.842] Timer tick, asking Buildbucket for the build status
[13:57:24.163] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:24.163] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:273:0) after 1m0s
[13:58:24.244] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:273:0)
[13:58:24.244] Timer tick, asking Buildbucket for the build status
[13:58:24.319] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:24.319] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:274:0) after 1m0s
[13:59:24.458] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:274:0)
[13:59:24.458] Timer tick, asking Buildbucket for the build status
[13:59:24.555] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:24.555] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:275:0) after 1m0s
[14:00:24.673] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:275:0)
[14:00:24.673] Timer tick, asking Buildbucket for the build status
[14:00:24.991] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:24.991] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:276:0) after 1m0s
[14:01:25.392] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:276:0)
[14:01:25.392] Timer tick, asking Buildbucket for the build status
[14:01:25.606] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:25.606] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:277:0) after 1m0s
[14:02:26.024] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:277:0)
[14:02:26.024] Timer tick, asking Buildbucket for the build status
[14:02:26.211] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:26.211] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:278:0) after 1m0s
[14:03:26.752] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:278:0)
[14:03:26.752] Timer tick, asking Buildbucket for the build status
[14:03:26.818] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:26.818] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:279:0) after 1m0s
[14:04:27.011] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:279:0)
[14:04:27.011] Timer tick, asking Buildbucket for the build status
[14:04:27.152] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:27.152] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:280:0) after 1m0s
[14:05:27.311] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:280:0)
[14:05:27.311] Timer tick, asking Buildbucket for the build status
[14:05:27.739] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:27.739] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:281:0) after 1m0s
[14:06:27.909] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:281:0)
[14:06:27.909] Timer tick, asking Buildbucket for the build status
[14:06:28.205] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:28.205] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:282:0) after 1m0s
[14:07:28.202] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:282:0)
[14:07:28.202] Timer tick, asking Buildbucket for the build status
[14:07:28.428] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:28.428] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:283:0) after 1m0s
[14:08:28.485] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:283:0)
[14:08:28.485] Timer tick, asking Buildbucket for the build status
[14:08:28.558] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:28.558] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:284:0) after 1m0s
[14:09:28.636] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:284:0)
[14:09:28.636] Timer tick, asking Buildbucket for the build status
[14:09:28.692] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:28.692] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:285:0) after 1m0s
[14:10:28.735] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:285:0)
[14:10:28.736] Timer tick, asking Buildbucket for the build status
[14:10:28.798] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:28.798] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:286:0) after 1m0s
[14:11:28.826] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:286:0)
[14:11:28.826] Timer tick, asking Buildbucket for the build status
[14:11:29.029] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:29.029] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:287:0) after 1m0s
[14:12:29.058] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:287:0)
[14:12:29.058] Timer tick, asking Buildbucket for the build status
[14:12:29.256] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:29.256] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:288:0) after 1m0s
[14:13:29.313] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:288:0)
[14:13:29.313] Timer tick, asking Buildbucket for the build status
[14:13:29.831] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:29.831] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:289:0) after 1m0s
[14:14:29.821] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:289:0)
[14:14:29.821] Timer tick, asking Buildbucket for the build status
[14:14:29.888] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:29.888] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:290:0) after 1m0s
[14:15:29.915] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:290:0)
[14:15:29.915] Timer tick, asking Buildbucket for the build status
[14:15:29.978] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:29.978] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:291:0) after 1m0s
[14:16:30.095] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:291:0)
[14:16:30.095] Timer tick, asking Buildbucket for the build status
[14:16:30.211] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:30.211] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:292:0) after 1m0s
[14:17:30.367] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:292:0)
[14:17:30.367] Timer tick, asking Buildbucket for the build status
[14:17:32.079] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:32.079] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:293:0) after 1m0s
[14:18:32.161] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:293:0)
[14:18:32.161] Timer tick, asking Buildbucket for the build status
[14:18:32.267] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:32.267] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:294:0) after 1m0s
[14:19:32.255] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:294:0)
[14:19:32.255] Timer tick, asking Buildbucket for the build status
[14:19:32.317] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:32.317] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:295:0) after 1m0s
[14:20:32.398] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:295:0)
[14:20:32.398] Timer tick, asking Buildbucket for the build status
[14:20:32.460] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:32.460] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:296:0) after 1m0s
[14:21:32.575] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:296:0)
[14:21:32.575] Timer tick, asking Buildbucket for the build status
[14:21:32.637] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:32.637] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:297:0) after 1m0s
[14:22:32.667] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:297:0)
[14:22:32.667] Timer tick, asking Buildbucket for the build status
[14:22:33.463] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:33.463] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:298:0) after 1m0s
[14:23:33.533] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:298:0)
[14:23:33.533] Timer tick, asking Buildbucket for the build status
[14:23:33.608] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:33.608] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:299:0) after 1m0s
[14:24:33.652] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:299:0)
[14:24:33.652] Timer tick, asking Buildbucket for the build status
[14:24:33.956] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:33.956] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:300:0) after 1m0s
[14:25:33.995] Handling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:300:0)
[14:25:33.995] Timer tick, asking Buildbucket for the build status
[14:25:34.077] Build 8862941677848208848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:34.077] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9028371739881673456:301:0) after 1m0s
[14:26:28.320] Received PubSub notification, asking Buildbucket for the build status
[14:26:28.388] Build 8862941677848208848: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:26:28.388] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606055187193557",
"created_by": "project:chromium",
"created_ts": "1606037176237976",
"id": "8862941677848208848",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"93f8fa9ab5d7288fd984f90c0eef8d9c5f8c801a\"}}",
"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\": \"93f8fa9ab5d7288fd984f90c0eef8d9c5f8c801a\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"win-dbg-6-odws\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 1058, \"got_angle_revision\": \"ebf890fcf9f3e297dcb0736b31bce3e63d63c4d7\", \"got_dawn_revision\": \"546a7c98c89718f2dadf1ae07088fa7cf2ccb53f\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"93f8fa9ab5d7288fd984f90c0eef8d9c5f8c801a\", \"got_revision_cp\": \"refs/heads/master@{#830034}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"6d612051c083238db89541be4fbb2d624a9baef4\", \"got_v8_revision\": \"805e8b5987e5fd07adbe998f0c21f84cb20468b8\", \"got_v8_revision_cp\": \"refs/heads/8.9.32@{#1}\", \"got_webrtc_revision\": \"7d75f2ca782f38006bb65bc67533e582190454e8\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32659}\", \"mirrored_builders\": [\"tryserver.chromium:win-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"93f8fa9ab5d7288fd984f90c0eef8d9c5f8c801a\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_524f8de60e2e268c779ae418ab45c03e275f35b08b0301b32216fe5285dcafcd_v2\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-6-odws\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5637-4d8b832\"], \"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": "1606037182012007",
"status": "COMPLETED",
"status_changed_ts": "1606055187532425",
"tags": [
"build_address:luci.chromium.ci/win-official/1058",
"builder:win-official",
"buildset:commit/git/93f8fa9ab5d7288fd984f90c0eef8d9c5f8c801a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/93f8fa9ab5d7288fd984f90c0eef8d9c5f8c801a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028371739881673456",
"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/8862941677848208848/+/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:5008180b9285af10",
"user_agent:luci-scheduler"
],
"updated_ts": "1606055187601966",
"url": "https://ci.chromium.org/b/8862941677848208848",
"utcnow_ts": "1606055188379829"
}
}
[14:26:28.388] Invocation finished in 5h0m13.474885649s with status SUCCEEDED