[11:03:44.634] New invocation is queued and will start shortly
[11:03:45.708] Starting the invocation (attempt 1)
[11:03:45.757] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:03:45.757] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:03:45.758] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020211879045903552",
"parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"60d6d0ad56b6def9c27a6e0a72b739545bba6b5b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-official",
"scheduler_invocation_id:9020211879045903552",
"scheduler_job_id:chromium/win-official",
"user_agent:luci-scheduler",
"buildset:commit/git/60d6d0ad56b6def9c27a6e0a72b739545bba6b5b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/60d6d0ad56b6def9c27a6e0a72b739545bba6b5b",
"gitiles_ref:refs/heads/master"
]
}
[11:03:46.573] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1613819025902657",
"id": "8854781817054360336",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"60d6d0ad56b6def9c27a6e0a72b739545bba6b5b\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613819026322551",
"tags": [
"build_address:luci.chromium.ci/win-official/1630",
"builder:win-official",
"buildset:commit/git/60d6d0ad56b6def9c27a6e0a72b739545bba6b5b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/60d6d0ad56b6def9c27a6e0a72b739545bba6b5b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020211879045903552",
"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/8854781817054360336/+/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": "1613819026322694",
"url": "https://ci.chromium.org/b/8854781817054360336",
"utcnow_ts": "1613819026565436"
}
}
[11:03:46.573] Task URL: https://ci.chromium.org/b/8854781817054360336
[11:03:46.573] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:2:0) after 1m0s
[11:04:46.591] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:2:0)
[11:04:46.591] Timer tick, asking Buildbucket for the build status
[11:04:46.676] Build 8854781817054360336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:04:46.676] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:3:0) after 1m0s
[11:05:39.033] Received PubSub notification, asking Buildbucket for the build status
[11:05:39.191] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:46.750] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:3:0)
[11:05:46.750] Timer tick, asking Buildbucket for the build status
[11:05:46.857] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:46.857] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:5:0) after 1m0s
[11:06:46.895] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:5:0)
[11:06:46.895] Timer tick, asking Buildbucket for the build status
[11:06:46.989] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:46.989] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:6:0) after 1m0s
[11:07:47.052] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:6:0)
[11:07:47.052] Timer tick, asking Buildbucket for the build status
[11:07:47.226] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:47.226] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:7:0) after 1m0s
[11:08:47.245] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:7:0)
[11:08:47.245] Timer tick, asking Buildbucket for the build status
[11:08:47.320] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:47.320] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:8:0) after 1m0s
[11:09:47.322] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:8:0)
[11:09:47.322] Timer tick, asking Buildbucket for the build status
[11:09:47.650] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:47.650] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:9:0) after 1m0s
[11:10:47.680] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:9:0)
[11:10:47.680] Timer tick, asking Buildbucket for the build status
[11:10:47.754] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:47.754] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:10:0) after 1m0s
[11:11:47.824] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:10:0)
[11:11:47.824] Timer tick, asking Buildbucket for the build status
[11:11:48.100] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:48.100] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:11:0) after 1m0s
[11:12:48.116] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:11:0)
[11:12:48.116] Timer tick, asking Buildbucket for the build status
[11:12:48.201] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:48.201] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:12:0) after 1m0s
[11:13:48.224] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:12:0)
[11:13:48.224] Timer tick, asking Buildbucket for the build status
[11:13:48.293] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:48.293] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:13:0) after 1m0s
[11:14:48.413] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:13:0)
[11:14:48.413] Timer tick, asking Buildbucket for the build status
[11:14:48.617] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:48.617] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:14:0) after 1m0s
[11:15:48.634] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:14:0)
[11:15:48.634] Timer tick, asking Buildbucket for the build status
[11:15:48.701] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:48.701] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:15:0) after 1m0s
[11:16:48.797] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:15:0)
[11:16:48.797] Timer tick, asking Buildbucket for the build status
[11:16:49.125] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:49.125] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:16:0) after 1m0s
[11:17:49.143] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:16:0)
[11:17:49.143] Timer tick, asking Buildbucket for the build status
[11:17:49.217] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:49.217] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:17:0) after 1m0s
[11:18:49.247] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:17:0)
[11:18:49.247] Timer tick, asking Buildbucket for the build status
[11:18:49.345] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:49.346] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:18:0) after 1m0s
[11:19:49.365] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:18:0)
[11:19:49.365] Timer tick, asking Buildbucket for the build status
[11:19:49.510] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:49.510] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:19:0) after 1m0s
[11:20:49.577] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:19:0)
[11:20:49.577] Timer tick, asking Buildbucket for the build status
[11:20:49.743] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:49.743] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:20:0) after 1m0s
[11:21:49.821] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:20:0)
[11:21:49.821] Timer tick, asking Buildbucket for the build status
[11:21:50.001] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:50.001] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:21:0) after 1m0s
[11:22:49.990] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:21:0)
[11:22:49.990] Timer tick, asking Buildbucket for the build status
[11:22:50.053] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:50.053] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:22:0) after 1m0s
[11:23:50.084] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:22:0)
[11:23:50.084] Timer tick, asking Buildbucket for the build status
[11:23:50.159] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:50.160] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:23:0) after 1m0s
[11:24:50.160] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:23:0)
[11:24:50.160] Timer tick, asking Buildbucket for the build status
[11:24:50.232] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:50.232] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:24:0) after 1m0s
[11:25:50.335] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:24:0)
[11:25:50.335] Timer tick, asking Buildbucket for the build status
[11:25:50.719] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:50.719] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:25:0) after 1m0s
[11:26:50.749] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:25:0)
[11:26:50.749] Timer tick, asking Buildbucket for the build status
[11:26:50.896] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:50.897] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:26:0) after 1m0s
[11:27:50.920] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:26:0)
[11:27:50.920] Timer tick, asking Buildbucket for the build status
[11:27:51.221] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:51.221] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:27:0) after 1m0s
[11:28:51.289] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:27:0)
[11:28:51.289] Timer tick, asking Buildbucket for the build status
[11:28:51.665] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:51.665] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:28:0) after 1m0s
[11:29:51.686] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:28:0)
[11:29:51.686] Timer tick, asking Buildbucket for the build status
[11:29:51.815] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:51.815] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:29:0) after 1m0s
[11:30:51.884] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:29:0)
[11:30:51.884] Timer tick, asking Buildbucket for the build status
[11:30:52.009] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:52.009] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:30:0) after 1m0s
[11:31:52.033] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:30:0)
[11:31:52.033] Timer tick, asking Buildbucket for the build status
[11:31:52.138] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:52.138] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:31:0) after 1m0s
[11:32:52.183] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:31:0)
[11:32:52.183] Timer tick, asking Buildbucket for the build status
[11:32:52.255] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:52.255] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:32:0) after 1m0s
[11:33:52.323] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:32:0)
[11:33:52.323] Timer tick, asking Buildbucket for the build status
[11:33:52.406] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:52.406] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:33:0) after 1m0s
[11:34:52.436] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:33:0)
[11:34:52.436] Timer tick, asking Buildbucket for the build status
[11:34:52.508] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:52.508] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:34:0) after 1m0s
[11:35:52.560] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:34:0)
[11:35:52.560] Timer tick, asking Buildbucket for the build status
[11:35:52.815] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:52.815] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:35:0) after 1m0s
[11:36:52.808] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:35:0)
[11:36:52.808] Timer tick, asking Buildbucket for the build status
[11:36:52.997] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:52.997] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:36:0) after 1m0s
[11:37:53.064] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:36:0)
[11:37:53.064] Timer tick, asking Buildbucket for the build status
[11:37:53.162] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:53.162] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:37:0) after 1m0s
[11:38:53.180] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:37:0)
[11:38:53.180] Timer tick, asking Buildbucket for the build status
[11:38:53.271] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:53.271] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:38:0) after 1m0s
[11:39:53.286] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:38:0)
[11:39:53.286] Timer tick, asking Buildbucket for the build status
[11:39:53.438] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:53.438] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:39:0) after 1m0s
[11:40:53.455] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:39:0)
[11:40:53.455] Timer tick, asking Buildbucket for the build status
[11:40:53.549] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:53.549] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:40:0) after 1m0s
[11:41:53.616] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:40:0)
[11:41:53.616] Timer tick, asking Buildbucket for the build status
[11:41:53.766] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:53.766] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:41:0) after 1m0s
[11:42:53.855] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:41:0)
[11:42:53.855] Timer tick, asking Buildbucket for the build status
[11:42:53.927] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:53.927] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:42:0) after 1m0s
[11:43:53.952] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:42:0)
[11:43:53.952] Timer tick, asking Buildbucket for the build status
[11:43:54.025] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:54.025] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:43:0) after 1m0s
[11:44:54.042] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:43:0)
[11:44:54.042] Timer tick, asking Buildbucket for the build status
[11:44:54.125] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:54.125] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:44:0) after 1m0s
[11:45:54.104] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:44:0)
[11:45:54.104] Timer tick, asking Buildbucket for the build status
[11:45:54.190] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:54.190] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:45:0) after 1m0s
[11:46:54.317] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:45:0)
[11:46:54.317] Timer tick, asking Buildbucket for the build status
[11:46:54.391] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:54.391] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:46:0) after 1m0s
[11:47:54.510] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:46:0)
[11:47:54.510] Timer tick, asking Buildbucket for the build status
[11:47:54.588] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:54.588] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:47:0) after 1m0s
[11:48:54.606] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:47:0)
[11:48:54.606] Timer tick, asking Buildbucket for the build status
[11:48:54.914] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:54.914] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:48:0) after 1m0s
[11:49:54.912] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:48:0)
[11:49:54.912] Timer tick, asking Buildbucket for the build status
[11:49:54.987] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:54.987] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:49:0) after 1m0s
[11:50:55.021] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:49:0)
[11:50:55.021] Timer tick, asking Buildbucket for the build status
[11:50:55.092] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:55.092] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:50:0) after 1m0s
[11:51:55.145] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:50:0)
[11:51:55.145] Timer tick, asking Buildbucket for the build status
[11:51:55.252] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:55.252] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:51:0) after 1m0s
[11:52:55.273] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:51:0)
[11:52:55.273] Timer tick, asking Buildbucket for the build status
[11:52:55.360] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:55.360] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:52:0) after 1m0s
[11:53:55.461] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:52:0)
[11:53:55.461] Timer tick, asking Buildbucket for the build status
[11:53:55.563] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:55.563] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:53:0) after 1m0s
[11:54:55.698] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:53:0)
[11:54:55.698] Timer tick, asking Buildbucket for the build status
[11:54:56.017] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:56.017] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:54:0) after 1m0s
[11:55:56.058] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:54:0)
[11:55:56.058] Timer tick, asking Buildbucket for the build status
[11:55:56.130] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:56.130] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:55:0) after 1m0s
[11:56:56.154] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:55:0)
[11:56:56.154] Timer tick, asking Buildbucket for the build status
[11:56:56.255] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:56.255] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:56:0) after 1m0s
[11:57:56.386] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:56:0)
[11:57:56.386] Timer tick, asking Buildbucket for the build status
[11:57:56.615] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:56.615] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:57:0) after 1m0s
[11:58:56.658] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:57:0)
[11:58:56.658] Timer tick, asking Buildbucket for the build status
[11:58:57.002] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:57.002] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:58:0) after 1m0s
[11:59:57.042] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:58:0)
[11:59:57.042] Timer tick, asking Buildbucket for the build status
[11:59:57.209] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:57.209] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:59:0) after 1m0s
[12:00:57.281] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:59:0)
[12:00:57.281] Timer tick, asking Buildbucket for the build status
[12:00:57.362] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:57.362] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:60:0) after 1m0s
[12:01:57.387] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:60:0)
[12:01:57.387] Timer tick, asking Buildbucket for the build status
[12:01:57.477] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:57.477] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:61:0) after 1m0s
[12:02:57.599] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:61:0)
[12:02:57.599] Timer tick, asking Buildbucket for the build status
[12:02:57.689] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:57.689] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:62:0) after 1m0s
[12:03:57.857] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:62:0)
[12:03:57.857] Timer tick, asking Buildbucket for the build status
[12:03:58.241] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:58.241] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:63:0) after 1m0s
[12:04:59.532] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:63:0)
[12:04:59.532] Timer tick, asking Buildbucket for the build status
[12:04:59.700] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:59.700] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:64:0) after 1m0s
[12:05:59.995] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:64:0)
[12:05:59.995] Timer tick, asking Buildbucket for the build status
[12:06:00.072] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:00.072] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:65:0) after 1m0s
[12:07:00.317] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:65:0)
[12:07:00.317] Timer tick, asking Buildbucket for the build status
[12:07:00.387] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:00.387] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:66:0) after 1m0s
[12:08:04.709] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:66:0)
[12:08:04.709] Timer tick, asking Buildbucket for the build status
[12:08:04.788] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:04.788] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:67:0) after 1m0s
[12:09:04.862] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:67:0)
[12:09:04.862] Timer tick, asking Buildbucket for the build status
[12:09:04.971] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:04.971] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:68:0) after 1m0s
[12:10:04.948] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:68:0)
[12:10:04.948] Timer tick, asking Buildbucket for the build status
[12:10:05.039] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:05.039] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:69:0) after 1m0s
[12:11:05.203] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:69:0)
[12:11:05.203] Timer tick, asking Buildbucket for the build status
[12:11:05.299] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:05.299] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:70:0) after 1m0s
[12:12:05.319] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:70:0)
[12:12:05.319] Timer tick, asking Buildbucket for the build status
[12:12:05.419] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:05.419] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:71:0) after 1m0s
[12:13:05.662] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:71:0)
[12:13:05.662] Timer tick, asking Buildbucket for the build status
[12:13:05.735] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:05.735] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:72:0) after 1m0s
[12:14:05.959] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:72:0)
[12:14:05.959] Timer tick, asking Buildbucket for the build status
[12:14:06.110] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:06.110] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:73:0) after 1m0s
[12:15:06.500] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:73:0)
[12:15:06.500] Timer tick, asking Buildbucket for the build status
[12:15:06.581] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:06.581] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:74:0) after 1m0s
[12:16:06.743] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:74:0)
[12:16:06.743] Timer tick, asking Buildbucket for the build status
[12:16:06.824] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:06.824] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:75:0) after 1m0s
[12:17:06.995] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:75:0)
[12:17:06.995] Timer tick, asking Buildbucket for the build status
[12:17:07.122] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:07.122] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:76:0) after 1m0s
[12:18:07.224] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:76:0)
[12:18:07.224] Timer tick, asking Buildbucket for the build status
[12:18:07.284] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:07.284] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:77:0) after 1m0s
[12:19:09.055] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:77:0)
[12:19:09.055] Timer tick, asking Buildbucket for the build status
[12:19:09.131] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:09.131] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:78:0) after 1m0s
[12:20:09.749] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:78:0)
[12:20:09.749] Timer tick, asking Buildbucket for the build status
[12:20:09.847] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:09.847] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:79:0) after 1m0s
[12:21:10.375] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:79:0)
[12:21:10.375] Timer tick, asking Buildbucket for the build status
[12:21:10.465] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:10.465] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:80:0) after 1m0s
[12:22:10.488] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:80:0)
[12:22:10.488] Timer tick, asking Buildbucket for the build status
[12:22:10.598] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:10.598] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:81:0) after 1m0s
[12:23:10.648] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:81:0)
[12:23:10.648] Timer tick, asking Buildbucket for the build status
[12:23:10.729] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:10.729] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:82:0) after 1m0s
[12:24:10.731] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:82:0)
[12:24:10.731] Timer tick, asking Buildbucket for the build status
[12:24:10.843] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:10.843] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:83:0) after 1m0s
[12:25:10.933] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:83:0)
[12:25:10.933] Timer tick, asking Buildbucket for the build status
[12:25:11.329] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:11.329] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:84:0) after 1m0s
[12:26:11.392] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:84:0)
[12:26:11.392] Timer tick, asking Buildbucket for the build status
[12:26:11.524] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:11.524] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:85:0) after 1m0s
[12:27:11.546] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:85:0)
[12:27:11.546] Timer tick, asking Buildbucket for the build status
[12:27:11.620] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:11.620] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:86:0) after 1m0s
[12:28:11.682] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:86:0)
[12:28:11.682] Timer tick, asking Buildbucket for the build status
[12:28:12.060] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:12.060] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:87:0) after 1m0s
[12:29:12.128] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:87:0)
[12:29:12.128] Timer tick, asking Buildbucket for the build status
[12:29:12.287] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:12.287] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:88:0) after 1m0s
[12:30:12.310] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:88:0)
[12:30:12.310] Timer tick, asking Buildbucket for the build status
[12:30:12.434] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:12.434] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:89:0) after 1m0s
[12:31:12.700] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:89:0)
[12:31:12.700] Timer tick, asking Buildbucket for the build status
[12:31:12.771] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:12.771] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:90:0) after 1m0s
[12:32:12.988] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:90:0)
[12:32:12.988] Timer tick, asking Buildbucket for the build status
[12:32:13.087] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:13.087] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:91:0) after 1m0s
[12:33:13.143] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:91:0)
[12:33:13.143] Timer tick, asking Buildbucket for the build status
[12:33:13.211] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:13.211] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:92:0) after 1m0s
[12:34:13.326] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:92:0)
[12:34:13.326] Timer tick, asking Buildbucket for the build status
[12:34:13.392] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:13.392] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:93:0) after 1m0s
[12:35:13.490] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:93:0)
[12:35:13.490] Timer tick, asking Buildbucket for the build status
[12:35:13.559] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:13.559] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:94:0) after 1m0s
[12:36:13.822] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:94:0)
[12:36:13.822] Timer tick, asking Buildbucket for the build status
[12:36:14.017] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:14.017] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:95:0) after 1m0s
[12:37:14.165] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:95:0)
[12:37:14.165] Timer tick, asking Buildbucket for the build status
[12:37:14.427] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:14.427] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:96:0) after 1m0s
[12:38:14.586] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:96:0)
[12:38:14.587] Timer tick, asking Buildbucket for the build status
[12:38:14.717] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:14.717] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:97:0) after 1m0s
[12:39:14.780] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:97:0)
[12:39:14.780] Timer tick, asking Buildbucket for the build status
[12:39:14.859] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:14.859] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:98:0) after 1m0s
[12:40:14.918] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:98:0)
[12:40:14.918] Timer tick, asking Buildbucket for the build status
[12:40:15.424] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:15.424] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:99:0) after 1m0s
[12:41:15.517] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:99:0)
[12:41:15.517] Timer tick, asking Buildbucket for the build status
[12:41:15.611] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:15.611] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:100:0) after 1m0s
[12:42:15.631] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:100:0)
[12:42:15.631] Timer tick, asking Buildbucket for the build status
[12:42:15.690] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:15.690] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:101:0) after 1m0s
[12:43:15.765] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:101:0)
[12:43:15.765] Timer tick, asking Buildbucket for the build status
[12:43:15.836] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:15.836] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:102:0) after 1m0s
[12:44:15.833] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:102:0)
[12:44:15.833] Timer tick, asking Buildbucket for the build status
[12:44:16.313] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:16.313] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:103:0) after 1m0s
[12:45:16.392] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:103:0)
[12:45:16.392] Timer tick, asking Buildbucket for the build status
[12:45:16.643] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:16.643] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:104:0) after 1m0s
[12:46:16.668] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:104:0)
[12:46:16.668] Timer tick, asking Buildbucket for the build status
[12:46:16.787] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:16.787] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:105:0) after 1m0s
[12:47:16.885] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:105:0)
[12:47:16.886] Timer tick, asking Buildbucket for the build status
[12:47:17.148] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:17.148] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:106:0) after 1m0s
[12:48:17.173] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:106:0)
[12:48:17.173] Timer tick, asking Buildbucket for the build status
[12:48:17.246] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:17.246] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:107:0) after 1m0s
[12:49:17.230] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:107:0)
[12:49:17.230] Timer tick, asking Buildbucket for the build status
[12:49:17.299] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:17.299] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:108:0) after 1m0s
[12:50:17.391] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:108:0)
[12:50:17.391] Timer tick, asking Buildbucket for the build status
[12:50:17.477] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:17.477] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:109:0) after 1m0s
[12:51:17.496] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:109:0)
[12:51:17.496] Timer tick, asking Buildbucket for the build status
[12:51:17.586] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:17.586] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:110:0) after 1m0s
[12:52:17.608] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:110:0)
[12:52:17.608] Timer tick, asking Buildbucket for the build status
[12:52:17.695] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:17.695] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:111:0) after 1m0s
[12:53:17.714] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:111:0)
[12:53:17.714] Timer tick, asking Buildbucket for the build status
[12:53:17.783] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:17.783] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:112:0) after 1m0s
[12:54:17.883] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:112:0)
[12:54:17.883] Timer tick, asking Buildbucket for the build status
[12:54:17.976] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:17.976] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:113:0) after 1m0s
[12:55:18.025] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:113:0)
[12:55:18.025] Timer tick, asking Buildbucket for the build status
[12:55:18.118] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:18.118] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:114:0) after 1m0s
[12:56:18.142] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:114:0)
[12:56:18.142] Timer tick, asking Buildbucket for the build status
[12:56:18.335] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:18.335] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:115:0) after 1m0s
[12:57:18.354] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:115:0)
[12:57:18.354] Timer tick, asking Buildbucket for the build status
[12:57:18.430] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:18.430] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:116:0) after 1m0s
[12:58:18.470] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:116:0)
[12:58:18.470] Timer tick, asking Buildbucket for the build status
[12:58:18.541] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:18.541] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:117:0) after 1m0s
[12:59:18.528] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:117:0)
[12:59:18.528] Timer tick, asking Buildbucket for the build status
[12:59:18.614] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:18.614] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:118:0) after 1m0s
[13:00:18.691] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:118:0)
[13:00:18.691] Timer tick, asking Buildbucket for the build status
[13:00:18.806] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:18.806] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:119:0) after 1m0s
[13:01:18.861] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:119:0)
[13:01:18.861] Timer tick, asking Buildbucket for the build status
[13:01:19.201] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:19.201] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:120:0) after 1m0s
[13:02:19.281] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:120:0)
[13:02:19.281] Timer tick, asking Buildbucket for the build status
[13:02:19.363] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:19.363] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:121:0) after 1m0s
[13:03:19.525] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:121:0)
[13:03:19.525] Timer tick, asking Buildbucket for the build status
[13:03:19.649] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:19.649] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:122:0) after 1m0s
[13:04:19.721] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:122:0)
[13:04:19.721] Timer tick, asking Buildbucket for the build status
[13:04:19.852] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:19.852] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:123:0) after 1m0s
[13:05:19.891] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:123:0)
[13:05:19.891] Timer tick, asking Buildbucket for the build status
[13:05:19.954] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:19.954] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:124:0) after 1m0s
[13:06:19.984] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:124:0)
[13:06:19.984] Timer tick, asking Buildbucket for the build status
[13:06:20.052] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:20.052] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:125:0) after 1m0s
[13:07:20.076] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:125:0)
[13:07:20.076] Timer tick, asking Buildbucket for the build status
[13:07:20.177] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:20.177] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:126:0) after 1m0s
[13:08:20.236] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:126:0)
[13:08:20.236] Timer tick, asking Buildbucket for the build status
[13:08:20.293] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:20.293] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:127:0) after 1m0s
[13:09:20.332] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:127:0)
[13:09:20.332] Timer tick, asking Buildbucket for the build status
[13:09:20.405] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:20.405] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:128:0) after 1m0s
[13:10:20.482] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:128:0)
[13:10:20.482] Timer tick, asking Buildbucket for the build status
[13:10:20.566] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:20.566] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:129:0) after 1m0s
[13:11:20.590] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:129:0)
[13:11:20.590] Timer tick, asking Buildbucket for the build status
[13:11:20.728] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:20.728] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:130:0) after 1m0s
[13:12:20.867] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:130:0)
[13:12:20.867] Timer tick, asking Buildbucket for the build status
[13:12:20.951] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:20.951] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:131:0) after 1m0s
[13:13:21.062] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:131:0)
[13:13:21.062] Timer tick, asking Buildbucket for the build status
[13:13:21.153] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:21.153] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:132:0) after 1m0s
[13:14:21.200] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:132:0)
[13:14:21.200] Timer tick, asking Buildbucket for the build status
[13:14:21.914] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:21.915] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:133:0) after 1m0s
[13:15:22.112] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:133:0)
[13:15:22.112] Timer tick, asking Buildbucket for the build status
[13:15:22.219] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:22.219] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:134:0) after 1m0s
[13:16:22.291] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:134:0)
[13:16:22.291] Timer tick, asking Buildbucket for the build status
[13:16:22.372] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:22.372] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:135:0) after 1m0s
[13:17:22.445] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:135:0)
[13:17:22.445] Timer tick, asking Buildbucket for the build status
[13:17:22.544] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:22.544] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:136:0) after 1m0s
[13:18:22.572] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:136:0)
[13:18:22.572] Timer tick, asking Buildbucket for the build status
[13:18:22.772] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:22.772] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:137:0) after 1m0s
[13:19:22.792] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:137:0)
[13:19:22.792] Timer tick, asking Buildbucket for the build status
[13:19:22.868] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:22.868] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:138:0) after 1m0s
[13:20:22.891] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:138:0)
[13:20:22.895] Timer tick, asking Buildbucket for the build status
[13:20:22.964] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:22.964] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:139:0) after 1m0s
[13:21:23.002] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:139:0)
[13:21:23.002] Timer tick, asking Buildbucket for the build status
[13:21:23.081] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:23.081] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:140:0) after 1m0s
[13:22:23.229] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:140:0)
[13:22:23.229] Timer tick, asking Buildbucket for the build status
[13:22:23.322] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:23.322] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:141:0) after 1m0s
[13:23:23.412] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:141:0)
[13:23:23.412] Timer tick, asking Buildbucket for the build status
[13:23:23.507] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:23.507] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:142:0) after 1m0s
[13:24:23.593] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:142:0)
[13:24:23.593] Timer tick, asking Buildbucket for the build status
[13:24:23.663] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:23.663] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:143:0) after 1m0s
[13:25:23.760] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:143:0)
[13:25:23.760] Timer tick, asking Buildbucket for the build status
[13:25:23.870] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:23.870] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:144:0) after 1m0s
[13:26:23.951] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:144:0)
[13:26:23.951] Timer tick, asking Buildbucket for the build status
[13:26:24.061] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:24.061] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:145:0) after 1m0s
[13:27:24.140] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:145:0)
[13:27:24.140] Timer tick, asking Buildbucket for the build status
[13:27:24.210] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:24.210] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:146:0) after 1m0s
[13:28:24.299] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:146:0)
[13:28:24.299] Timer tick, asking Buildbucket for the build status
[13:28:24.518] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:24.518] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:147:0) after 1m0s
[13:29:24.601] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:147:0)
[13:29:24.601] Timer tick, asking Buildbucket for the build status
[13:29:24.686] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:24.686] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:148:0) after 1m0s
[13:30:24.877] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:148:0)
[13:30:24.877] Timer tick, asking Buildbucket for the build status
[13:30:25.045] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:25.045] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:149:0) after 1m0s
[13:31:25.156] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:149:0)
[13:31:25.156] Timer tick, asking Buildbucket for the build status
[13:31:25.229] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:25.229] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:150:0) after 1m0s
[13:32:25.480] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:150:0)
[13:32:25.480] Timer tick, asking Buildbucket for the build status
[13:32:25.712] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:25.712] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:151:0) after 1m0s
[13:33:25.782] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:151:0)
[13:33:25.782] Timer tick, asking Buildbucket for the build status
[13:33:25.855] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:25.855] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:152:0) after 1m0s
[13:34:25.952] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:152:0)
[13:34:25.952] Timer tick, asking Buildbucket for the build status
[13:34:26.047] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:26.047] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:153:0) after 1m0s
[13:35:26.120] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:153:0)
[13:35:26.120] Timer tick, asking Buildbucket for the build status
[13:35:26.201] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:26.201] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:154:0) after 1m0s
[13:36:26.248] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:154:0)
[13:36:26.248] Timer tick, asking Buildbucket for the build status
[13:36:26.429] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:26.429] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:155:0) after 1m0s
[13:37:26.502] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:155:0)
[13:37:26.502] Timer tick, asking Buildbucket for the build status
[13:37:26.588] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:26.588] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:156:0) after 1m0s
[13:38:26.610] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:156:0)
[13:38:26.611] Timer tick, asking Buildbucket for the build status
[13:38:27.114] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:27.114] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:157:0) after 1m0s
[13:39:27.238] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:157:0)
[13:39:27.238] Timer tick, asking Buildbucket for the build status
[13:39:27.487] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:27.487] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:158:0) after 1m0s
[13:40:27.547] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:158:0)
[13:40:27.547] Timer tick, asking Buildbucket for the build status
[13:40:27.719] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:27.719] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:159:0) after 1m0s
[13:41:27.743] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:159:0)
[13:41:27.743] Timer tick, asking Buildbucket for the build status
[13:41:27.808] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:27.808] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:160:0) after 1m0s
[13:42:27.835] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:160:0)
[13:42:27.835] Timer tick, asking Buildbucket for the build status
[13:42:27.912] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:27.912] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:161:0) after 1m0s
[13:43:27.984] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:161:0)
[13:43:27.984] Timer tick, asking Buildbucket for the build status
[13:43:28.060] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:28.060] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:162:0) after 1m0s
[13:44:28.078] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:162:0)
[13:44:28.078] Timer tick, asking Buildbucket for the build status
[13:44:28.185] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:28.185] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:163:0) after 1m0s
[13:45:28.261] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:163:0)
[13:45:28.261] Timer tick, asking Buildbucket for the build status
[13:45:28.338] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:28.338] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:164:0) after 1m0s
[13:46:28.354] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:164:0)
[13:46:28.354] Timer tick, asking Buildbucket for the build status
[13:46:28.419] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:28.419] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:165:0) after 1m0s
[13:47:28.501] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:165:0)
[13:47:28.501] Timer tick, asking Buildbucket for the build status
[13:47:28.784] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:28.784] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:166:0) after 1m0s
[13:48:28.835] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:166:0)
[13:48:28.835] Timer tick, asking Buildbucket for the build status
[13:48:28.904] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:28.904] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:167:0) after 1m0s
[13:49:28.908] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:167:0)
[13:49:28.908] Timer tick, asking Buildbucket for the build status
[13:49:29.038] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:29.038] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:168:0) after 1m0s
[13:50:29.068] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:168:0)
[13:50:29.068] Timer tick, asking Buildbucket for the build status
[13:50:29.272] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:29.272] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:169:0) after 1m0s
[13:51:29.301] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:169:0)
[13:51:29.301] Timer tick, asking Buildbucket for the build status
[13:51:29.378] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:29.378] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:170:0) after 1m0s
[13:52:29.400] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:170:0)
[13:52:29.400] Timer tick, asking Buildbucket for the build status
[13:52:29.603] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:29.603] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:171:0) after 1m0s
[13:53:29.641] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:171:0)
[13:53:29.641] Timer tick, asking Buildbucket for the build status
[13:53:29.711] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:29.711] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:172:0) after 1m0s
[13:54:29.742] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:172:0)
[13:54:29.742] Timer tick, asking Buildbucket for the build status
[13:54:29.859] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:29.859] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:173:0) after 1m0s
[13:55:29.882] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:173:0)
[13:55:29.882] Timer tick, asking Buildbucket for the build status
[13:55:30.331] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:30.331] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:174:0) after 1m0s
[13:56:30.352] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:174:0)
[13:56:30.352] Timer tick, asking Buildbucket for the build status
[13:56:30.423] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:30.423] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:175:0) after 1m0s
[13:57:30.444] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:175:0)
[13:57:30.444] Timer tick, asking Buildbucket for the build status
[13:57:30.525] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:30.525] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:176:0) after 1m0s
[13:58:30.549] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:176:0)
[13:58:30.549] Timer tick, asking Buildbucket for the build status
[13:58:30.613] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:30.613] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:177:0) after 1m0s
[13:59:30.669] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:177:0)
[13:59:30.669] Timer tick, asking Buildbucket for the build status
[13:59:30.748] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:30.748] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:178:0) after 1m0s
[14:00:30.773] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:178:0)
[14:00:30.773] Timer tick, asking Buildbucket for the build status
[14:00:31.081] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:31.081] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:179:0) after 1m0s
[14:01:31.138] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:179:0)
[14:01:31.138] Timer tick, asking Buildbucket for the build status
[14:01:31.280] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:31.280] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:180:0) after 1m0s
[14:02:31.286] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:180:0)
[14:02:31.286] Timer tick, asking Buildbucket for the build status
[14:02:31.356] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:31.356] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:181:0) after 1m0s
[14:03:31.388] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:181:0)
[14:03:31.388] Timer tick, asking Buildbucket for the build status
[14:03:31.455] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:31.455] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:182:0) after 1m0s
[14:04:31.480] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:182:0)
[14:04:31.480] Timer tick, asking Buildbucket for the build status
[14:04:31.557] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:31.557] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:183:0) after 1m0s
[14:05:31.591] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:183:0)
[14:05:31.591] Timer tick, asking Buildbucket for the build status
[14:05:31.693] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:31.693] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:184:0) after 1m0s
[14:06:31.746] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:184:0)
[14:06:31.746] Timer tick, asking Buildbucket for the build status
[14:06:32.037] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:32.037] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:185:0) after 1m0s
[14:07:32.053] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:185:0)
[14:07:32.053] Timer tick, asking Buildbucket for the build status
[14:07:32.127] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:32.127] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:186:0) after 1m0s
[14:08:32.194] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:186:0)
[14:08:32.194] Timer tick, asking Buildbucket for the build status
[14:08:32.451] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:32.451] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:187:0) after 1m0s
[14:09:32.511] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:187:0)
[14:09:32.511] Timer tick, asking Buildbucket for the build status
[14:09:32.579] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:32.579] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:188:0) after 1m0s
[14:10:32.585] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:188:0)
[14:10:32.585] Timer tick, asking Buildbucket for the build status
[14:10:32.681] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:32.681] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:189:0) after 1m0s
[14:11:32.701] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:189:0)
[14:11:32.701] Timer tick, asking Buildbucket for the build status
[14:11:32.827] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:32.827] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:190:0) after 1m0s
[14:12:32.893] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:190:0)
[14:12:32.893] Timer tick, asking Buildbucket for the build status
[14:12:33.139] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:33.139] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:191:0) after 1m0s
[14:13:33.168] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:191:0)
[14:13:33.168] Timer tick, asking Buildbucket for the build status
[14:13:33.240] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:33.240] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:192:0) after 1m0s
[14:14:33.289] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:192:0)
[14:14:33.289] Timer tick, asking Buildbucket for the build status
[14:14:33.389] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:33.389] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:193:0) after 1m0s
[14:15:33.444] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:193:0)
[14:15:33.444] Timer tick, asking Buildbucket for the build status
[14:15:33.749] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:33.749] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:194:0) after 1m0s
[14:16:33.794] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:194:0)
[14:16:33.794] Timer tick, asking Buildbucket for the build status
[14:16:33.889] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:33.889] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:195:0) after 1m0s
[14:17:33.944] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:195:0)
[14:17:33.944] Timer tick, asking Buildbucket for the build status
[14:17:34.343] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:34.343] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:196:0) after 1m0s
[14:18:34.369] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:196:0)
[14:18:34.369] Timer tick, asking Buildbucket for the build status
[14:18:34.464] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:34.464] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:197:0) after 1m0s
[14:19:34.513] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:197:0)
[14:19:34.513] Timer tick, asking Buildbucket for the build status
[14:19:34.591] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:34.591] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:198:0) after 1m0s
[14:20:34.651] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:198:0)
[14:20:34.651] Timer tick, asking Buildbucket for the build status
[14:20:34.843] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:34.843] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:199:0) after 1m0s
[14:21:34.884] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:199:0)
[14:21:34.884] Timer tick, asking Buildbucket for the build status
[14:21:35.108] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:35.108] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:200:0) after 1m0s
[14:22:35.104] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:200:0)
[14:22:35.104] Timer tick, asking Buildbucket for the build status
[14:22:35.216] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:35.216] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:201:0) after 1m0s
[14:23:35.241] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:201:0)
[14:23:35.241] Timer tick, asking Buildbucket for the build status
[14:23:35.611] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:35.611] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:202:0) after 1m0s
[14:24:35.683] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:202:0)
[14:24:35.683] Timer tick, asking Buildbucket for the build status
[14:24:35.760] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:35.760] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:203:0) after 1m0s
[14:25:35.741] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:203:0)
[14:25:35.741] Timer tick, asking Buildbucket for the build status
[14:25:35.899] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:35.899] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:204:0) after 1m0s
[14:26:35.921] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:204:0)
[14:26:35.921] Timer tick, asking Buildbucket for the build status
[14:26:36.117] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:36.117] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:205:0) after 1m0s
[14:27:36.173] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:205:0)
[14:27:36.173] Timer tick, asking Buildbucket for the build status
[14:27:36.419] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:36.419] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:206:0) after 1m0s
[14:28:36.491] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:206:0)
[14:28:36.491] Timer tick, asking Buildbucket for the build status
[14:28:36.642] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:36.642] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:207:0) after 1m0s
[14:29:36.676] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:207:0)
[14:29:36.676] Timer tick, asking Buildbucket for the build status
[14:29:36.757] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:36.757] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:208:0) after 1m0s
[14:30:36.801] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:208:0)
[14:30:36.801] Timer tick, asking Buildbucket for the build status
[14:30:36.893] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:36.893] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:209:0) after 1m0s
[14:31:36.978] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:209:0)
[14:31:36.978] Timer tick, asking Buildbucket for the build status
[14:31:37.202] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:37.202] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:210:0) after 1m0s
[14:32:37.223] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:210:0)
[14:32:37.223] Timer tick, asking Buildbucket for the build status
[14:32:37.432] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:37.432] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:211:0) after 1m0s
[14:33:37.461] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:211:0)
[14:33:37.461] Timer tick, asking Buildbucket for the build status
[14:33:37.615] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:37.615] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:212:0) after 1m0s
[14:34:37.637] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:212:0)
[14:34:37.637] Timer tick, asking Buildbucket for the build status
[14:34:37.899] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:37.899] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:213:0) after 1m0s
[14:35:37.890] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:213:0)
[14:35:37.890] Timer tick, asking Buildbucket for the build status
[14:35:38.023] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:38.023] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:214:0) after 1m0s
[14:36:38.048] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:214:0)
[14:36:38.048] Timer tick, asking Buildbucket for the build status
[14:36:38.202] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:38.202] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:215:0) after 1m0s
[14:37:38.293] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:215:0)
[14:37:38.293] Timer tick, asking Buildbucket for the build status
[14:37:38.445] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:38.445] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:216:0) after 1m0s
[14:38:38.511] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:216:0)
[14:38:38.511] Timer tick, asking Buildbucket for the build status
[14:38:38.605] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:38.605] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:217:0) after 1m0s
[14:39:38.646] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:217:0)
[14:39:38.646] Timer tick, asking Buildbucket for the build status
[14:39:38.725] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:38.725] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:218:0) after 1m0s
[14:40:38.790] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:218:0)
[14:40:38.790] Timer tick, asking Buildbucket for the build status
[14:40:39.109] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:39.109] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:219:0) after 1m0s
[14:41:39.122] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:219:0)
[14:41:39.122] Timer tick, asking Buildbucket for the build status
[14:41:39.216] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:39.216] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:220:0) after 1m0s
[14:42:39.256] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:220:0)
[14:42:39.256] Timer tick, asking Buildbucket for the build status
[14:42:39.513] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:39.513] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:221:0) after 1m0s
[14:43:39.537] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:221:0)
[14:43:39.537] Timer tick, asking Buildbucket for the build status
[14:43:39.613] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:39.613] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:222:0) after 1m0s
[14:44:39.635] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:222:0)
[14:44:39.635] Timer tick, asking Buildbucket for the build status
[14:44:39.702] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:39.702] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:223:0) after 1m0s
[14:45:39.723] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:223:0)
[14:45:39.723] Timer tick, asking Buildbucket for the build status
[14:45:39.803] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:39.803] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:224:0) after 1m0s
[14:46:39.889] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:224:0)
[14:46:39.889] Timer tick, asking Buildbucket for the build status
[14:46:39.962] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:39.962] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:225:0) after 1m0s
[14:47:39.990] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:225:0)
[14:47:39.990] Timer tick, asking Buildbucket for the build status
[14:47:40.055] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:40.055] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:226:0) after 1m0s
[14:48:40.049] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:226:0)
[14:48:40.049] Timer tick, asking Buildbucket for the build status
[14:48:40.155] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:40.155] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:227:0) after 1m0s
[14:49:40.183] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:227:0)
[14:49:40.183] Timer tick, asking Buildbucket for the build status
[14:49:40.461] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:40.461] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:228:0) after 1m0s
[14:50:40.501] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:228:0)
[14:50:40.501] Timer tick, asking Buildbucket for the build status
[14:50:40.580] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:40.580] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:229:0) after 1m0s
[14:51:40.663] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:229:0)
[14:51:40.663] Timer tick, asking Buildbucket for the build status
[14:51:40.915] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:40.915] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:230:0) after 1m0s
[14:52:40.968] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:230:0)
[14:52:40.968] Timer tick, asking Buildbucket for the build status
[14:52:41.300] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:41.300] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:231:0) after 1m0s
[14:53:41.322] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:231:0)
[14:53:41.322] Timer tick, asking Buildbucket for the build status
[14:53:41.850] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:41.850] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:232:0) after 1m0s
[14:54:41.850] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:232:0)
[14:54:41.850] Timer tick, asking Buildbucket for the build status
[14:54:41.965] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:41.965] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:233:0) after 1m0s
[14:55:42.102] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:233:0)
[14:55:42.102] Timer tick, asking Buildbucket for the build status
[14:55:42.187] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:42.187] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:234:0) after 1m0s
[14:56:42.249] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:234:0)
[14:56:42.249] Timer tick, asking Buildbucket for the build status
[14:56:42.326] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:42.326] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:235:0) after 1m0s
[14:57:42.389] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:235:0)
[14:57:42.389] Timer tick, asking Buildbucket for the build status
[14:57:42.453] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:42.453] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:236:0) after 1m0s
[14:58:42.497] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:236:0)
[14:58:42.497] Timer tick, asking Buildbucket for the build status
[14:58:42.564] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:42.564] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:237:0) after 1m0s
[14:59:42.589] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:237:0)
[14:59:42.589] Timer tick, asking Buildbucket for the build status
[14:59:42.657] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:42.657] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:238:0) after 1m0s
[15:00:42.659] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:238:0)
[15:00:42.659] Timer tick, asking Buildbucket for the build status
[15:00:42.796] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:42.796] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:239:0) after 1m0s
[15:01:42.866] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:239:0)
[15:01:42.866] Timer tick, asking Buildbucket for the build status
[15:01:42.950] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:42.950] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:240:0) after 1m0s
[15:02:43.037] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:240:0)
[15:02:43.037] Timer tick, asking Buildbucket for the build status
[15:02:43.135] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:43.135] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:241:0) after 1m0s
[15:03:43.207] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:241:0)
[15:03:43.207] Timer tick, asking Buildbucket for the build status
[15:03:43.483] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:43.483] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:242:0) after 1m0s
[15:04:43.602] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:242:0)
[15:04:43.602] Timer tick, asking Buildbucket for the build status
[15:04:43.686] Build 8854781817054360336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:43.686] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020211879045903552:243:0) after 1m0s
[15:05:41.218] Received PubSub notification, asking Buildbucket for the build status
[15:05:41.443] Build 8854781817054360336: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:05:41.443] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1613833539923184",
"created_by": "project:chromium",
"created_ts": "1613819025902657",
"id": "8854781817054360336",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"60d6d0ad56b6def9c27a6e0a72b739545bba6b5b\"}}",
"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\": \"60d6d0ad56b6def9c27a6e0a72b739545bba6b5b\", \"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-9-wqii\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 1630, \"got_angle_revision\": \"d3d30921fc4c74ff24d27c1ad038445fa497046e\", \"got_dawn_revision\": \"1258e245a978083cab0b707c84dea814eadb3fbb\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"60d6d0ad56b6def9c27a6e0a72b739545bba6b5b\", \"got_revision_cp\": \"refs/heads/master@{#856090}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"0cfc043a97311d6ea24f9b2f6b2b3118b05012d4\", \"got_v8_revision\": \"2430d8fffa7d4f8a0992bcb5eb3725e5367cd9ac\", \"got_v8_revision_cp\": \"refs/heads/9.0.229@{#1}\", \"got_webrtc_revision\": \"753c76a705199ea752933f3688a8e4c8233dca53\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33298}\", \"mirrored_builders\": [\"tryserver.chromium:win-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"60d6d0ad56b6def9c27a6e0a72b739545bba6b5b\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_9b3ebe5fd1c5be87380c40d216747346a59b28cf26de183f0e8e2b32e944d3c8_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-9-wqii\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5706-397711c\"], \"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": "1613819138129667",
"status": "COMPLETED",
"status_changed_ts": "1613833540515681",
"tags": [
"build_address:luci.chromium.ci/win-official/1630",
"builder:win-official",
"buildset:commit/git/60d6d0ad56b6def9c27a6e0a72b739545bba6b5b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/60d6d0ad56b6def9c27a6e0a72b739545bba6b5b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020211879045903552",
"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/8854781817054360336/+/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:51d7eda511f27310",
"user_agent:luci-scheduler"
],
"updated_ts": "1613833540608350",
"url": "https://ci.chromium.org/b/8854781817054360336",
"utcnow_ts": "1613833541421055"
}
}
[15:05:41.443] Invocation finished in 4h1m56.824484511s with status SUCCEEDED