[13:44:40.690] New invocation is queued and will start shortly
[13:44:41.729] Starting the invocation (attempt 1)
[13:44:41.761] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:44:41.761] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:44:41.761] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018118023708883232",
"parameters_json": "{\"builder_name\":\"win32-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"255eb32c897b28c692b3da72617c993338633b91\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win32-official",
"scheduler_invocation_id:9018118023708883232",
"scheduler_job_id:chromium/win32-official",
"user_agent:luci-scheduler",
"buildset:commit/git/255eb32c897b28c692b3da72617c993338633b91",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/255eb32c897b28c692b3da72617c993338633b91",
"gitiles_ref:refs/heads/master"
]
}
[13:44:43.085] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615815881995128",
"id": "8852687961679850752",
"parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"255eb32c897b28c692b3da72617c993338633b91\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615815882929532",
"tags": [
"build_address:luci.chromium.ci/win32-official/1699",
"builder:win32-official",
"buildset:commit/git/255eb32c897b28c692b3da72617c993338633b91",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/255eb32c897b28c692b3da72617c993338633b91",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018118023708883232",
"scheduler_job_id:chromium/win32-official",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8852687961679850752/+/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": "1615815882929689",
"url": "https://ci.chromium.org/b/8852687961679850752",
"utcnow_ts": "1615815883075392"
}
}
[13:44:43.085] Task URL: https://ci.chromium.org/b/8852687961679850752
[13:44:43.085] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:2:0) after 1m0s
[13:44:50.748] Received PubSub notification, asking Buildbucket for the build status
[13:44:50.801] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:43.126] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:2:0)
[13:45:43.126] Timer tick, asking Buildbucket for the build status
[13:45:43.273] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:43.273] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:4:0) after 1m0s
[13:46:43.424] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:4:0)
[13:46:43.424] Timer tick, asking Buildbucket for the build status
[13:46:43.576] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:43.576] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:5:0) after 1m0s
[13:47:43.599] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:5:0)
[13:47:43.599] Timer tick, asking Buildbucket for the build status
[13:47:43.659] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:43.659] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:6:0) after 1m0s
[13:48:43.717] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:6:0)
[13:48:43.717] Timer tick, asking Buildbucket for the build status
[13:48:43.974] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:43.974] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:7:0) after 1m0s
[13:49:44.096] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:7:0)
[13:49:44.096] Timer tick, asking Buildbucket for the build status
[13:49:44.304] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:44.304] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:8:0) after 1m0s
[13:50:44.928] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:8:0)
[13:50:44.928] Timer tick, asking Buildbucket for the build status
[13:50:45.115] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:45.116] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:9:0) after 1m0s
[13:51:45.209] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:9:0)
[13:51:45.209] Timer tick, asking Buildbucket for the build status
[13:51:45.308] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:45.308] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:10:0) after 1m0s
[13:52:45.352] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:10:0)
[13:52:45.352] Timer tick, asking Buildbucket for the build status
[13:52:45.468] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:45.468] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:11:0) after 1m0s
[13:53:45.508] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:11:0)
[13:53:45.508] Timer tick, asking Buildbucket for the build status
[13:53:45.668] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:45.671] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:12:0) after 1m0s
[13:54:45.691] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:12:0)
[13:54:45.691] Timer tick, asking Buildbucket for the build status
[13:54:46.370] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:46.370] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:13:0) after 1m0s
[13:55:46.441] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:13:0)
[13:55:46.441] Timer tick, asking Buildbucket for the build status
[13:55:46.730] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:46.730] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:14:0) after 1m0s
[13:56:46.784] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:14:0)
[13:56:46.784] Timer tick, asking Buildbucket for the build status
[13:56:46.879] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:46.879] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:15:0) after 1m0s
[13:57:46.901] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:15:0)
[13:57:46.901] Timer tick, asking Buildbucket for the build status
[13:57:46.993] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:46.993] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:16:0) after 1m0s
[13:58:47.024] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:16:0)
[13:58:47.024] Timer tick, asking Buildbucket for the build status
[13:58:47.126] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:47.126] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:17:0) after 1m0s
[13:59:47.146] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:17:0)
[13:59:47.147] Timer tick, asking Buildbucket for the build status
[13:59:47.210] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:47.210] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:18:0) after 1m0s
[14:00:47.258] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:18:0)
[14:00:47.258] Timer tick, asking Buildbucket for the build status
[14:00:48.615] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:48.615] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:19:0) after 1m0s
[14:01:48.880] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:19:0)
[14:01:48.880] Timer tick, asking Buildbucket for the build status
[14:01:49.069] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:49.069] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:20:0) after 1m0s
[14:02:49.159] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:20:0)
[14:02:49.159] Timer tick, asking Buildbucket for the build status
[14:02:49.267] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:49.267] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:21:0) after 1m0s
[14:03:49.293] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:21:0)
[14:03:49.293] Timer tick, asking Buildbucket for the build status
[14:03:49.448] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:49.448] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:22:0) after 1m0s
[14:04:49.478] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:22:0)
[14:04:49.478] Timer tick, asking Buildbucket for the build status
[14:04:50.006] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:50.006] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:23:0) after 1m0s
[14:05:50.034] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:23:0)
[14:05:50.034] Timer tick, asking Buildbucket for the build status
[14:05:50.139] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:50.139] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:24:0) after 1m0s
[14:06:50.110] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:24:0)
[14:06:50.110] Timer tick, asking Buildbucket for the build status
[14:06:50.260] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:50.260] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:25:0) after 1m0s
[14:07:50.278] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:25:0)
[14:07:50.278] Timer tick, asking Buildbucket for the build status
[14:07:50.423] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:50.423] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:26:0) after 1m0s
[14:08:50.441] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:26:0)
[14:08:50.441] Timer tick, asking Buildbucket for the build status
[14:08:50.545] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:50.545] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:27:0) after 1m0s
[14:09:50.604] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:27:0)
[14:09:50.604] Timer tick, asking Buildbucket for the build status
[14:09:50.913] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:50.913] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:28:0) after 1m0s
[14:10:50.933] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:28:0)
[14:10:50.933] Timer tick, asking Buildbucket for the build status
[14:10:51.054] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:51.054] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:29:0) after 1m0s
[14:11:51.070] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:29:0)
[14:11:51.070] Timer tick, asking Buildbucket for the build status
[14:11:51.176] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:51.176] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:30:0) after 1m0s
[14:12:51.194] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:30:0)
[14:12:51.194] Timer tick, asking Buildbucket for the build status
[14:12:51.347] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:51.347] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:31:0) after 1m0s
[14:13:51.383] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:31:0)
[14:13:51.383] Timer tick, asking Buildbucket for the build status
[14:13:51.472] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:51.472] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:32:0) after 1m0s
[14:14:51.509] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:32:0)
[14:14:51.509] Timer tick, asking Buildbucket for the build status
[14:14:51.663] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:51.663] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:33:0) after 1m0s
[14:15:51.729] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:33:0)
[14:15:51.729] Timer tick, asking Buildbucket for the build status
[14:15:51.813] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:51.813] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:34:0) after 1m0s
[14:16:51.859] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:34:0)
[14:16:51.859] Timer tick, asking Buildbucket for the build status
[14:16:51.973] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:51.973] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:35:0) after 1m0s
[14:17:52.237] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:35:0)
[14:17:52.237] Timer tick, asking Buildbucket for the build status
[14:17:52.316] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:52.316] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:36:0) after 1m0s
[14:18:52.418] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:36:0)
[14:18:52.418] Timer tick, asking Buildbucket for the build status
[14:18:52.481] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:52.481] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:37:0) after 1m0s
[14:19:52.492] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:37:0)
[14:19:52.492] Timer tick, asking Buildbucket for the build status
[14:19:52.757] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:52.757] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:38:0) after 1m0s
[14:20:52.922] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:38:0)
[14:20:52.922] Timer tick, asking Buildbucket for the build status
[14:20:53.242] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:53.242] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:39:0) after 1m0s
[14:21:53.404] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:39:0)
[14:21:53.404] Timer tick, asking Buildbucket for the build status
[14:21:53.667] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:53.667] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:40:0) after 1m0s
[14:22:53.653] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:40:0)
[14:22:53.653] Timer tick, asking Buildbucket for the build status
[14:22:53.708] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:53.708] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:41:0) after 1m0s
[14:23:54.040] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:41:0)
[14:23:54.040] Timer tick, asking Buildbucket for the build status
[14:23:54.224] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:54.224] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:42:0) after 1m0s
[14:24:54.633] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:42:0)
[14:24:54.633] Timer tick, asking Buildbucket for the build status
[14:24:55.671] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:55.671] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:43:0) after 1m0s
[14:25:55.724] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:43:0)
[14:25:55.724] Timer tick, asking Buildbucket for the build status
[14:25:55.798] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:55.798] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:44:0) after 1m0s
[14:26:55.962] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:44:0)
[14:26:55.962] Timer tick, asking Buildbucket for the build status
[14:26:56.061] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:56.061] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:45:0) after 1m0s
[14:27:56.133] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:45:0)
[14:27:56.133] Timer tick, asking Buildbucket for the build status
[14:27:58.048] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:58.048] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:46:0) after 1m0s
[14:28:58.175] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:46:0)
[14:28:58.175] Timer tick, asking Buildbucket for the build status
[14:28:58.744] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:58.744] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:47:0) after 1m0s
[14:29:58.757] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:47:0)
[14:29:58.757] Timer tick, asking Buildbucket for the build status
[14:29:58.965] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:58.966] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:48:0) after 1m0s
[14:30:59.052] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:48:0)
[14:30:59.052] Timer tick, asking Buildbucket for the build status
[14:30:59.134] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:59.134] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:49:0) after 1m0s
[14:31:59.106] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:49:0)
[14:31:59.106] Timer tick, asking Buildbucket for the build status
[14:31:59.180] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:59.180] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:50:0) after 1m0s
[14:32:59.200] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:50:0)
[14:32:59.200] Timer tick, asking Buildbucket for the build status
[14:32:59.276] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:59.276] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:51:0) after 1m0s
[14:33:59.299] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:51:0)
[14:33:59.299] Timer tick, asking Buildbucket for the build status
[14:33:59.375] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:59.375] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:52:0) after 1m0s
[14:34:59.523] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:52:0)
[14:34:59.523] Timer tick, asking Buildbucket for the build status
[14:34:59.660] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:59.660] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:53:0) after 1m0s
[14:35:59.743] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:53:0)
[14:35:59.743] Timer tick, asking Buildbucket for the build status
[14:35:59.861] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:59.861] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:54:0) after 1m0s
[14:36:59.910] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:54:0)
[14:36:59.910] Timer tick, asking Buildbucket for the build status
[14:36:59.976] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:59.976] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:55:0) after 1m0s
[14:38:00.010] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:55:0)
[14:38:00.010] Timer tick, asking Buildbucket for the build status
[14:38:00.151] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:00.151] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:56:0) after 1m0s
[14:39:00.125] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:56:0)
[14:39:00.125] Timer tick, asking Buildbucket for the build status
[14:39:00.410] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:00.410] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:57:0) after 1m0s
[14:40:00.592] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:57:0)
[14:40:00.592] Timer tick, asking Buildbucket for the build status
[14:40:00.669] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:00.669] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:58:0) after 1m0s
[14:41:00.691] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:58:0)
[14:41:00.691] Timer tick, asking Buildbucket for the build status
[14:41:00.833] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:00.833] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:59:0) after 1m0s
[14:42:00.881] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:59:0)
[14:42:00.881] Timer tick, asking Buildbucket for the build status
[14:42:00.967] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:00.967] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:60:0) after 1m0s
[14:43:00.987] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:60:0)
[14:43:00.987] Timer tick, asking Buildbucket for the build status
[14:43:01.488] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:01.488] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:61:0) after 1m0s
[14:44:01.531] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:61:0)
[14:44:01.531] Timer tick, asking Buildbucket for the build status
[14:44:01.622] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:01.622] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:62:0) after 1m0s
[14:45:01.609] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:62:0)
[14:45:01.609] Timer tick, asking Buildbucket for the build status
[14:45:01.831] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:01.831] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:63:0) after 1m0s
[14:46:01.862] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:63:0)
[14:46:01.862] Timer tick, asking Buildbucket for the build status
[14:46:01.933] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:01.934] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:64:0) after 1m0s
[14:47:01.969] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:64:0)
[14:47:01.969] Timer tick, asking Buildbucket for the build status
[14:47:02.106] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:02.106] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:65:0) after 1m0s
[14:48:02.125] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:65:0)
[14:48:02.125] Timer tick, asking Buildbucket for the build status
[14:48:02.359] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:02.359] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:66:0) after 1m0s
[14:49:02.388] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:66:0)
[14:49:02.388] Timer tick, asking Buildbucket for the build status
[14:49:02.522] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:02.522] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:67:0) after 1m0s
[14:50:02.580] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:67:0)
[14:50:02.580] Timer tick, asking Buildbucket for the build status
[14:50:02.783] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:02.783] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:68:0) after 1m0s
[14:51:02.803] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:68:0)
[14:51:02.803] Timer tick, asking Buildbucket for the build status
[14:51:02.894] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:02.894] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:69:0) after 1m0s
[14:52:02.958] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:69:0)
[14:52:02.958] Timer tick, asking Buildbucket for the build status
[14:52:03.041] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:03.041] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:70:0) after 1m0s
[14:53:03.089] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:70:0)
[14:53:03.089] Timer tick, asking Buildbucket for the build status
[14:53:03.186] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:03.186] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:71:0) after 1m0s
[14:54:03.514] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:71:0)
[14:54:03.514] Timer tick, asking Buildbucket for the build status
[14:54:05.428] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:05.428] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:72:0) after 1m0s
[14:55:05.453] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:72:0)
[14:55:05.453] Timer tick, asking Buildbucket for the build status
[14:55:05.585] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:05.585] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:73:0) after 1m0s
[14:56:05.639] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:73:0)
[14:56:05.639] Timer tick, asking Buildbucket for the build status
[14:56:05.719] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:05.719] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:74:0) after 1m0s
[14:57:05.742] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:74:0)
[14:57:05.742] Timer tick, asking Buildbucket for the build status
[14:57:07.822] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:07.822] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:75:0) after 1m0s
[14:58:07.844] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:75:0)
[14:58:07.844] Timer tick, asking Buildbucket for the build status
[14:58:07.912] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:07.912] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:76:0) after 1m0s
[14:59:07.938] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:76:0)
[14:59:07.938] Timer tick, asking Buildbucket for the build status
[14:59:08.000] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:08.000] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:77:0) after 1m0s
[15:00:08.111] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:77:0)
[15:00:08.111] Timer tick, asking Buildbucket for the build status
[15:00:08.184] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:08.184] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:78:0) after 1m0s
[15:01:08.690] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:78:0)
[15:01:08.690] Timer tick, asking Buildbucket for the build status
[15:01:08.771] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:08.771] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:79:0) after 1m0s
[15:02:08.852] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:79:0)
[15:02:08.852] Timer tick, asking Buildbucket for the build status
[15:02:08.971] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:08.971] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:80:0) after 1m0s
[15:03:09.019] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:80:0)
[15:03:09.019] Timer tick, asking Buildbucket for the build status
[15:03:09.115] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:09.115] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:81:0) after 1m0s
[15:04:09.240] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:81:0)
[15:04:09.240] Timer tick, asking Buildbucket for the build status
[15:04:09.492] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:09.492] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:82:0) after 1m0s
[15:05:09.575] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:82:0)
[15:05:09.575] Timer tick, asking Buildbucket for the build status
[15:05:09.661] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:09.661] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:83:0) after 1m0s
[15:06:09.939] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:83:0)
[15:06:09.939] Timer tick, asking Buildbucket for the build status
[15:06:10.023] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:10.023] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:84:0) after 1m0s
[15:07:10.329] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:84:0)
[15:07:10.329] Timer tick, asking Buildbucket for the build status
[15:07:10.538] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:10.538] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:85:0) after 1m0s
[15:08:10.602] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:85:0)
[15:08:10.602] Timer tick, asking Buildbucket for the build status
[15:08:10.708] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:10.708] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:86:0) after 1m0s
[15:09:10.792] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:86:0)
[15:09:10.792] Timer tick, asking Buildbucket for the build status
[15:09:10.872] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:10.872] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:87:0) after 1m0s
[15:10:14.112] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:87:0)
[15:10:14.112] Timer tick, asking Buildbucket for the build status
[15:10:14.382] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:14.382] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:88:0) after 1m0s
[15:11:14.417] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:88:0)
[15:11:14.417] Timer tick, asking Buildbucket for the build status
[15:11:14.719] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:14.719] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:89:0) after 1m0s
[15:12:14.794] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:89:0)
[15:12:14.794] Timer tick, asking Buildbucket for the build status
[15:12:14.942] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:14.942] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:90:0) after 1m0s
[15:13:14.994] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:90:0)
[15:13:14.994] Timer tick, asking Buildbucket for the build status
[15:13:15.057] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:15.057] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:91:0) after 1m0s
[15:14:15.115] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:91:0)
[15:14:15.115] Timer tick, asking Buildbucket for the build status
[15:14:15.202] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:15.202] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:92:0) after 1m0s
[15:15:15.330] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:92:0)
[15:15:15.330] Timer tick, asking Buildbucket for the build status
[15:15:15.409] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:15.409] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:93:0) after 1m0s
[15:16:15.614] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:93:0)
[15:16:15.614] Timer tick, asking Buildbucket for the build status
[15:16:15.694] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:15.694] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:94:0) after 1m0s
[15:17:15.830] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:94:0)
[15:17:15.830] Timer tick, asking Buildbucket for the build status
[15:17:16.029] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:16.029] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:95:0) after 1m0s
[15:18:16.039] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:95:0)
[15:18:16.039] Timer tick, asking Buildbucket for the build status
[15:18:16.303] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:16.303] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:96:0) after 1m0s
[15:19:16.378] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:96:0)
[15:19:16.378] Timer tick, asking Buildbucket for the build status
[15:19:16.847] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:16.847] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:97:0) after 1m0s
[15:20:16.929] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:97:0)
[15:20:16.929] Timer tick, asking Buildbucket for the build status
[15:20:17.394] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:17.394] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:98:0) after 1m0s
[15:21:17.667] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:98:0)
[15:21:17.667] Timer tick, asking Buildbucket for the build status
[15:21:17.775] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:17.775] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:99:0) after 1m0s
[15:22:18.010] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:99:0)
[15:22:18.010] Timer tick, asking Buildbucket for the build status
[15:22:18.084] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:18.084] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:100:0) after 1m0s
[15:23:18.367] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:100:0)
[15:23:18.367] Timer tick, asking Buildbucket for the build status
[15:23:18.542] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:18.542] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:101:0) after 1m0s
[15:24:18.722] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:101:0)
[15:24:18.722] Timer tick, asking Buildbucket for the build status
[15:24:18.955] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:18.955] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:102:0) after 1m0s
[15:25:19.018] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:102:0)
[15:25:19.018] Timer tick, asking Buildbucket for the build status
[15:25:19.425] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:19.425] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:103:0) after 1m0s
[15:26:19.659] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:103:0)
[15:26:19.659] Timer tick, asking Buildbucket for the build status
[15:26:19.789] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:19.790] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:104:0) after 1m0s
[15:27:19.863] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:104:0)
[15:27:19.863] Timer tick, asking Buildbucket for the build status
[15:27:21.363] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:21.363] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:105:0) after 1m0s
[15:28:21.730] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:105:0)
[15:28:21.730] Timer tick, asking Buildbucket for the build status
[15:28:21.827] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:21.827] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:106:0) after 1m0s
[15:29:21.939] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:106:0)
[15:29:21.939] Timer tick, asking Buildbucket for the build status
[15:29:22.420] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:22.420] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:107:0) after 1m0s
[15:30:23.000] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:107:0)
[15:30:23.000] Timer tick, asking Buildbucket for the build status
[15:30:23.661] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:23.661] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:108:0) after 1m0s
[15:31:23.793] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:108:0)
[15:31:23.793] Timer tick, asking Buildbucket for the build status
[15:31:23.855] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:23.855] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:109:0) after 1m0s
[15:32:23.975] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:109:0)
[15:32:23.975] Timer tick, asking Buildbucket for the build status
[15:32:24.073] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:24.073] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:110:0) after 1m0s
[15:33:24.182] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:110:0)
[15:33:24.182] Timer tick, asking Buildbucket for the build status
[15:33:24.253] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:24.253] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:111:0) after 1m0s
[15:34:24.616] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:111:0)
[15:34:24.616] Timer tick, asking Buildbucket for the build status
[15:34:24.834] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:24.834] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:112:0) after 1m0s
[15:35:24.951] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:112:0)
[15:35:24.951] Timer tick, asking Buildbucket for the build status
[15:35:25.131] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:25.131] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:113:0) after 1m0s
[15:36:25.245] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:113:0)
[15:36:25.245] Timer tick, asking Buildbucket for the build status
[15:36:25.349] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:25.349] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:114:0) after 1m0s
[15:37:25.461] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:114:0)
[15:37:25.461] Timer tick, asking Buildbucket for the build status
[15:37:25.582] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:25.582] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:115:0) after 1m0s
[15:38:25.613] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:115:0)
[15:38:25.613] Timer tick, asking Buildbucket for the build status
[15:38:25.741] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:25.741] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:116:0) after 1m0s
[15:39:25.830] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:116:0)
[15:39:25.830] Timer tick, asking Buildbucket for the build status
[15:39:25.907] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:25.907] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:117:0) after 1m0s
[15:40:26.020] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:117:0)
[15:40:26.020] Timer tick, asking Buildbucket for the build status
[15:40:26.137] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:26.137] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:118:0) after 1m0s
[15:41:26.169] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:118:0)
[15:41:26.169] Timer tick, asking Buildbucket for the build status
[15:41:26.256] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:26.257] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:119:0) after 1m0s
[15:42:26.260] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:119:0)
[15:42:26.260] Timer tick, asking Buildbucket for the build status
[15:42:26.357] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:26.357] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:120:0) after 1m0s
[15:43:26.442] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:120:0)
[15:43:26.442] Timer tick, asking Buildbucket for the build status
[15:43:26.543] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:26.543] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:121:0) after 1m0s
[15:44:26.579] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:121:0)
[15:44:26.579] Timer tick, asking Buildbucket for the build status
[15:44:26.646] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:26.646] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:122:0) after 1m0s
[15:45:26.651] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:122:0)
[15:45:26.651] Timer tick, asking Buildbucket for the build status
[15:45:26.773] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:26.773] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:123:0) after 1m0s
[15:46:26.809] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:123:0)
[15:46:26.809] Timer tick, asking Buildbucket for the build status
[15:46:26.894] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:26.894] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:124:0) after 1m0s
[15:47:26.979] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:124:0)
[15:47:26.979] Timer tick, asking Buildbucket for the build status
[15:47:27.050] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:27.051] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:125:0) after 1m0s
[15:48:27.192] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:125:0)
[15:48:27.192] Timer tick, asking Buildbucket for the build status
[15:48:27.329] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:27.329] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:126:0) after 1m0s
[15:49:27.396] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:126:0)
[15:49:27.396] Timer tick, asking Buildbucket for the build status
[15:49:28.161] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:28.161] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:127:0) after 1m0s
[15:50:28.181] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:127:0)
[15:50:28.181] Timer tick, asking Buildbucket for the build status
[15:50:28.460] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:28.460] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:128:0) after 1m0s
[15:51:28.469] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:128:0)
[15:51:28.469] Timer tick, asking Buildbucket for the build status
[15:51:28.564] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:28.564] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:129:0) after 1m0s
[15:52:28.640] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:129:0)
[15:52:28.640] Timer tick, asking Buildbucket for the build status
[15:52:28.755] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:28.755] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:130:0) after 1m0s
[15:53:28.782] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:130:0)
[15:53:28.782] Timer tick, asking Buildbucket for the build status
[15:53:28.850] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:28.850] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:131:0) after 1m0s
[15:54:28.850] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:131:0)
[15:54:28.850] Timer tick, asking Buildbucket for the build status
[15:54:28.913] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:28.913] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:132:0) after 1m0s
[15:55:28.952] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:132:0)
[15:55:28.953] Timer tick, asking Buildbucket for the build status
[15:55:29.063] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:29.063] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:133:0) after 1m0s
[15:56:29.157] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:133:0)
[15:56:29.157] Timer tick, asking Buildbucket for the build status
[15:56:29.256] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:29.256] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:134:0) after 1m0s
[15:57:29.242] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:134:0)
[15:57:29.242] Timer tick, asking Buildbucket for the build status
[15:57:29.345] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:29.345] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:135:0) after 1m0s
[15:58:29.391] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:135:0)
[15:58:29.391] Timer tick, asking Buildbucket for the build status
[15:58:29.467] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:29.467] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:136:0) after 1m0s
[15:59:29.485] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:136:0)
[15:59:29.485] Timer tick, asking Buildbucket for the build status
[15:59:29.562] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:29.562] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:137:0) after 1m0s
[16:00:29.629] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:137:0)
[16:00:29.629] Timer tick, asking Buildbucket for the build status
[16:00:29.774] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:29.774] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:138:0) after 1m0s
[16:01:29.779] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:138:0)
[16:01:29.779] Timer tick, asking Buildbucket for the build status
[16:01:29.861] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:29.861] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:139:0) after 1m0s
[16:02:29.957] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:139:0)
[16:02:29.957] Timer tick, asking Buildbucket for the build status
[16:02:30.093] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:30.093] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:140:0) after 1m0s
[16:03:30.139] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:140:0)
[16:03:30.139] Timer tick, asking Buildbucket for the build status
[16:03:30.300] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:30.300] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:141:0) after 1m0s
[16:04:30.476] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:141:0)
[16:04:30.476] Timer tick, asking Buildbucket for the build status
[16:04:30.575] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:30.575] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:142:0) after 1m0s
[16:05:30.555] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:142:0)
[16:05:30.555] Timer tick, asking Buildbucket for the build status
[16:05:30.666] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:30.666] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:143:0) after 1m0s
[16:06:30.695] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:143:0)
[16:06:30.695] Timer tick, asking Buildbucket for the build status
[16:06:30.845] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:30.845] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:144:0) after 1m0s
[16:07:30.876] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:144:0)
[16:07:30.876] Timer tick, asking Buildbucket for the build status
[16:07:30.971] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:30.971] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:145:0) after 1m0s
[16:08:30.989] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:145:0)
[16:08:30.989] Timer tick, asking Buildbucket for the build status
[16:08:31.133] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:31.133] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:146:0) after 1m0s
[16:09:31.120] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:146:0)
[16:09:31.120] Timer tick, asking Buildbucket for the build status
[16:09:31.199] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:31.199] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:147:0) after 1m0s
[16:10:31.586] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:147:0)
[16:10:31.586] Timer tick, asking Buildbucket for the build status
[16:10:31.965] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:31.965] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:148:0) after 1m0s
[16:11:32.052] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:148:0)
[16:11:32.052] Timer tick, asking Buildbucket for the build status
[16:11:32.268] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:32.268] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:149:0) after 1m0s
[16:12:32.336] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:149:0)
[16:12:32.336] Timer tick, asking Buildbucket for the build status
[16:12:32.416] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:32.416] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:150:0) after 1m0s
[16:13:32.437] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:150:0)
[16:13:32.437] Timer tick, asking Buildbucket for the build status
[16:13:32.679] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:32.679] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:151:0) after 1m0s
[16:14:32.732] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:151:0)
[16:14:32.732] Timer tick, asking Buildbucket for the build status
[16:14:32.867] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:32.867] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:152:0) after 1m0s
[16:15:32.860] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:152:0)
[16:15:32.860] Timer tick, asking Buildbucket for the build status
[16:15:32.960] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:32.960] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:153:0) after 1m0s
[16:16:33.476] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:153:0)
[16:16:33.476] Timer tick, asking Buildbucket for the build status
[16:16:33.543] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:33.543] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:154:0) after 1m0s
[16:17:33.610] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:154:0)
[16:17:33.610] Timer tick, asking Buildbucket for the build status
[16:17:33.866] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:33.866] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:155:0) after 1m0s
[16:18:34.090] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:155:0)
[16:18:34.090] Timer tick, asking Buildbucket for the build status
[16:18:34.229] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:34.229] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:156:0) after 1m0s
[16:19:35.427] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:156:0)
[16:19:35.427] Timer tick, asking Buildbucket for the build status
[16:19:35.887] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:35.887] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:157:0) after 1m0s
[16:20:36.717] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:157:0)
[16:20:36.717] Timer tick, asking Buildbucket for the build status
[16:20:36.826] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:36.826] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:158:0) after 1m0s
[16:21:37.088] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:158:0)
[16:21:37.088] Timer tick, asking Buildbucket for the build status
[16:21:37.865] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:37.865] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:159:0) after 1m0s
[16:22:37.987] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:159:0)
[16:22:37.987] Timer tick, asking Buildbucket for the build status
[16:22:38.194] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:38.194] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:160:0) after 1m0s
[16:23:38.275] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:160:0)
[16:23:38.275] Timer tick, asking Buildbucket for the build status
[16:23:38.434] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:38.434] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:161:0) after 1m0s
[16:24:38.441] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:161:0)
[16:24:38.441] Timer tick, asking Buildbucket for the build status
[16:24:38.531] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:38.531] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:162:0) after 1m0s
[16:25:38.569] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:162:0)
[16:25:38.569] Timer tick, asking Buildbucket for the build status
[16:25:38.684] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:38.684] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:163:0) after 1m0s
[16:26:39.280] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:163:0)
[16:26:39.280] Timer tick, asking Buildbucket for the build status
[16:26:39.368] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:39.368] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:164:0) after 1m0s
[16:27:39.396] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:164:0)
[16:27:39.396] Timer tick, asking Buildbucket for the build status
[16:27:39.839] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:39.839] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:165:0) after 1m0s
[16:28:39.905] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:165:0)
[16:28:39.905] Timer tick, asking Buildbucket for the build status
[16:28:40.479] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:40.479] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:166:0) after 1m0s
[16:29:40.499] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:166:0)
[16:29:40.499] Timer tick, asking Buildbucket for the build status
[16:29:40.670] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:40.670] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:167:0) after 1m0s
[16:30:40.712] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:167:0)
[16:30:40.712] Timer tick, asking Buildbucket for the build status
[16:30:40.885] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:40.885] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:168:0) after 1m0s
[16:31:40.944] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:168:0)
[16:31:40.944] Timer tick, asking Buildbucket for the build status
[16:31:41.220] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:41.220] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:169:0) after 1m0s
[16:32:41.311] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:169:0)
[16:32:41.311] Timer tick, asking Buildbucket for the build status
[16:32:41.434] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:41.434] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:170:0) after 1m0s
[16:33:41.510] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:170:0)
[16:33:41.510] Timer tick, asking Buildbucket for the build status
[16:33:41.588] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:41.588] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:171:0) after 1m0s
[16:34:41.580] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:171:0)
[16:34:41.580] Timer tick, asking Buildbucket for the build status
[16:34:41.842] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:41.842] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:172:0) after 1m0s
[16:35:41.849] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:172:0)
[16:35:41.849] Timer tick, asking Buildbucket for the build status
[16:35:41.960] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:41.960] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:173:0) after 1m0s
[16:36:42.001] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:173:0)
[16:36:42.001] Timer tick, asking Buildbucket for the build status
[16:36:42.083] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:42.083] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:174:0) after 1m0s
[16:37:42.130] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:174:0)
[16:37:42.130] Timer tick, asking Buildbucket for the build status
[16:37:42.394] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:42.394] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:175:0) after 1m0s
[16:38:42.434] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:175:0)
[16:38:42.434] Timer tick, asking Buildbucket for the build status
[16:38:42.513] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:42.513] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:176:0) after 1m0s
[16:39:42.572] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:176:0)
[16:39:42.572] Timer tick, asking Buildbucket for the build status
[16:39:42.660] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:42.660] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:177:0) after 1m0s
[16:40:42.816] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:177:0)
[16:40:42.816] Timer tick, asking Buildbucket for the build status
[16:40:43.088] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:43.088] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:178:0) after 1m0s
[16:41:43.102] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:178:0)
[16:41:43.102] Timer tick, asking Buildbucket for the build status
[16:41:43.347] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:43.347] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:179:0) after 1m0s
[16:42:43.338] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:179:0)
[16:42:43.338] Timer tick, asking Buildbucket for the build status
[16:42:43.446] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:43.446] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:180:0) after 1m0s
[16:43:43.615] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:180:0)
[16:43:43.615] Timer tick, asking Buildbucket for the build status
[16:43:43.971] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:43.971] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:181:0) after 1m0s
[16:44:44.047] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:181:0)
[16:44:44.047] Timer tick, asking Buildbucket for the build status
[16:44:44.164] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:44.164] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:182:0) after 1m0s
[16:45:44.189] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:182:0)
[16:45:44.189] Timer tick, asking Buildbucket for the build status
[16:45:44.290] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:44.290] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:183:0) after 1m0s
[16:46:44.293] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:183:0)
[16:46:44.293] Timer tick, asking Buildbucket for the build status
[16:46:44.391] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:44.391] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:184:0) after 1m0s
[16:47:44.436] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:184:0)
[16:47:44.436] Timer tick, asking Buildbucket for the build status
[16:47:44.647] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:44.647] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:185:0) after 1m0s
[16:48:44.676] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:185:0)
[16:48:44.676] Timer tick, asking Buildbucket for the build status
[16:48:46.310] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:46.310] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:186:0) after 1m0s
[16:49:46.338] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:186:0)
[16:49:46.338] Timer tick, asking Buildbucket for the build status
[16:49:46.446] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:46.446] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:187:0) after 1m0s
[16:50:46.469] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:187:0)
[16:50:46.469] Timer tick, asking Buildbucket for the build status
[16:50:46.864] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:46.864] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:188:0) after 1m0s
[16:51:46.885] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:188:0)
[16:51:46.885] Timer tick, asking Buildbucket for the build status
[16:51:47.126] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:47.126] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:189:0) after 1m0s
[16:52:47.156] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:189:0)
[16:52:47.156] Timer tick, asking Buildbucket for the build status
[16:52:47.255] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:47.255] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:190:0) after 1m0s
[16:53:47.284] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:190:0)
[16:53:47.284] Timer tick, asking Buildbucket for the build status
[16:53:47.387] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:47.387] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:191:0) after 1m0s
[16:54:47.731] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:191:0)
[16:54:47.731] Timer tick, asking Buildbucket for the build status
[16:54:47.840] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:47.840] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:192:0) after 1m0s
[16:55:47.955] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:192:0)
[16:55:47.955] Timer tick, asking Buildbucket for the build status
[16:55:48.138] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:48.138] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:193:0) after 1m0s
[16:56:48.247] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:193:0)
[16:56:48.247] Timer tick, asking Buildbucket for the build status
[16:56:48.312] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:48.312] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:194:0) after 1m0s
[16:57:48.399] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:194:0)
[16:57:48.399] Timer tick, asking Buildbucket for the build status
[16:57:48.659] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:48.659] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:195:0) after 1m0s
[16:58:48.696] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:195:0)
[16:58:48.696] Timer tick, asking Buildbucket for the build status
[16:58:48.840] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:48.840] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:196:0) after 1m0s
[16:59:48.861] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:196:0)
[16:59:48.861] Timer tick, asking Buildbucket for the build status
[16:59:48.925] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:48.925] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:197:0) after 1m0s
[17:00:49.237] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:197:0)
[17:00:49.237] Timer tick, asking Buildbucket for the build status
[17:00:49.677] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:49.677] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:198:0) after 1m0s
[17:01:49.780] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:198:0)
[17:01:49.780] Timer tick, asking Buildbucket for the build status
[17:01:50.629] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:50.629] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:199:0) after 1m0s
[17:02:50.804] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:199:0)
[17:02:50.804] Timer tick, asking Buildbucket for the build status
[17:02:51.136] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:51.136] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:200:0) after 1m0s
[17:03:51.344] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:200:0)
[17:03:51.344] Timer tick, asking Buildbucket for the build status
[17:03:51.432] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:51.432] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:201:0) after 1m0s
[17:04:51.563] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:201:0)
[17:04:51.563] Timer tick, asking Buildbucket for the build status
[17:04:52.096] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:52.096] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:202:0) after 1m0s
[17:05:52.109] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:202:0)
[17:05:52.109] Timer tick, asking Buildbucket for the build status
[17:05:52.293] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:52.294] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:203:0) after 1m0s
[17:06:52.428] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:203:0)
[17:06:52.428] Timer tick, asking Buildbucket for the build status
[17:06:52.845] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:52.845] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:204:0) after 1m0s
[17:07:52.895] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:204:0)
[17:07:52.895] Timer tick, asking Buildbucket for the build status
[17:07:53.249] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:53.249] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:205:0) after 1m0s
[17:08:53.250] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:205:0)
[17:08:53.250] Timer tick, asking Buildbucket for the build status
[17:08:53.393] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:53.393] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:206:0) after 1m0s
[17:09:53.418] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:206:0)
[17:09:53.418] Timer tick, asking Buildbucket for the build status
[17:09:53.522] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:53.522] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:207:0) after 1m0s
[17:10:53.595] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:207:0)
[17:10:53.595] Timer tick, asking Buildbucket for the build status
[17:10:54.144] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:54.144] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:208:0) after 1m0s
[17:11:54.145] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:208:0)
[17:11:54.145] Timer tick, asking Buildbucket for the build status
[17:11:54.259] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:54.259] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:209:0) after 1m0s
[17:12:54.307] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:209:0)
[17:12:54.307] Timer tick, asking Buildbucket for the build status
[17:12:54.830] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:54.830] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:210:0) after 1m0s
[17:13:54.957] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:210:0)
[17:13:54.957] Timer tick, asking Buildbucket for the build status
[17:13:55.056] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:55.056] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:211:0) after 1m0s
[17:14:55.058] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:211:0)
[17:14:55.058] Timer tick, asking Buildbucket for the build status
[17:14:55.250] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:55.250] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:212:0) after 1m0s
[17:15:55.364] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:212:0)
[17:15:55.364] Timer tick, asking Buildbucket for the build status
[17:15:55.488] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:55.488] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:213:0) after 1m0s
[17:16:55.692] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:213:0)
[17:16:55.692] Timer tick, asking Buildbucket for the build status
[17:16:55.810] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:55.810] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:214:0) after 1m0s
[17:17:55.912] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:214:0)
[17:17:55.912] Timer tick, asking Buildbucket for the build status
[17:17:55.997] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:55.997] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:215:0) after 1m0s
[17:18:56.053] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:215:0)
[17:18:56.053] Timer tick, asking Buildbucket for the build status
[17:18:56.148] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:56.148] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:216:0) after 1m0s
[17:19:56.244] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:216:0)
[17:19:56.244] Timer tick, asking Buildbucket for the build status
[17:19:56.408] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:56.408] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:217:0) after 1m0s
[17:20:56.513] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:217:0)
[17:20:56.513] Timer tick, asking Buildbucket for the build status
[17:20:56.621] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:56.621] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:218:0) after 1m0s
[17:21:56.728] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:218:0)
[17:21:56.728] Timer tick, asking Buildbucket for the build status
[17:21:56.798] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:56.798] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:219:0) after 1m0s
[17:22:56.864] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:219:0)
[17:22:56.864] Timer tick, asking Buildbucket for the build status
[17:22:57.781] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:57.781] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:220:0) after 1m0s
[17:23:58.010] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:220:0)
[17:23:58.010] Timer tick, asking Buildbucket for the build status
[17:23:58.140] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:58.140] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:221:0) after 1m0s
[17:24:58.258] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:221:0)
[17:24:58.258] Timer tick, asking Buildbucket for the build status
[17:24:58.403] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:58.403] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:222:0) after 1m0s
[17:25:58.494] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:222:0)
[17:25:58.494] Timer tick, asking Buildbucket for the build status
[17:25:58.994] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:58.994] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:223:0) after 1m0s
[17:26:59.033] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:223:0)
[17:26:59.033] Timer tick, asking Buildbucket for the build status
[17:26:59.316] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:59.316] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:224:0) after 1m0s
[17:27:59.406] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:224:0)
[17:27:59.406] Timer tick, asking Buildbucket for the build status
[17:27:59.555] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:59.556] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:225:0) after 1m0s
[17:28:59.647] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:225:0)
[17:28:59.647] Timer tick, asking Buildbucket for the build status
[17:28:59.711] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:59.711] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:226:0) after 1m0s
[17:29:59.762] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:226:0)
[17:29:59.762] Timer tick, asking Buildbucket for the build status
[17:29:59.895] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:59.895] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:227:0) after 1m0s
[17:30:59.979] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:227:0)
[17:30:59.979] Timer tick, asking Buildbucket for the build status
[17:31:00.156] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:00.156] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:228:0) after 1m0s
[17:32:00.179] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:228:0)
[17:32:00.179] Timer tick, asking Buildbucket for the build status
[17:32:00.342] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:00.342] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:229:0) after 1m0s
[17:33:00.410] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:229:0)
[17:33:00.410] Timer tick, asking Buildbucket for the build status
[17:33:00.680] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:00.680] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:230:0) after 1m0s
[17:34:00.990] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:230:0)
[17:34:00.990] Timer tick, asking Buildbucket for the build status
[17:34:01.154] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:01.154] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:231:0) after 1m0s
[17:35:01.198] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:231:0)
[17:35:01.198] Timer tick, asking Buildbucket for the build status
[17:35:01.759] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:01.759] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:232:0) after 1m0s
[17:36:01.856] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:232:0)
[17:36:01.856] Timer tick, asking Buildbucket for the build status
[17:36:01.944] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:01.944] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:233:0) after 1m0s
[17:37:01.950] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:233:0)
[17:37:01.950] Timer tick, asking Buildbucket for the build status
[17:37:02.122] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:02.122] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:234:0) after 1m0s
[17:38:02.204] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:234:0)
[17:38:02.204] Timer tick, asking Buildbucket for the build status
[17:38:02.474] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:02.474] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:235:0) after 1m0s
[17:39:02.568] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:235:0)
[17:39:02.568] Timer tick, asking Buildbucket for the build status
[17:39:03.278] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:03.278] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:236:0) after 1m0s
[17:40:03.311] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:236:0)
[17:40:03.311] Timer tick, asking Buildbucket for the build status
[17:40:03.489] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:03.489] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:237:0) after 1m0s
[17:41:03.555] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:237:0)
[17:41:03.555] Timer tick, asking Buildbucket for the build status
[17:41:03.713] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:03.713] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:238:0) after 1m0s
[17:42:03.807] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:238:0)
[17:42:03.807] Timer tick, asking Buildbucket for the build status
[17:42:03.899] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:03.899] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:239:0) after 1m0s
[17:43:03.967] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:239:0)
[17:43:03.967] Timer tick, asking Buildbucket for the build status
[17:43:04.319] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:04.319] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:240:0) after 1m0s
[17:44:04.404] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:240:0)
[17:44:04.404] Timer tick, asking Buildbucket for the build status
[17:44:04.715] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:04.715] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:241:0) after 1m0s
[17:45:04.819] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:241:0)
[17:45:04.819] Timer tick, asking Buildbucket for the build status
[17:45:04.907] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:04.907] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:242:0) after 1m0s
[17:46:05.053] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:242:0)
[17:46:05.053] Timer tick, asking Buildbucket for the build status
[17:46:05.163] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:05.163] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:243:0) after 1m0s
[17:47:05.236] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:243:0)
[17:47:05.236] Timer tick, asking Buildbucket for the build status
[17:47:05.299] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:05.299] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:244:0) after 1m0s
[17:48:05.381] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:244:0)
[17:48:05.381] Timer tick, asking Buildbucket for the build status
[17:48:05.606] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:05.606] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:245:0) after 1m0s
[17:49:05.619] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:245:0)
[17:49:05.619] Timer tick, asking Buildbucket for the build status
[17:49:05.688] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:05.688] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:246:0) after 1m0s
[17:50:05.729] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:246:0)
[17:50:05.730] Timer tick, asking Buildbucket for the build status
[17:50:06.031] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:06.031] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:247:0) after 1m0s
[17:51:06.081] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:247:0)
[17:51:06.081] Timer tick, asking Buildbucket for the build status
[17:51:06.181] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:06.181] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:248:0) after 1m0s
[17:52:06.231] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:248:0)
[17:52:06.231] Timer tick, asking Buildbucket for the build status
[17:52:06.340] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:06.340] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:249:0) after 1m0s
[17:53:06.833] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:249:0)
[17:53:06.833] Timer tick, asking Buildbucket for the build status
[17:53:07.631] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:07.631] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:250:0) after 1m0s
[17:54:07.837] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:250:0)
[17:54:07.837] Timer tick, asking Buildbucket for the build status
[17:54:09.757] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:09.757] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:251:0) after 1m0s
[17:55:09.972] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:251:0)
[17:55:09.972] Timer tick, asking Buildbucket for the build status
[17:55:12.047] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:12.047] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:252:0) after 1m0s
[17:56:12.379] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:252:0)
[17:56:12.379] Timer tick, asking Buildbucket for the build status
[17:56:12.496] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:12.496] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:253:0) after 1m0s
[17:57:12.551] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:253:0)
[17:57:12.551] Timer tick, asking Buildbucket for the build status
[17:57:12.880] Build 8852687961679850752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:12.880] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9018118023708883232:254:0) after 1m0s
[17:57:57.654] Received PubSub notification, asking Buildbucket for the build status
[17:57:57.916] Build 8852687961679850752: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:57:57.916] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615831076820395",
"created_by": "project:chromium",
"created_ts": "1615815881995128",
"id": "8852687961679850752",
"parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"255eb32c897b28c692b3da72617c993338633b91\"}}",
"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\": \"255eb32c897b28c692b3da72617c993338633b91\", \"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-1-u2gj\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win32-official\", \"buildnumber\": 1699, \"got_angle_revision\": \"45ce8d1e89ea780ed7f87a10e65a6d12c0ca5d33\", \"got_dawn_revision\": \"d41aa4378d25e551e6e2f3ae0406757e994ff24b\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"255eb32c897b28c692b3da72617c993338633b91\", \"got_revision_cp\": \"refs/heads/master@{#862792}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"5cdf55ff2084d8aa719fe74fbe1622b61ff64294\", \"got_v8_revision\": \"0560234773bbbac133fbff9e109b07cc23df8752\", \"got_v8_revision_cp\": \"refs/heads/9.1.108@{#2}\", \"got_webrtc_revision\": \"86473404362e38131203537b8a8c8ec7c1abc31a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33444}\", \"is_cached\": true, \"mirrored_builders\": [\"tryserver.chromium:win32-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"255eb32c897b28c692b3da72617c993338633b91\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_f6b49936a2965b3cdad8f63ce13313d0c4b82119a9acfffbfe199e91c26d0c88_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-1-u2gj\"], \"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\": [\"5754-8c4f760\"], \"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": "1615815890063168",
"status": "COMPLETED",
"status_changed_ts": "1615831077328804",
"tags": [
"build_address:luci.chromium.ci/win32-official/1699",
"builder:win32-official",
"buildset:commit/git/255eb32c897b28c692b3da72617c993338633b91",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/255eb32c897b28c692b3da72617c993338633b91",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018118023708883232",
"scheduler_job_id:chromium/win32-official",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8852687961679850752/+/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:524ef350c49e8b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1615831077345745",
"url": "https://ci.chromium.org/b/8852687961679850752",
"utcnow_ts": "1615831077890853"
}
}
[17:57:57.916] Invocation finished in 4h13m17.240774941s with status SUCCEEDED