[17:29:10.350] New invocation is queued and will start shortly
[17:29:11.926] Starting the invocation (attempt 1)
[17:29:11.972] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:29:11.991] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:29:11.991] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021003002674198656",
"parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"e5f7e2bcc716f0829a6330bd2e9ba97a69b264b3\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-official",
"scheduler_invocation_id:9021003002674198656",
"scheduler_job_id:chromium/win-official",
"user_agent:luci-scheduler",
"buildset:commit/git/e5f7e2bcc716f0829a6330bd2e9ba97a69b264b3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e5f7e2bcc716f0829a6330bd2e9ba97a69b264b3",
"gitiles_ref:refs/heads/master"
]
}
[17:29:12.887] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613064552101626",
"id": "8855572940174864496",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e5f7e2bcc716f0829a6330bd2e9ba97a69b264b3\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613064552701812",
"tags": [
"build_address:luci.chromium.ci/win-official/1583",
"builder:win-official",
"buildset:commit/git/e5f7e2bcc716f0829a6330bd2e9ba97a69b264b3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e5f7e2bcc716f0829a6330bd2e9ba97a69b264b3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021003002674198656",
"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/8855572940174864496/+/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": "1613064552701980",
"url": "https://ci.chromium.org/b/8855572940174864496",
"utcnow_ts": "1613064552877654"
}
}
[17:29:12.887] Task URL: https://ci.chromium.org/b/8855572940174864496
[17:29:12.887] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:2:0) after 1m0s
[17:30:12.896] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:2:0)
[17:30:12.896] Timer tick, asking Buildbucket for the build status
[17:30:13.878] Build 8855572940174864496: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:30:13.878] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:3:0) after 1m0s
[17:31:09.492] Received PubSub notification, asking Buildbucket for the build status
[17:31:09.637] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:14.031] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:3:0)
[17:31:14.031] Timer tick, asking Buildbucket for the build status
[17:31:14.260] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:14.260] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:5:0) after 1m0s
[17:32:14.284] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:5:0)
[17:32:14.284] Timer tick, asking Buildbucket for the build status
[17:32:14.352] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:14.352] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:6:0) after 1m0s
[17:33:14.331] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:6:0)
[17:33:14.332] Timer tick, asking Buildbucket for the build status
[17:33:14.408] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:14.409] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:7:0) after 1m0s
[17:34:14.480] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:7:0)
[17:34:14.480] Timer tick, asking Buildbucket for the build status
[17:34:14.569] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:14.569] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:8:0) after 1m0s
[17:35:14.651] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:8:0)
[17:35:14.651] Timer tick, asking Buildbucket for the build status
[17:35:15.026] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:15.026] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:9:0) after 1m0s
[17:36:15.099] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:9:0)
[17:36:15.099] Timer tick, asking Buildbucket for the build status
[17:36:15.188] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:15.188] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:10:0) after 1m0s
[17:37:15.207] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:10:0)
[17:37:15.207] Timer tick, asking Buildbucket for the build status
[17:37:15.369] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:15.369] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:11:0) after 1m0s
[17:38:15.470] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:11:0)
[17:38:15.471] Timer tick, asking Buildbucket for the build status
[17:38:15.716] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:15.716] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:12:0) after 1m0s
[17:39:15.798] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:12:0)
[17:39:15.798] Timer tick, asking Buildbucket for the build status
[17:39:15.970] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:15.970] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:13:0) after 1m0s
[17:40:15.998] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:13:0)
[17:40:15.998] Timer tick, asking Buildbucket for the build status
[17:40:16.627] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:16.627] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:14:0) after 1m0s
[17:41:16.612] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:14:0)
[17:41:16.612] Timer tick, asking Buildbucket for the build status
[17:41:17.059] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:17.059] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:15:0) after 1m0s
[17:42:17.104] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:15:0)
[17:42:17.104] Timer tick, asking Buildbucket for the build status
[17:42:17.197] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:17.198] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:16:0) after 1m0s
[17:43:17.250] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:16:0)
[17:43:17.250] Timer tick, asking Buildbucket for the build status
[17:43:17.508] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:17.508] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:17:0) after 1m0s
[17:44:17.516] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:17:0)
[17:44:17.516] Timer tick, asking Buildbucket for the build status
[17:44:17.621] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:17.621] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:18:0) after 1m0s
[17:45:17.670] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:18:0)
[17:45:17.670] Timer tick, asking Buildbucket for the build status
[17:45:17.949] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:17.949] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:19:0) after 1m0s
[17:46:18.021] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:19:0)
[17:46:18.021] Timer tick, asking Buildbucket for the build status
[17:46:18.091] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:18.091] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:20:0) after 1m0s
[17:47:18.263] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:20:0)
[17:47:18.263] Timer tick, asking Buildbucket for the build status
[17:47:18.388] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:18.388] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:21:0) after 1m0s
[17:48:18.547] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:21:0)
[17:48:18.547] Timer tick, asking Buildbucket for the build status
[17:48:18.719] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:18.719] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:22:0) after 1m0s
[17:49:18.837] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:22:0)
[17:49:18.837] Timer tick, asking Buildbucket for the build status
[17:49:19.032] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:19.032] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:23:0) after 1m0s
[17:50:19.131] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:23:0)
[17:50:19.131] Timer tick, asking Buildbucket for the build status
[17:50:19.390] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:19.391] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:24:0) after 1m0s
[17:51:19.515] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:24:0)
[17:51:19.515] Timer tick, asking Buildbucket for the build status
[17:51:19.630] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:19.630] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:25:0) after 1m0s
[17:52:19.648] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:25:0)
[17:52:19.648] Timer tick, asking Buildbucket for the build status
[17:52:19.771] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:19.772] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:26:0) after 1m0s
[17:53:19.796] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:26:0)
[17:53:19.796] Timer tick, asking Buildbucket for the build status
[17:53:19.930] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:19.930] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:27:0) after 1m0s
[17:54:19.948] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:27:0)
[17:54:19.948] Timer tick, asking Buildbucket for the build status
[17:54:20.097] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:20.097] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:28:0) after 1m0s
[17:55:20.172] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:28:0)
[17:55:20.172] Timer tick, asking Buildbucket for the build status
[17:55:20.300] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:20.300] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:29:0) after 1m0s
[17:56:20.352] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:29:0)
[17:56:20.352] Timer tick, asking Buildbucket for the build status
[17:56:20.552] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:20.552] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:30:0) after 1m0s
[17:57:20.651] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:30:0)
[17:57:20.651] Timer tick, asking Buildbucket for the build status
[17:57:20.744] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:20.744] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:31:0) after 1m0s
[17:58:20.784] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:31:0)
[17:58:20.784] Timer tick, asking Buildbucket for the build status
[17:58:21.025] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:21.025] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:32:0) after 1m0s
[17:59:21.055] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:32:0)
[17:59:21.055] Timer tick, asking Buildbucket for the build status
[17:59:21.232] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:21.232] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:33:0) after 1m0s
[18:00:21.242] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:33:0)
[18:00:21.242] Timer tick, asking Buildbucket for the build status
[18:00:21.344] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:21.344] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:34:0) after 1m0s
[18:01:21.452] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:34:0)
[18:01:21.452] Timer tick, asking Buildbucket for the build status
[18:01:21.722] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:21.722] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:35:0) after 1m0s
[18:02:21.757] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:35:0)
[18:02:21.757] Timer tick, asking Buildbucket for the build status
[18:02:21.874] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:21.874] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:36:0) after 1m0s
[18:03:21.934] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:36:0)
[18:03:21.934] Timer tick, asking Buildbucket for the build status
[18:03:22.024] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:22.024] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:37:0) after 1m0s
[18:04:22.061] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:37:0)
[18:04:22.061] Timer tick, asking Buildbucket for the build status
[18:04:22.678] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:22.678] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:38:0) after 1m0s
[18:05:22.763] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:38:0)
[18:05:22.763] Timer tick, asking Buildbucket for the build status
[18:05:22.852] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:22.852] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:39:0) after 1m0s
[18:06:22.974] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:39:0)
[18:06:22.974] Timer tick, asking Buildbucket for the build status
[18:06:23.069] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:23.069] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:40:0) after 1m0s
[18:07:23.157] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:40:0)
[18:07:23.157] Timer tick, asking Buildbucket for the build status
[18:07:23.235] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:23.235] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:41:0) after 1m0s
[18:08:23.302] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:41:0)
[18:08:23.302] Timer tick, asking Buildbucket for the build status
[18:08:23.455] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:23.455] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:42:0) after 1m0s
[18:09:23.469] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:42:0)
[18:09:23.469] Timer tick, asking Buildbucket for the build status
[18:09:23.594] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:23.594] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:43:0) after 1m0s
[18:10:23.638] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:43:0)
[18:10:23.638] Timer tick, asking Buildbucket for the build status
[18:10:23.742] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:23.742] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:44:0) after 1m0s
[18:11:23.783] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:44:0)
[18:11:23.783] Timer tick, asking Buildbucket for the build status
[18:11:24.505] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:24.505] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:45:0) after 1m0s
[18:12:24.618] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:45:0)
[18:12:24.618] Timer tick, asking Buildbucket for the build status
[18:12:24.726] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:24.726] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:46:0) after 1m0s
[18:13:24.831] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:46:0)
[18:13:24.831] Timer tick, asking Buildbucket for the build status
[18:13:25.338] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:25.338] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:47:0) after 1m0s
[18:14:25.492] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:47:0)
[18:14:25.492] Timer tick, asking Buildbucket for the build status
[18:14:25.608] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:25.608] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:48:0) after 1m0s
[18:15:25.687] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:48:0)
[18:15:25.687] Timer tick, asking Buildbucket for the build status
[18:15:25.789] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:25.789] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:49:0) after 1m0s
[18:16:25.797] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:49:0)
[18:16:25.797] Timer tick, asking Buildbucket for the build status
[18:16:25.900] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:25.901] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:50:0) after 1m0s
[18:17:26.093] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:50:0)
[18:17:26.093] Timer tick, asking Buildbucket for the build status
[18:17:26.241] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:26.241] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:51:0) after 1m0s
[18:18:26.342] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:51:0)
[18:18:26.342] Timer tick, asking Buildbucket for the build status
[18:18:26.433] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:26.433] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:52:0) after 1m0s
[18:19:26.498] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:52:0)
[18:19:26.498] Timer tick, asking Buildbucket for the build status
[18:19:26.592] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:26.592] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:53:0) after 1m0s
[18:20:26.624] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:53:0)
[18:20:26.624] Timer tick, asking Buildbucket for the build status
[18:20:26.703] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:26.703] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:54:0) after 1m0s
[18:21:26.793] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:54:0)
[18:21:26.793] Timer tick, asking Buildbucket for the build status
[18:21:27.025] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:27.025] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:55:0) after 1m0s
[18:22:27.098] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:55:0)
[18:22:27.099] Timer tick, asking Buildbucket for the build status
[18:22:27.308] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:27.308] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:56:0) after 1m0s
[18:23:27.309] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:56:0)
[18:23:27.309] Timer tick, asking Buildbucket for the build status
[18:23:27.446] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:27.446] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:57:0) after 1m0s
[18:24:27.536] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:57:0)
[18:24:27.536] Timer tick, asking Buildbucket for the build status
[18:24:27.643] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:27.643] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:58:0) after 1m0s
[18:25:27.759] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:58:0)
[18:25:27.759] Timer tick, asking Buildbucket for the build status
[18:25:27.922] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:27.922] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:59:0) after 1m0s
[18:26:27.929] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:59:0)
[18:26:27.930] Timer tick, asking Buildbucket for the build status
[18:26:28.047] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:28.047] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:60:0) after 1m0s
[18:27:28.120] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:60:0)
[18:27:28.120] Timer tick, asking Buildbucket for the build status
[18:27:28.364] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:28.364] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:61:0) after 1m0s
[18:28:28.387] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:61:0)
[18:28:28.387] Timer tick, asking Buildbucket for the build status
[18:28:28.471] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:28.471] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:62:0) after 1m0s
[18:29:28.506] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:62:0)
[18:29:28.506] Timer tick, asking Buildbucket for the build status
[18:29:28.951] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:28.951] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:63:0) after 1m0s
[18:30:29.061] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:63:0)
[18:30:29.061] Timer tick, asking Buildbucket for the build status
[18:30:29.169] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:29.169] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:64:0) after 1m0s
[18:31:29.190] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:64:0)
[18:31:29.190] Timer tick, asking Buildbucket for the build status
[18:31:29.293] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:29.293] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:65:0) after 1m0s
[18:32:29.322] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:65:0)
[18:32:29.322] Timer tick, asking Buildbucket for the build status
[18:32:29.449] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:29.449] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:66:0) after 1m0s
[18:33:29.481] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:66:0)
[18:33:29.481] Timer tick, asking Buildbucket for the build status
[18:33:29.627] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:29.627] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:67:0) after 1m0s
[18:34:29.735] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:67:0)
[18:34:29.735] Timer tick, asking Buildbucket for the build status
[18:34:30.123] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:30.123] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:68:0) after 1m0s
[18:35:30.172] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:68:0)
[18:35:30.172] Timer tick, asking Buildbucket for the build status
[18:35:30.270] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:30.270] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:69:0) after 1m0s
[18:36:30.324] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:69:0)
[18:36:30.324] Timer tick, asking Buildbucket for the build status
[18:36:30.450] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:30.450] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:70:0) after 1m0s
[18:37:30.602] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:70:0)
[18:37:30.602] Timer tick, asking Buildbucket for the build status
[18:37:30.695] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:30.695] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:71:0) after 1m0s
[18:38:30.740] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:71:0)
[18:38:30.740] Timer tick, asking Buildbucket for the build status
[18:38:31.350] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:31.350] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:72:0) after 1m0s
[18:39:31.454] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:72:0)
[18:39:31.454] Timer tick, asking Buildbucket for the build status
[18:39:32.128] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:32.128] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:73:0) after 1m0s
[18:40:32.198] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:73:0)
[18:40:32.198] Timer tick, asking Buildbucket for the build status
[18:40:32.314] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:32.314] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:74:0) after 1m0s
[18:41:32.336] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:74:0)
[18:41:32.336] Timer tick, asking Buildbucket for the build status
[18:41:32.416] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:32.416] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:75:0) after 1m0s
[18:42:32.510] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:75:0)
[18:42:32.510] Timer tick, asking Buildbucket for the build status
[18:42:32.623] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:32.623] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:76:0) after 1m0s
[18:43:32.756] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:76:0)
[18:43:32.756] Timer tick, asking Buildbucket for the build status
[18:43:32.851] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:32.851] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:77:0) after 1m0s
[18:44:32.889] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:77:0)
[18:44:32.889] Timer tick, asking Buildbucket for the build status
[18:44:32.995] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:32.995] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:78:0) after 1m0s
[18:45:33.018] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:78:0)
[18:45:33.018] Timer tick, asking Buildbucket for the build status
[18:45:33.181] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:33.181] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:79:0) after 1m0s
[18:46:33.223] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:79:0)
[18:46:33.223] Timer tick, asking Buildbucket for the build status
[18:46:33.369] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:33.369] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:80:0) after 1m0s
[18:47:34.024] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:80:0)
[18:47:34.024] Timer tick, asking Buildbucket for the build status
[18:47:34.119] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:34.119] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:81:0) after 1m0s
[18:48:34.217] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:81:0)
[18:48:34.217] Timer tick, asking Buildbucket for the build status
[18:48:34.348] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:34.348] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:82:0) after 1m0s
[18:49:34.373] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:82:0)
[18:49:34.373] Timer tick, asking Buildbucket for the build status
[18:49:34.495] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:34.495] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:83:0) after 1m0s
[18:50:34.655] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:83:0)
[18:50:34.655] Timer tick, asking Buildbucket for the build status
[18:50:35.066] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:35.066] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:84:0) after 1m0s
[18:51:35.289] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:84:0)
[18:51:35.289] Timer tick, asking Buildbucket for the build status
[18:51:35.399] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:35.399] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:85:0) after 1m0s
[18:52:35.451] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:85:0)
[18:52:35.451] Timer tick, asking Buildbucket for the build status
[18:52:35.529] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:35.529] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:86:0) after 1m0s
[18:53:35.586] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:86:0)
[18:53:35.586] Timer tick, asking Buildbucket for the build status
[18:53:35.668] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:35.668] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:87:0) after 1m0s
[18:54:35.678] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:87:0)
[18:54:35.678] Timer tick, asking Buildbucket for the build status
[18:54:35.768] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:35.768] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:88:0) after 1m0s
[18:55:35.777] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:88:0)
[18:55:35.777] Timer tick, asking Buildbucket for the build status
[18:55:35.855] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:35.855] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:89:0) after 1m0s
[18:56:36.018] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:89:0)
[18:56:36.018] Timer tick, asking Buildbucket for the build status
[18:56:36.491] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:36.492] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:90:0) after 1m0s
[18:57:36.688] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:90:0)
[18:57:36.688] Timer tick, asking Buildbucket for the build status
[18:57:36.908] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:36.908] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:91:0) after 1m0s
[18:58:37.148] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:91:0)
[18:58:37.148] Timer tick, asking Buildbucket for the build status
[18:58:37.252] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:37.252] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:92:0) after 1m0s
[18:59:37.370] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:92:0)
[18:59:37.370] Timer tick, asking Buildbucket for the build status
[18:59:37.489] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:37.489] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:93:0) after 1m0s
[19:00:39.159] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:93:0)
[19:00:39.159] Timer tick, asking Buildbucket for the build status
[19:00:39.308] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:39.308] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:94:0) after 1m0s
[19:01:39.375] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:94:0)
[19:01:39.375] Timer tick, asking Buildbucket for the build status
[19:01:39.505] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:39.505] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:95:0) after 1m0s
[19:02:39.558] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:95:0)
[19:02:39.558] Timer tick, asking Buildbucket for the build status
[19:02:39.633] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:39.633] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:96:0) after 1m0s
[19:03:39.661] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:96:0)
[19:03:39.661] Timer tick, asking Buildbucket for the build status
[19:03:39.795] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:39.795] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:97:0) after 1m0s
[19:04:39.892] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:97:0)
[19:04:39.892] Timer tick, asking Buildbucket for the build status
[19:04:39.978] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:39.979] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:98:0) after 1m0s
[19:05:40.046] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:98:0)
[19:05:40.046] Timer tick, asking Buildbucket for the build status
[19:05:40.242] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:40.242] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:99:0) after 1m0s
[19:06:40.287] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:99:0)
[19:06:40.287] Timer tick, asking Buildbucket for the build status
[19:06:40.422] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:40.422] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:100:0) after 1m0s
[19:07:40.545] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:100:0)
[19:07:40.545] Timer tick, asking Buildbucket for the build status
[19:07:40.799] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:40.799] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:101:0) after 1m0s
[19:08:40.837] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:101:0)
[19:08:40.837] Timer tick, asking Buildbucket for the build status
[19:08:40.944] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:40.944] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:102:0) after 1m0s
[19:09:41.102] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:102:0)
[19:09:41.102] Timer tick, asking Buildbucket for the build status
[19:09:41.385] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:41.385] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:103:0) after 1m0s
[19:10:41.536] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:103:0)
[19:10:41.536] Timer tick, asking Buildbucket for the build status
[19:10:41.847] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:41.847] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:104:0) after 1m0s
[19:11:41.983] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:104:0)
[19:11:41.983] Timer tick, asking Buildbucket for the build status
[19:11:42.097] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:42.097] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:105:0) after 1m0s
[19:12:42.167] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:105:0)
[19:12:42.167] Timer tick, asking Buildbucket for the build status
[19:12:42.320] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:42.320] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:106:0) after 1m0s
[19:13:42.419] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:106:0)
[19:13:42.419] Timer tick, asking Buildbucket for the build status
[19:13:42.615] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:42.615] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:107:0) after 1m0s
[19:14:42.648] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:107:0)
[19:14:42.648] Timer tick, asking Buildbucket for the build status
[19:14:42.843] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:42.843] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:108:0) after 1m0s
[19:15:42.877] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:108:0)
[19:15:42.877] Timer tick, asking Buildbucket for the build status
[19:15:43.180] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:43.180] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:109:0) after 1m0s
[19:16:43.193] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:109:0)
[19:16:43.193] Timer tick, asking Buildbucket for the build status
[19:16:43.287] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:43.287] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:110:0) after 1m0s
[19:17:43.340] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:110:0)
[19:17:43.340] Timer tick, asking Buildbucket for the build status
[19:17:43.570] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:43.570] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:111:0) after 1m0s
[19:18:43.612] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:111:0)
[19:18:43.613] Timer tick, asking Buildbucket for the build status
[19:18:43.931] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:43.931] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:112:0) after 1m0s
[19:19:43.961] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:112:0)
[19:19:43.961] Timer tick, asking Buildbucket for the build status
[19:19:44.198] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:44.198] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:113:0) after 1m0s
[19:20:44.325] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:113:0)
[19:20:44.325] Timer tick, asking Buildbucket for the build status
[19:20:44.591] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:44.591] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:114:0) after 1m0s
[19:21:44.715] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:114:0)
[19:21:44.715] Timer tick, asking Buildbucket for the build status
[19:21:44.913] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:44.913] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:115:0) after 1m0s
[19:22:45.092] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:115:0)
[19:22:45.093] Timer tick, asking Buildbucket for the build status
[19:22:45.514] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:45.514] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:116:0) after 1m0s
[19:23:45.578] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:116:0)
[19:23:45.578] Timer tick, asking Buildbucket for the build status
[19:23:45.830] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:45.830] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:117:0) after 1m0s
[19:24:45.933] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:117:0)
[19:24:45.933] Timer tick, asking Buildbucket for the build status
[19:24:46.071] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:46.071] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:118:0) after 1m0s
[19:25:46.274] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:118:0)
[19:25:46.274] Timer tick, asking Buildbucket for the build status
[19:25:46.531] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:46.531] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:119:0) after 1m0s
[19:26:46.620] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:119:0)
[19:26:46.620] Timer tick, asking Buildbucket for the build status
[19:26:46.731] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:46.732] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:120:0) after 1m0s
[19:27:46.764] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:120:0)
[19:27:46.764] Timer tick, asking Buildbucket for the build status
[19:27:47.517] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:47.517] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:121:0) after 1m0s
[19:28:47.586] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:121:0)
[19:28:47.586] Timer tick, asking Buildbucket for the build status
[19:28:47.825] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:47.825] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:122:0) after 1m0s
[19:29:47.957] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:122:0)
[19:29:47.957] Timer tick, asking Buildbucket for the build status
[19:29:48.204] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:48.204] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:123:0) after 1m0s
[19:30:48.456] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:123:0)
[19:30:48.456] Timer tick, asking Buildbucket for the build status
[19:30:48.562] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:48.562] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:124:0) after 1m0s
[19:31:48.742] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:124:0)
[19:31:48.742] Timer tick, asking Buildbucket for the build status
[19:31:48.919] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:48.919] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:125:0) after 1m0s
[19:32:49.066] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:125:0)
[19:32:49.066] Timer tick, asking Buildbucket for the build status
[19:32:49.346] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:49.346] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:126:0) after 1m0s
[19:33:49.515] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:126:0)
[19:33:49.515] Timer tick, asking Buildbucket for the build status
[19:33:49.625] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:49.625] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:127:0) after 1m0s
[19:34:49.825] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:127:0)
[19:34:49.825] Timer tick, asking Buildbucket for the build status
[19:34:50.018] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:50.018] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:128:0) after 1m0s
[19:35:50.061] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:128:0)
[19:35:50.061] Timer tick, asking Buildbucket for the build status
[19:35:50.131] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:50.131] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:129:0) after 1m0s
[19:36:50.136] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:129:0)
[19:36:50.136] Timer tick, asking Buildbucket for the build status
[19:36:50.599] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:50.599] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:130:0) after 1m0s
[19:37:50.698] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:130:0)
[19:37:50.698] Timer tick, asking Buildbucket for the build status
[19:37:50.986] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:50.986] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:131:0) after 1m0s
[19:38:54.188] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:131:0)
[19:38:54.188] Timer tick, asking Buildbucket for the build status
[19:38:54.297] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:54.298] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:132:0) after 1m0s
[19:39:55.134] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:132:0)
[19:39:55.134] Timer tick, asking Buildbucket for the build status
[19:39:55.297] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:55.298] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:133:0) after 1m0s
[19:40:55.347] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:133:0)
[19:40:55.347] Timer tick, asking Buildbucket for the build status
[19:40:55.614] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:55.614] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:134:0) after 1m0s
[19:41:55.684] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:134:0)
[19:41:55.684] Timer tick, asking Buildbucket for the build status
[19:41:55.758] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:55.758] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:135:0) after 1m0s
[19:42:56.038] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:135:0)
[19:42:56.038] Timer tick, asking Buildbucket for the build status
[19:42:56.152] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:56.153] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:136:0) after 1m0s
[19:43:56.229] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:136:0)
[19:43:56.229] Timer tick, asking Buildbucket for the build status
[19:43:56.314] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:56.314] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:137:0) after 1m0s
[19:44:56.406] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:137:0)
[19:44:56.406] Timer tick, asking Buildbucket for the build status
[19:44:56.537] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:56.537] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:138:0) after 1m0s
[19:45:56.587] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:138:0)
[19:45:56.587] Timer tick, asking Buildbucket for the build status
[19:45:56.903] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:56.903] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:139:0) after 1m0s
[19:46:57.033] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:139:0)
[19:46:57.034] Timer tick, asking Buildbucket for the build status
[19:46:57.219] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:57.219] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:140:0) after 1m0s
[19:47:57.376] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:140:0)
[19:47:57.376] Timer tick, asking Buildbucket for the build status
[19:47:57.467] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:57.467] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:141:0) after 1m0s
[19:48:57.611] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:141:0)
[19:48:57.611] Timer tick, asking Buildbucket for the build status
[19:48:57.896] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:57.896] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:142:0) after 1m0s
[19:49:57.998] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:142:0)
[19:49:57.998] Timer tick, asking Buildbucket for the build status
[19:49:58.231] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:58.231] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:143:0) after 1m0s
[19:50:58.339] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:143:0)
[19:50:58.339] Timer tick, asking Buildbucket for the build status
[19:50:58.567] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:58.567] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:144:0) after 1m0s
[19:51:58.606] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:144:0)
[19:51:58.606] Timer tick, asking Buildbucket for the build status
[19:51:58.810] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:58.810] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:145:0) after 1m0s
[19:52:58.897] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:145:0)
[19:52:58.897] Timer tick, asking Buildbucket for the build status
[19:52:58.980] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:58.980] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:146:0) after 1m0s
[19:53:59.029] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:146:0)
[19:53:59.029] Timer tick, asking Buildbucket for the build status
[19:53:59.153] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:59.153] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:147:0) after 1m0s
[19:54:59.219] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:147:0)
[19:54:59.219] Timer tick, asking Buildbucket for the build status
[19:54:59.329] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:59.329] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:148:0) after 1m0s
[19:55:59.351] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:148:0)
[19:55:59.352] Timer tick, asking Buildbucket for the build status
[19:55:59.419] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:59.419] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:149:0) after 1m0s
[19:56:59.500] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:149:0)
[19:56:59.500] Timer tick, asking Buildbucket for the build status
[19:56:59.923] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:59.923] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:150:0) after 1m0s
[19:58:00.029] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:150:0)
[19:58:00.029] Timer tick, asking Buildbucket for the build status
[19:58:00.353] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:00.353] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:151:0) after 1m0s
[19:59:00.418] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:151:0)
[19:59:00.418] Timer tick, asking Buildbucket for the build status
[19:59:00.479] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:00.479] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:152:0) after 1m0s
[20:00:01.654] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:152:0)
[20:00:01.654] Timer tick, asking Buildbucket for the build status
[20:00:01.905] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:01.905] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:153:0) after 1m0s
[20:01:02.416] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:153:0)
[20:01:02.416] Timer tick, asking Buildbucket for the build status
[20:01:02.592] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:02.592] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:154:0) after 1m0s
[20:02:02.682] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:154:0)
[20:02:02.682] Timer tick, asking Buildbucket for the build status
[20:02:03.536] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:03.536] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:155:0) after 1m0s
[20:03:03.631] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:155:0)
[20:03:03.631] Timer tick, asking Buildbucket for the build status
[20:03:03.902] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:03.902] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:156:0) after 1m0s
[20:04:04.084] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:156:0)
[20:04:04.084] Timer tick, asking Buildbucket for the build status
[20:04:04.157] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:04.157] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:157:0) after 1m0s
[20:05:04.217] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:157:0)
[20:05:04.217] Timer tick, asking Buildbucket for the build status
[20:05:04.355] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:04.355] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:158:0) after 1m0s
[20:06:04.436] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:158:0)
[20:06:04.436] Timer tick, asking Buildbucket for the build status
[20:06:11.065] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:11.065] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:159:0) after 1m0s
[20:07:11.148] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:159:0)
[20:07:11.148] Timer tick, asking Buildbucket for the build status
[20:07:11.288] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:11.288] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:160:0) after 1m0s
[20:08:11.360] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:160:0)
[20:08:11.360] Timer tick, asking Buildbucket for the build status
[20:08:11.426] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:11.426] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:161:0) after 1m0s
[20:09:11.458] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:161:0)
[20:09:11.458] Timer tick, asking Buildbucket for the build status
[20:09:11.644] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:11.644] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:162:0) after 1m0s
[20:10:11.716] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:162:0)
[20:10:11.716] Timer tick, asking Buildbucket for the build status
[20:10:12.053] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:12.053] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:163:0) after 1m0s
[20:11:12.138] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:163:0)
[20:11:12.138] Timer tick, asking Buildbucket for the build status
[20:11:13.121] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:13.121] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:164:0) after 1m0s
[20:12:13.214] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:164:0)
[20:12:13.214] Timer tick, asking Buildbucket for the build status
[20:12:13.282] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:13.282] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:165:0) after 1m0s
[20:13:13.392] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:165:0)
[20:13:13.392] Timer tick, asking Buildbucket for the build status
[20:13:13.607] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:13.607] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:166:0) after 1m0s
[20:14:13.695] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:166:0)
[20:14:13.695] Timer tick, asking Buildbucket for the build status
[20:14:13.832] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:13.832] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:167:0) after 1m0s
[20:15:13.905] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:167:0)
[20:15:13.905] Timer tick, asking Buildbucket for the build status
[20:15:14.636] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:14.636] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:168:0) after 1m0s
[20:16:14.695] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:168:0)
[20:16:14.695] Timer tick, asking Buildbucket for the build status
[20:16:15.143] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:15.143] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:169:0) after 1m0s
[20:17:15.234] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:169:0)
[20:17:15.234] Timer tick, asking Buildbucket for the build status
[20:17:15.298] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:15.298] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:170:0) after 1m0s
[20:18:15.349] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:170:0)
[20:18:15.349] Timer tick, asking Buildbucket for the build status
[20:18:15.461] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:15.461] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:171:0) after 1m0s
[20:19:15.534] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:171:0)
[20:19:15.534] Timer tick, asking Buildbucket for the build status
[20:19:16.160] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:16.160] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:172:0) after 1m0s
[20:20:16.236] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:172:0)
[20:20:16.236] Timer tick, asking Buildbucket for the build status
[20:20:16.369] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:16.369] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:173:0) after 1m0s
[20:21:16.392] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:173:0)
[20:21:16.392] Timer tick, asking Buildbucket for the build status
[20:21:16.655] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:16.655] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:174:0) after 1m0s
[20:22:16.794] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:174:0)
[20:22:16.794] Timer tick, asking Buildbucket for the build status
[20:22:17.356] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:17.356] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:175:0) after 1m0s
[20:23:17.410] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:175:0)
[20:23:17.410] Timer tick, asking Buildbucket for the build status
[20:23:17.656] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:17.656] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:176:0) after 1m0s
[20:24:17.676] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:176:0)
[20:24:17.676] Timer tick, asking Buildbucket for the build status
[20:24:17.824] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:17.824] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:177:0) after 1m0s
[20:25:17.869] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:177:0)
[20:25:17.869] Timer tick, asking Buildbucket for the build status
[20:25:18.030] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:18.030] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:178:0) after 1m0s
[20:26:18.095] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:178:0)
[20:26:18.095] Timer tick, asking Buildbucket for the build status
[20:26:18.178] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:18.178] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:179:0) after 1m0s
[20:27:18.226] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:179:0)
[20:27:18.227] Timer tick, asking Buildbucket for the build status
[20:27:19.289] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:19.289] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:180:0) after 1m0s
[20:28:19.289] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:180:0)
[20:28:19.289] Timer tick, asking Buildbucket for the build status
[20:28:19.617] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:19.617] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:181:0) after 1m0s
[20:29:19.681] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:181:0)
[20:29:19.681] Timer tick, asking Buildbucket for the build status
[20:29:19.761] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:19.761] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:182:0) after 1m0s
[20:30:19.821] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:182:0)
[20:30:19.821] Timer tick, asking Buildbucket for the build status
[20:30:20.656] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:20.656] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:183:0) after 1m0s
[20:31:20.702] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:183:0)
[20:31:20.702] Timer tick, asking Buildbucket for the build status
[20:31:20.764] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:20.764] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:184:0) after 1m0s
[20:32:20.929] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:184:0)
[20:32:20.929] Timer tick, asking Buildbucket for the build status
[20:32:21.027] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:21.027] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:185:0) after 1m0s
[20:33:21.142] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:185:0)
[20:33:21.142] Timer tick, asking Buildbucket for the build status
[20:33:21.266] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:21.266] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:186:0) after 1m0s
[20:34:21.317] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:186:0)
[20:34:21.317] Timer tick, asking Buildbucket for the build status
[20:34:21.457] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:21.457] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:187:0) after 1m0s
[20:35:21.486] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:187:0)
[20:35:21.486] Timer tick, asking Buildbucket for the build status
[20:35:21.588] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:21.588] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:188:0) after 1m0s
[20:36:21.621] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:188:0)
[20:36:21.621] Timer tick, asking Buildbucket for the build status
[20:36:21.929] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:21.929] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:189:0) after 1m0s
[20:37:21.979] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:189:0)
[20:37:21.979] Timer tick, asking Buildbucket for the build status
[20:37:22.129] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:22.129] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:190:0) after 1m0s
[20:38:22.221] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:190:0)
[20:38:22.221] Timer tick, asking Buildbucket for the build status
[20:38:22.482] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:22.482] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:191:0) after 1m0s
[20:39:22.568] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:191:0)
[20:39:22.568] Timer tick, asking Buildbucket for the build status
[20:39:22.692] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:22.692] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:192:0) after 1m0s
[20:40:22.670] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:192:0)
[20:40:22.670] Timer tick, asking Buildbucket for the build status
[20:40:23.148] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:23.148] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:193:0) after 1m0s
[20:41:23.265] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:193:0)
[20:41:23.265] Timer tick, asking Buildbucket for the build status
[20:41:23.412] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:23.412] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:194:0) after 1m0s
[20:42:23.535] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:194:0)
[20:42:23.535] Timer tick, asking Buildbucket for the build status
[20:42:23.640] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:23.640] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:195:0) after 1m0s
[20:43:23.794] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:195:0)
[20:43:23.794] Timer tick, asking Buildbucket for the build status
[20:43:23.856] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:23.856] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:196:0) after 1m0s
[20:44:23.927] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:196:0)
[20:44:23.927] Timer tick, asking Buildbucket for the build status
[20:44:24.096] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:24.096] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:197:0) after 1m0s
[20:45:24.131] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:197:0)
[20:45:24.131] Timer tick, asking Buildbucket for the build status
[20:45:24.518] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:24.518] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:198:0) after 1m0s
[20:46:24.573] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:198:0)
[20:46:24.573] Timer tick, asking Buildbucket for the build status
[20:46:24.646] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:24.646] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:199:0) after 1m0s
[20:47:24.699] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:199:0)
[20:47:24.699] Timer tick, asking Buildbucket for the build status
[20:47:24.763] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:24.763] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:200:0) after 1m0s
[20:48:24.810] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:200:0)
[20:48:24.810] Timer tick, asking Buildbucket for the build status
[20:48:24.886] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:24.887] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:201:0) after 1m0s
[20:49:24.959] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:201:0)
[20:49:24.959] Timer tick, asking Buildbucket for the build status
[20:49:25.014] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:25.014] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:202:0) after 1m0s
[20:50:25.124] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:202:0)
[20:50:25.124] Timer tick, asking Buildbucket for the build status
[20:50:25.321] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:25.321] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:203:0) after 1m0s
[20:51:25.444] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:203:0)
[20:51:25.444] Timer tick, asking Buildbucket for the build status
[20:51:25.529] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:25.529] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:204:0) after 1m0s
[20:52:25.612] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:204:0)
[20:52:25.612] Timer tick, asking Buildbucket for the build status
[20:52:26.322] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:26.322] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:205:0) after 1m0s
[20:53:26.422] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:205:0)
[20:53:26.422] Timer tick, asking Buildbucket for the build status
[20:53:26.501] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:26.501] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:206:0) after 1m0s
[20:54:26.533] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:206:0)
[20:54:26.533] Timer tick, asking Buildbucket for the build status
[20:54:26.823] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:26.823] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:207:0) after 1m0s
[20:55:26.876] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:207:0)
[20:55:26.876] Timer tick, asking Buildbucket for the build status
[20:55:27.043] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:27.043] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:208:0) after 1m0s
[20:56:27.137] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:208:0)
[20:56:27.137] Timer tick, asking Buildbucket for the build status
[20:56:27.325] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:27.325] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:209:0) after 1m0s
[20:57:27.425] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:209:0)
[20:57:27.425] Timer tick, asking Buildbucket for the build status
[20:57:27.498] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:27.498] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:210:0) after 1m0s
[20:58:27.541] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:210:0)
[20:58:27.541] Timer tick, asking Buildbucket for the build status
[20:58:27.595] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:27.596] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:211:0) after 1m0s
[20:59:27.678] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:211:0)
[20:59:27.678] Timer tick, asking Buildbucket for the build status
[20:59:27.736] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:27.736] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:212:0) after 1m0s
[21:00:27.807] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:212:0)
[21:00:27.807] Timer tick, asking Buildbucket for the build status
[21:00:27.993] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:27.993] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:213:0) after 1m0s
[21:01:28.110] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:213:0)
[21:01:28.110] Timer tick, asking Buildbucket for the build status
[21:01:28.184] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:28.184] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:214:0) after 1m0s
[21:02:28.210] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:214:0)
[21:02:28.210] Timer tick, asking Buildbucket for the build status
[21:02:28.364] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:28.364] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:215:0) after 1m0s
[21:03:28.452] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:215:0)
[21:03:28.452] Timer tick, asking Buildbucket for the build status
[21:03:28.592] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:28.593] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:216:0) after 1m0s
[21:04:28.619] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:216:0)
[21:04:28.619] Timer tick, asking Buildbucket for the build status
[21:04:28.678] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:28.678] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:217:0) after 1m0s
[21:05:28.816] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:217:0)
[21:05:28.816] Timer tick, asking Buildbucket for the build status
[21:05:29.052] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:29.052] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:218:0) after 1m0s
[21:06:29.096] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:218:0)
[21:06:29.096] Timer tick, asking Buildbucket for the build status
[21:06:29.157] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:29.158] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:219:0) after 1m0s
[21:07:29.187] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:219:0)
[21:07:29.187] Timer tick, asking Buildbucket for the build status
[21:07:29.265] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:29.265] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:220:0) after 1m0s
[21:08:29.294] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:220:0)
[21:08:29.294] Timer tick, asking Buildbucket for the build status
[21:08:29.437] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:29.437] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:221:0) after 1m0s
[21:09:29.497] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:221:0)
[21:09:29.497] Timer tick, asking Buildbucket for the build status
[21:09:29.634] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:29.634] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:222:0) after 1m0s
[21:10:29.663] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:222:0)
[21:10:29.663] Timer tick, asking Buildbucket for the build status
[21:10:29.770] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:29.770] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:223:0) after 1m0s
[21:11:29.788] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:223:0)
[21:11:29.788] Timer tick, asking Buildbucket for the build status
[21:11:29.878] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:29.878] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:224:0) after 1m0s
[21:12:30.109] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:224:0)
[21:12:30.109] Timer tick, asking Buildbucket for the build status
[21:12:30.218] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:30.218] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:225:0) after 1m0s
[21:13:30.305] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:225:0)
[21:13:30.305] Timer tick, asking Buildbucket for the build status
[21:13:30.417] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:30.417] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:226:0) after 1m0s
[21:14:30.598] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:226:0)
[21:14:30.598] Timer tick, asking Buildbucket for the build status
[21:14:30.763] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:30.763] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:227:0) after 1m0s
[21:15:31.044] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:227:0)
[21:15:31.044] Timer tick, asking Buildbucket for the build status
[21:15:31.162] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:31.162] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:228:0) after 1m0s
[21:16:31.185] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:228:0)
[21:16:31.185] Timer tick, asking Buildbucket for the build status
[21:16:31.252] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:31.252] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:229:0) after 1m0s
[21:17:31.412] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:229:0)
[21:17:31.412] Timer tick, asking Buildbucket for the build status
[21:17:31.486] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:31.486] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:230:0) after 1m0s
[21:18:31.642] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:230:0)
[21:18:31.642] Timer tick, asking Buildbucket for the build status
[21:18:31.701] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:31.701] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:231:0) after 1m0s
[21:19:31.832] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:231:0)
[21:19:31.832] Timer tick, asking Buildbucket for the build status
[21:19:31.885] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:31.885] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:232:0) after 1m0s
[21:20:31.991] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:232:0)
[21:20:31.991] Timer tick, asking Buildbucket for the build status
[21:20:32.078] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:32.078] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:233:0) after 1m0s
[21:21:32.178] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:233:0)
[21:21:32.178] Timer tick, asking Buildbucket for the build status
[21:21:32.506] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:32.506] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:234:0) after 1m0s
[21:22:32.605] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:234:0)
[21:22:32.605] Timer tick, asking Buildbucket for the build status
[21:22:32.666] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:32.666] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:235:0) after 1m0s
[21:23:32.733] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:235:0)
[21:23:32.733] Timer tick, asking Buildbucket for the build status
[21:23:32.898] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:32.898] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:236:0) after 1m0s
[21:24:32.981] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:236:0)
[21:24:32.981] Timer tick, asking Buildbucket for the build status
[21:24:33.079] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:33.079] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:237:0) after 1m0s
[21:25:33.182] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:237:0)
[21:25:33.182] Timer tick, asking Buildbucket for the build status
[21:25:33.374] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:33.374] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:238:0) after 1m0s
[21:26:33.417] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:238:0)
[21:26:33.417] Timer tick, asking Buildbucket for the build status
[21:26:33.708] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:33.708] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:239:0) after 1m0s
[21:27:33.771] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:239:0)
[21:27:33.771] Timer tick, asking Buildbucket for the build status
[21:27:33.981] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:33.981] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:240:0) after 1m0s
[21:28:34.057] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:240:0)
[21:28:34.057] Timer tick, asking Buildbucket for the build status
[21:28:34.107] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:34.107] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:241:0) after 1m0s
[21:29:34.142] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:241:0)
[21:29:34.142] Timer tick, asking Buildbucket for the build status
[21:29:34.209] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:34.209] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:242:0) after 1m0s
[21:30:34.281] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:242:0)
[21:30:34.281] Timer tick, asking Buildbucket for the build status
[21:30:34.637] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:34.637] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:243:0) after 1m0s
[21:31:34.760] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:243:0)
[21:31:34.760] Timer tick, asking Buildbucket for the build status
[21:31:35.054] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:35.054] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:244:0) after 1m0s
[21:32:35.130] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:244:0)
[21:32:35.130] Timer tick, asking Buildbucket for the build status
[21:32:36.183] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:36.183] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:245:0) after 1m0s
[21:33:36.209] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:245:0)
[21:33:36.209] Timer tick, asking Buildbucket for the build status
[21:33:36.285] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:36.286] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:246:0) after 1m0s
[21:34:36.320] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:246:0)
[21:34:36.320] Timer tick, asking Buildbucket for the build status
[21:34:36.424] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:36.424] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:247:0) after 1m0s
[21:35:36.507] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:247:0)
[21:35:36.507] Timer tick, asking Buildbucket for the build status
[21:35:36.907] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:36.907] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:248:0) after 1m0s
[21:36:36.996] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:248:0)
[21:36:36.996] Timer tick, asking Buildbucket for the build status
[21:36:37.104] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:37.104] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:249:0) after 1m0s
[21:37:37.206] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:249:0)
[21:37:37.206] Timer tick, asking Buildbucket for the build status
[21:37:40.940] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:40.940] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:250:0) after 1m0s
[21:38:41.025] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:250:0)
[21:38:41.025] Timer tick, asking Buildbucket for the build status
[21:38:41.131] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:41.131] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:251:0) after 1m0s
[21:39:41.275] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:251:0)
[21:39:41.275] Timer tick, asking Buildbucket for the build status
[21:39:41.538] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:41.538] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:252:0) after 1m0s
[21:40:41.548] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:252:0)
[21:40:41.548] Timer tick, asking Buildbucket for the build status
[21:40:41.686] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:41.686] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:253:0) after 1m0s
[21:41:41.693] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:253:0)
[21:41:41.693] Timer tick, asking Buildbucket for the build status
[21:41:41.792] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:41.792] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:254:0) after 1m0s
[21:42:41.883] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:254:0)
[21:42:41.883] Timer tick, asking Buildbucket for the build status
[21:42:42.033] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:42.033] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:255:0) after 1m0s
[21:43:42.136] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:255:0)
[21:43:42.136] Timer tick, asking Buildbucket for the build status
[21:43:43.618] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:43.618] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:256:0) after 1m0s
[21:44:43.763] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:256:0)
[21:44:43.763] Timer tick, asking Buildbucket for the build status
[21:44:44.572] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:44.572] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:257:0) after 1m0s
[21:45:44.684] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:257:0)
[21:45:44.684] Timer tick, asking Buildbucket for the build status
[21:45:44.793] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:44.793] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:258:0) after 1m0s
[21:46:44.832] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:258:0)
[21:46:44.832] Timer tick, asking Buildbucket for the build status
[21:46:45.533] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:45.533] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:259:0) after 1m0s
[21:47:45.712] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:259:0)
[21:47:45.712] Timer tick, asking Buildbucket for the build status
[21:47:45.913] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:45.913] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:260:0) after 1m0s
[21:48:45.941] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:260:0)
[21:48:45.941] Timer tick, asking Buildbucket for the build status
[21:48:46.017] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:46.017] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:261:0) after 1m0s
[21:49:46.092] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:261:0)
[21:49:46.092] Timer tick, asking Buildbucket for the build status
[21:49:46.157] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:46.157] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:262:0) after 1m0s
[21:50:46.309] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:262:0)
[21:50:46.309] Timer tick, asking Buildbucket for the build status
[21:50:46.417] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:46.417] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:263:0) after 1m0s
[21:51:46.553] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:263:0)
[21:51:46.553] Timer tick, asking Buildbucket for the build status
[21:51:46.738] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:46.738] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:264:0) after 1m0s
[21:52:46.855] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:264:0)
[21:52:46.855] Timer tick, asking Buildbucket for the build status
[21:52:46.941] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:46.941] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:265:0) after 1m0s
[21:53:47.021] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:265:0)
[21:53:47.021] Timer tick, asking Buildbucket for the build status
[21:53:47.731] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:47.731] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:266:0) after 1m0s
[21:54:47.815] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:266:0)
[21:54:47.815] Timer tick, asking Buildbucket for the build status
[21:54:47.867] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:47.867] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:267:0) after 1m0s
[21:55:48.043] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:267:0)
[21:55:48.043] Timer tick, asking Buildbucket for the build status
[21:55:48.139] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:48.139] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:268:0) after 1m0s
[21:56:48.231] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:268:0)
[21:56:48.231] Timer tick, asking Buildbucket for the build status
[21:56:48.449] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:48.449] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:269:0) after 1m0s
[21:57:48.565] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:269:0)
[21:57:48.565] Timer tick, asking Buildbucket for the build status
[21:57:48.655] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:48.655] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:270:0) after 1m0s
[21:58:48.684] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:270:0)
[21:58:48.684] Timer tick, asking Buildbucket for the build status
[21:58:48.827] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:48.827] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:271:0) after 1m0s
[21:59:48.862] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:271:0)
[21:59:48.862] Timer tick, asking Buildbucket for the build status
[21:59:48.937] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:48.937] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:272:0) after 1m0s
[22:00:48.963] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:272:0)
[22:00:48.963] Timer tick, asking Buildbucket for the build status
[22:00:49.299] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:49.299] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:273:0) after 1m0s
[22:01:49.397] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:273:0)
[22:01:49.397] Timer tick, asking Buildbucket for the build status
[22:01:49.492] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:49.492] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:274:0) after 1m0s
[22:02:49.529] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:274:0)
[22:02:49.529] Timer tick, asking Buildbucket for the build status
[22:02:49.647] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:49.647] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:275:0) after 1m0s
[22:03:49.719] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:275:0)
[22:03:49.719] Timer tick, asking Buildbucket for the build status
[22:03:49.934] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:49.934] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:276:0) after 1m0s
[22:04:50.008] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:276:0)
[22:04:50.008] Timer tick, asking Buildbucket for the build status
[22:04:50.071] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:50.071] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:277:0) after 1m0s
[22:05:50.133] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:277:0)
[22:05:50.133] Timer tick, asking Buildbucket for the build status
[22:05:50.226] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:50.226] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:278:0) after 1m0s
[22:06:50.296] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:278:0)
[22:06:50.296] Timer tick, asking Buildbucket for the build status
[22:06:50.667] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:50.667] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:279:0) after 1m0s
[22:07:50.703] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:279:0)
[22:07:50.703] Timer tick, asking Buildbucket for the build status
[22:07:50.930] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:50.930] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:280:0) after 1m0s
[22:08:50.951] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:280:0)
[22:08:50.951] Timer tick, asking Buildbucket for the build status
[22:08:51.059] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:51.059] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:281:0) after 1m0s
[22:09:51.165] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:281:0)
[22:09:51.165] Timer tick, asking Buildbucket for the build status
[22:09:51.231] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:51.231] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:282:0) after 1m0s
[22:10:51.393] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:282:0)
[22:10:51.393] Timer tick, asking Buildbucket for the build status
[22:10:51.577] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:51.577] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:283:0) after 1m0s
[22:11:51.701] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:283:0)
[22:11:51.701] Timer tick, asking Buildbucket for the build status
[22:11:51.773] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:51.773] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:284:0) after 1m0s
[22:12:51.830] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:284:0)
[22:12:51.830] Timer tick, asking Buildbucket for the build status
[22:12:51.931] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:51.931] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:285:0) after 1m0s
[22:13:52.005] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:285:0)
[22:13:52.005] Timer tick, asking Buildbucket for the build status
[22:13:52.148] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:52.148] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:286:0) after 1m0s
[22:14:52.206] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:286:0)
[22:14:52.206] Timer tick, asking Buildbucket for the build status
[22:14:52.265] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:52.265] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:287:0) after 1m0s
[22:15:52.257] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:287:0)
[22:15:52.257] Timer tick, asking Buildbucket for the build status
[22:15:52.598] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:52.598] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:288:0) after 1m0s
[22:16:52.725] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:288:0)
[22:16:52.725] Timer tick, asking Buildbucket for the build status
[22:16:52.823] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:52.823] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:289:0) after 1m0s
[22:17:52.840] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:289:0)
[22:17:52.840] Timer tick, asking Buildbucket for the build status
[22:17:52.960] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:52.960] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:290:0) after 1m0s
[22:18:53.034] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:290:0)
[22:18:53.034] Timer tick, asking Buildbucket for the build status
[22:18:53.118] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:53.118] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:291:0) after 1m0s
[22:19:53.133] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:291:0)
[22:19:53.133] Timer tick, asking Buildbucket for the build status
[22:19:53.332] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:53.332] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:292:0) after 1m0s
[22:20:53.365] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:292:0)
[22:20:53.365] Timer tick, asking Buildbucket for the build status
[22:20:53.476] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:53.476] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:293:0) after 1m0s
[22:21:53.494] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:293:0)
[22:21:53.494] Timer tick, asking Buildbucket for the build status
[22:21:53.555] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:53.555] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:294:0) after 1m0s
[22:22:53.815] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:294:0)
[22:22:53.815] Timer tick, asking Buildbucket for the build status
[22:22:53.881] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:53.881] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:295:0) after 1m0s
[22:23:54.006] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:295:0)
[22:23:54.006] Timer tick, asking Buildbucket for the build status
[22:23:54.644] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:54.644] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:296:0) after 1m0s
[22:24:54.722] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:296:0)
[22:24:54.722] Timer tick, asking Buildbucket for the build status
[22:24:55.012] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:55.012] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:297:0) after 1m0s
[22:25:55.103] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:297:0)
[22:25:55.103] Timer tick, asking Buildbucket for the build status
[22:25:55.198] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:55.198] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:298:0) after 1m0s
[22:26:55.374] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:298:0)
[22:26:55.374] Timer tick, asking Buildbucket for the build status
[22:26:55.452] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:55.452] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:299:0) after 1m0s
[22:27:55.529] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:299:0)
[22:27:55.529] Timer tick, asking Buildbucket for the build status
[22:27:55.632] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:55.632] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:300:0) after 1m0s
[22:28:55.691] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:300:0)
[22:28:55.691] Timer tick, asking Buildbucket for the build status
[22:28:55.757] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:55.757] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:301:0) after 1m0s
[22:29:55.917] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:301:0)
[22:29:55.917] Timer tick, asking Buildbucket for the build status
[22:29:55.975] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:55.975] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:302:0) after 1m0s
[22:30:56.202] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:302:0)
[22:30:56.202] Timer tick, asking Buildbucket for the build status
[22:30:56.377] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:56.377] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:303:0) after 1m0s
[22:31:56.570] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:303:0)
[22:31:56.570] Timer tick, asking Buildbucket for the build status
[22:31:56.638] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:56.638] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:304:0) after 1m0s
[22:32:56.755] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:304:0)
[22:32:56.755] Timer tick, asking Buildbucket for the build status
[22:32:56.862] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:56.863] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:305:0) after 1m0s
[22:33:56.912] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:305:0)
[22:33:56.912] Timer tick, asking Buildbucket for the build status
[22:33:56.978] Build 8855572940174864496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:56.978] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021003002674198656:306:0) after 1m0s
[22:34:42.716] Received PubSub notification, asking Buildbucket for the build status
[22:34:42.923] Build 8855572940174864496: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:34:42.923] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613082881832487",
"created_by": "project:chromium",
"created_ts": "1613064552101626",
"id": "8855572940174864496",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e5f7e2bcc716f0829a6330bd2e9ba97a69b264b3\"}}",
"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\": \"e5f7e2bcc716f0829a6330bd2e9ba97a69b264b3\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"win-dbg-6-bshi\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 1583, \"got_angle_revision\": \"a8a2a71b3ab5e535def6239997f6f24da918556b\", \"got_dawn_revision\": \"e9f42997b213f1b287aa31698e22b2bca6976853\", \"got_nacl_revision\": \"82ac8c0a6f0d3ffc843c693dd5149a356b866ae5\", \"got_revision\": \"e5f7e2bcc716f0829a6330bd2e9ba97a69b264b3\", \"got_revision_cp\": \"refs/heads/master@{#853166}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"673a7fe5c3ff6686c98951cafb24a93ca5bd1303\", \"got_v8_revision\": \"02d4d4b3a2d530260c6172e3af40729555ce5db7\", \"got_v8_revision_cp\": \"refs/heads/9.0.164@{#1}\", \"got_webrtc_revision\": \"f28d7e89b7a3c985d83f59d16b9f3c3f45ef7997\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33224}\", \"mirrored_builders\": [\"tryserver.chromium:win-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e5f7e2bcc716f0829a6330bd2e9ba97a69b264b3\"}, \"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-6-bshi\"], \"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\": [\"5685-1877293\"], \"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": "1613064668261730",
"status": "COMPLETED",
"status_changed_ts": "1613082882251560",
"tags": [
"build_address:luci.chromium.ci/win-official/1583",
"builder:win-official",
"buildset:commit/git/e5f7e2bcc716f0829a6330bd2e9ba97a69b264b3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e5f7e2bcc716f0829a6330bd2e9ba97a69b264b3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021003002674198656",
"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/8855572940174864496/+/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:51aaf54f8dd0fa10",
"user_agent:luci-scheduler"
],
"updated_ts": "1613082882270908",
"url": "https://ci.chromium.org/b/8855572940174864496",
"utcnow_ts": "1613082882903870"
}
}
[22:34:42.923] Invocation finished in 5h5m32.5902547s with status SUCCEEDED