[09:04:58.117] New invocation is queued and will start shortly
[09:04:59.296] Starting the invocation (attempt 1)
[09:04:59.336] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:04:59.337] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:04:59.337] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022937260733364512",
"parameters_json": "{\"builder_name\":\"win32-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"ec3ff6eb4d53bc3f448d7084087a532eb14611eb\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win32-official",
"scheduler_invocation_id:9022937260733364512",
"scheduler_job_id:chromium/win32-official",
"user_agent:luci-scheduler",
"buildset:commit/git/ec3ff6eb4d53bc3f448d7084087a532eb14611eb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ec3ff6eb4d53bc3f448d7084087a532eb14611eb",
"gitiles_ref:refs/heads/master"
]
}
[09:05:00.509] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611219899494149",
"id": "8857507198626932704",
"parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ec3ff6eb4d53bc3f448d7084087a532eb14611eb\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611219900286232",
"tags": [
"build_address:luci.chromium.ci/win32-official/1381",
"builder:win32-official",
"buildset:commit/git/ec3ff6eb4d53bc3f448d7084087a532eb14611eb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ec3ff6eb4d53bc3f448d7084087a532eb14611eb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022937260733364512",
"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/8857507198626932704/+/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": "1611219900286380",
"url": "https://ci.chromium.org/b/8857507198626932704",
"utcnow_ts": "1611219900499205"
}
}
[09:05:00.509] Task URL: https://ci.chromium.org/b/8857507198626932704
[09:05:00.509] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:2:0) after 1m0s
[09:05:18.058] Received PubSub notification, asking Buildbucket for the build status
[09:05:18.233] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:00.533] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:2:0)
[09:06:00.533] Timer tick, asking Buildbucket for the build status
[09:06:00.936] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:00.936] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:4:0) after 1m0s
[09:07:00.950] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:4:0)
[09:07:00.950] Timer tick, asking Buildbucket for the build status
[09:07:01.401] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:01.401] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:5:0) after 1m0s
[09:08:01.427] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:5:0)
[09:08:01.427] Timer tick, asking Buildbucket for the build status
[09:08:01.520] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:01.520] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:6:0) after 1m0s
[09:09:01.542] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:6:0)
[09:09:01.542] Timer tick, asking Buildbucket for the build status
[09:09:01.644] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:01.644] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:7:0) after 1m0s
[09:10:01.665] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:7:0)
[09:10:01.665] Timer tick, asking Buildbucket for the build status
[09:10:02.100] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:02.100] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:8:0) after 1m0s
[09:11:02.123] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:8:0)
[09:11:02.123] Timer tick, asking Buildbucket for the build status
[09:11:02.332] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:02.332] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:9:0) after 1m0s
[09:12:02.370] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:9:0)
[09:12:02.370] Timer tick, asking Buildbucket for the build status
[09:12:02.604] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:02.604] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:10:0) after 1m0s
[09:13:02.625] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:10:0)
[09:13:02.625] Timer tick, asking Buildbucket for the build status
[09:13:02.724] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:02.724] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:11:0) after 1m0s
[09:14:02.752] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:11:0)
[09:14:02.752] Timer tick, asking Buildbucket for the build status
[09:14:03.078] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:03.078] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:12:0) after 1m0s
[09:15:03.097] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:12:0)
[09:15:03.098] Timer tick, asking Buildbucket for the build status
[09:15:03.331] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:03.331] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:13:0) after 1m0s
[09:16:03.361] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:13:0)
[09:16:03.361] Timer tick, asking Buildbucket for the build status
[09:16:03.588] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:03.588] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:14:0) after 1m0s
[09:17:03.637] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:14:0)
[09:17:03.637] Timer tick, asking Buildbucket for the build status
[09:17:03.740] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:03.741] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:15:0) after 1m0s
[09:18:03.744] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:15:0)
[09:18:03.744] Timer tick, asking Buildbucket for the build status
[09:18:03.912] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:03.912] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:16:0) after 1m0s
[09:19:03.932] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:16:0)
[09:19:03.932] Timer tick, asking Buildbucket for the build status
[09:19:04.092] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:04.092] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:17:0) after 1m0s
[09:20:04.108] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:17:0)
[09:20:04.108] Timer tick, asking Buildbucket for the build status
[09:20:04.214] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:04.214] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:18:0) after 1m0s
[09:21:04.364] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:18:0)
[09:21:04.364] Timer tick, asking Buildbucket for the build status
[09:21:04.428] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:04.428] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:19:0) after 1m0s
[09:22:04.585] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:19:0)
[09:22:04.585] Timer tick, asking Buildbucket for the build status
[09:22:04.834] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:04.834] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:20:0) after 1m0s
[09:23:04.986] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:20:0)
[09:23:04.986] Timer tick, asking Buildbucket for the build status
[09:23:05.192] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:05.192] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:21:0) after 1m0s
[09:24:05.206] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:21:0)
[09:24:05.206] Timer tick, asking Buildbucket for the build status
[09:24:05.270] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:05.270] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:22:0) after 1m0s
[09:25:05.284] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:22:0)
[09:25:05.284] Timer tick, asking Buildbucket for the build status
[09:25:05.448] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:05.448] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:23:0) after 1m0s
[09:26:05.591] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:23:0)
[09:26:05.591] Timer tick, asking Buildbucket for the build status
[09:26:05.655] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:05.655] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:24:0) after 1m0s
[09:27:05.766] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:24:0)
[09:27:05.766] Timer tick, asking Buildbucket for the build status
[09:27:06.090] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:06.090] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:25:0) after 1m0s
[09:28:06.239] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:25:0)
[09:28:06.239] Timer tick, asking Buildbucket for the build status
[09:28:06.742] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:06.742] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:26:0) after 1m0s
[09:29:06.810] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:26:0)
[09:29:06.810] Timer tick, asking Buildbucket for the build status
[09:29:07.015] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:07.015] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:27:0) after 1m0s
[09:30:07.056] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:27:0)
[09:30:07.056] Timer tick, asking Buildbucket for the build status
[09:30:07.466] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:07.466] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:28:0) after 1m0s
[09:31:08.034] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:28:0)
[09:31:08.034] Timer tick, asking Buildbucket for the build status
[09:31:08.123] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:08.123] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:29:0) after 1m0s
[09:32:08.266] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:29:0)
[09:32:08.266] Timer tick, asking Buildbucket for the build status
[09:32:08.397] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:08.397] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:30:0) after 1m0s
[09:33:08.574] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:30:0)
[09:33:08.574] Timer tick, asking Buildbucket for the build status
[09:33:08.726] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:08.726] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:31:0) after 1m0s
[09:34:08.765] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:31:0)
[09:34:08.765] Timer tick, asking Buildbucket for the build status
[09:34:08.821] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:08.821] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:32:0) after 1m0s
[09:35:08.964] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:32:0)
[09:35:08.964] Timer tick, asking Buildbucket for the build status
[09:35:09.589] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:09.589] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:33:0) after 1m0s
[09:36:09.862] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:33:0)
[09:36:09.862] Timer tick, asking Buildbucket for the build status
[09:36:09.927] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:09.927] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:34:0) after 1m0s
[09:37:09.995] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:34:0)
[09:37:09.995] Timer tick, asking Buildbucket for the build status
[09:37:10.062] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:10.062] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:35:0) after 1m0s
[09:38:10.194] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:35:0)
[09:38:10.194] Timer tick, asking Buildbucket for the build status
[09:38:10.790] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:10.790] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:36:0) after 1m0s
[09:39:10.771] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:36:0)
[09:39:10.771] Timer tick, asking Buildbucket for the build status
[09:39:10.830] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:10.830] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:37:0) after 1m0s
[09:40:10.866] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:37:0)
[09:40:10.866] Timer tick, asking Buildbucket for the build status
[09:40:10.983] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:10.983] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:38:0) after 1m0s
[09:41:11.078] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:38:0)
[09:41:11.078] Timer tick, asking Buildbucket for the build status
[09:41:11.772] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:11.772] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:39:0) after 1m0s
[09:42:11.875] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:39:0)
[09:42:11.875] Timer tick, asking Buildbucket for the build status
[09:42:12.030] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:12.030] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:40:0) after 1m0s
[09:43:12.049] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:40:0)
[09:43:12.049] Timer tick, asking Buildbucket for the build status
[09:43:12.248] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:12.248] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:41:0) after 1m0s
[09:44:12.269] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:41:0)
[09:44:12.269] Timer tick, asking Buildbucket for the build status
[09:44:12.381] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:12.381] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:42:0) after 1m0s
[09:45:12.463] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:42:0)
[09:45:12.463] Timer tick, asking Buildbucket for the build status
[09:45:12.857] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:12.857] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:43:0) after 1m0s
[09:46:13.016] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:43:0)
[09:46:13.016] Timer tick, asking Buildbucket for the build status
[09:46:13.086] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:13.086] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:44:0) after 1m0s
[09:47:13.127] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:44:0)
[09:47:13.127] Timer tick, asking Buildbucket for the build status
[09:47:13.191] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:13.191] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:45:0) after 1m0s
[09:48:13.312] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:45:0)
[09:48:13.312] Timer tick, asking Buildbucket for the build status
[09:48:13.381] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:13.381] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:46:0) after 1m0s
[09:49:13.381] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:46:0)
[09:49:13.381] Timer tick, asking Buildbucket for the build status
[09:49:13.511] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:13.511] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:47:0) after 1m0s
[09:50:13.649] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:47:0)
[09:50:13.649] Timer tick, asking Buildbucket for the build status
[09:50:14.016] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:14.016] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:48:0) after 1m0s
[09:51:14.100] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:48:0)
[09:51:14.100] Timer tick, asking Buildbucket for the build status
[09:51:14.195] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:14.195] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:49:0) after 1m0s
[09:52:14.238] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:49:0)
[09:52:14.238] Timer tick, asking Buildbucket for the build status
[09:52:14.326] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:14.326] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:50:0) after 1m0s
[09:53:14.344] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:50:0)
[09:53:14.344] Timer tick, asking Buildbucket for the build status
[09:53:14.517] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:14.518] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:51:0) after 1m0s
[09:54:14.590] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:51:0)
[09:54:14.590] Timer tick, asking Buildbucket for the build status
[09:54:15.018] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:15.018] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:52:0) after 1m0s
[09:55:15.089] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:52:0)
[09:55:15.089] Timer tick, asking Buildbucket for the build status
[09:55:15.214] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:15.214] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:53:0) after 1m0s
[09:56:15.242] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:53:0)
[09:56:15.242] Timer tick, asking Buildbucket for the build status
[09:56:15.309] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:15.309] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:54:0) after 1m0s
[09:57:15.335] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:54:0)
[09:57:15.335] Timer tick, asking Buildbucket for the build status
[09:57:15.400] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:15.400] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:55:0) after 1m0s
[09:58:15.478] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:55:0)
[09:58:15.478] Timer tick, asking Buildbucket for the build status
[09:58:15.619] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:15.619] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:56:0) after 1m0s
[09:59:15.623] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:56:0)
[09:59:15.623] Timer tick, asking Buildbucket for the build status
[09:59:15.683] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:15.684] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:57:0) after 1m0s
[10:00:15.762] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:57:0)
[10:00:15.762] Timer tick, asking Buildbucket for the build status
[10:00:15.881] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:15.881] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:58:0) after 1m0s
[10:01:15.990] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:58:0)
[10:01:15.990] Timer tick, asking Buildbucket for the build status
[10:01:16.054] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:16.054] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:59:0) after 1m0s
[10:02:16.178] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:59:0)
[10:02:16.178] Timer tick, asking Buildbucket for the build status
[10:02:16.253] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:16.253] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:60:0) after 1m0s
[10:03:16.366] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:60:0)
[10:03:16.366] Timer tick, asking Buildbucket for the build status
[10:03:16.445] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:16.445] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:61:0) after 1m0s
[10:04:16.537] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:61:0)
[10:04:16.537] Timer tick, asking Buildbucket for the build status
[10:04:16.649] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:16.649] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:62:0) after 1m0s
[10:05:16.674] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:62:0)
[10:05:16.674] Timer tick, asking Buildbucket for the build status
[10:05:16.781] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:16.781] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:63:0) after 1m0s
[10:06:16.872] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:63:0)
[10:06:16.872] Timer tick, asking Buildbucket for the build status
[10:06:17.032] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:17.032] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:64:0) after 1m0s
[10:07:17.066] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:64:0)
[10:07:17.066] Timer tick, asking Buildbucket for the build status
[10:07:17.128] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:17.128] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:65:0) after 1m0s
[10:08:17.142] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:65:0)
[10:08:17.142] Timer tick, asking Buildbucket for the build status
[10:08:17.220] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:17.220] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:66:0) after 1m0s
[10:09:17.310] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:66:0)
[10:09:17.310] Timer tick, asking Buildbucket for the build status
[10:09:17.618] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:17.618] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:67:0) after 1m0s
[10:10:17.639] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:67:0)
[10:10:17.639] Timer tick, asking Buildbucket for the build status
[10:10:17.746] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:17.746] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:68:0) after 1m0s
[10:11:17.814] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:68:0)
[10:11:17.814] Timer tick, asking Buildbucket for the build status
[10:11:17.912] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:17.912] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:69:0) after 1m0s
[10:12:17.948] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:69:0)
[10:12:17.948] Timer tick, asking Buildbucket for the build status
[10:12:18.011] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:18.011] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:70:0) after 1m0s
[10:13:18.069] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:70:0)
[10:13:18.069] Timer tick, asking Buildbucket for the build status
[10:13:18.465] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:18.465] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:71:0) after 1m0s
[10:14:18.494] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:71:0)
[10:14:18.494] Timer tick, asking Buildbucket for the build status
[10:14:18.792] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:18.792] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:72:0) after 1m0s
[10:15:18.868] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:72:0)
[10:15:18.868] Timer tick, asking Buildbucket for the build status
[10:15:18.976] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:18.976] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:73:0) after 1m0s
[10:16:19.049] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:73:0)
[10:16:19.049] Timer tick, asking Buildbucket for the build status
[10:16:19.113] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:19.114] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:74:0) after 1m0s
[10:17:19.135] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:74:0)
[10:17:19.135] Timer tick, asking Buildbucket for the build status
[10:17:19.232] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:19.232] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:75:0) after 1m0s
[10:18:19.301] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:75:0)
[10:18:19.301] Timer tick, asking Buildbucket for the build status
[10:18:19.366] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:19.366] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:76:0) after 1m0s
[10:19:19.400] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:76:0)
[10:19:19.400] Timer tick, asking Buildbucket for the build status
[10:19:19.468] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:19.468] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:77:0) after 1m0s
[10:20:19.496] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:77:0)
[10:20:19.496] Timer tick, asking Buildbucket for the build status
[10:20:19.953] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:19.953] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:78:0) after 1m0s
[10:21:19.989] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:78:0)
[10:21:19.989] Timer tick, asking Buildbucket for the build status
[10:21:20.072] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:20.072] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:79:0) after 1m0s
[10:22:20.060] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:79:0)
[10:22:20.060] Timer tick, asking Buildbucket for the build status
[10:22:20.127] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:20.127] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:80:0) after 1m0s
[10:23:20.196] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:80:0)
[10:23:20.196] Timer tick, asking Buildbucket for the build status
[10:23:20.320] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:20.320] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:81:0) after 1m0s
[10:24:20.355] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:81:0)
[10:24:20.355] Timer tick, asking Buildbucket for the build status
[10:24:20.431] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:20.431] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:82:0) after 1m0s
[10:25:20.464] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:82:0)
[10:25:20.464] Timer tick, asking Buildbucket for the build status
[10:25:20.570] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:20.570] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:83:0) after 1m0s
[10:26:20.582] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:83:0)
[10:26:20.582] Timer tick, asking Buildbucket for the build status
[10:26:20.690] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:20.690] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:84:0) after 1m0s
[10:27:20.724] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:84:0)
[10:27:20.724] Timer tick, asking Buildbucket for the build status
[10:27:20.784] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:20.784] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:85:0) after 1m0s
[10:28:20.845] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:85:0)
[10:28:20.845] Timer tick, asking Buildbucket for the build status
[10:28:20.895] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:20.895] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:86:0) after 1m0s
[10:29:20.963] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:86:0)
[10:29:20.963] Timer tick, asking Buildbucket for the build status
[10:29:21.076] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:21.076] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:87:0) after 1m0s
[10:30:21.285] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:87:0)
[10:30:21.285] Timer tick, asking Buildbucket for the build status
[10:30:21.388] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:21.388] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:88:0) after 1m0s
[10:31:21.442] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:88:0)
[10:31:21.442] Timer tick, asking Buildbucket for the build status
[10:31:21.498] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:21.498] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:89:0) after 1m0s
[10:32:21.554] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:89:0)
[10:32:21.554] Timer tick, asking Buildbucket for the build status
[10:32:22.161] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:22.161] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:90:0) after 1m0s
[10:33:22.171] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:90:0)
[10:33:22.171] Timer tick, asking Buildbucket for the build status
[10:33:22.657] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:22.657] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:91:0) after 1m0s
[10:34:22.760] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:91:0)
[10:34:22.760] Timer tick, asking Buildbucket for the build status
[10:34:22.813] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:22.813] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:92:0) after 1m0s
[10:35:22.860] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:92:0)
[10:35:22.860] Timer tick, asking Buildbucket for the build status
[10:35:22.971] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:22.971] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:93:0) after 1m0s
[10:36:23.022] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:93:0)
[10:36:23.022] Timer tick, asking Buildbucket for the build status
[10:36:23.329] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:23.330] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:94:0) after 1m0s
[10:37:23.420] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:94:0)
[10:37:23.420] Timer tick, asking Buildbucket for the build status
[10:37:23.516] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:23.516] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:95:0) after 1m0s
[10:38:23.653] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:95:0)
[10:38:23.653] Timer tick, asking Buildbucket for the build status
[10:38:23.810] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:23.810] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:96:0) after 1m0s
[10:39:23.901] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:96:0)
[10:39:23.901] Timer tick, asking Buildbucket for the build status
[10:39:23.971] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:23.971] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:97:0) after 1m0s
[10:40:24.004] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:97:0)
[10:40:24.004] Timer tick, asking Buildbucket for the build status
[10:40:24.165] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:24.165] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:98:0) after 1m0s
[10:41:24.189] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:98:0)
[10:41:24.189] Timer tick, asking Buildbucket for the build status
[10:41:24.251] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:24.251] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:99:0) after 1m0s
[10:42:24.289] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:99:0)
[10:42:24.289] Timer tick, asking Buildbucket for the build status
[10:42:24.889] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:24.889] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:100:0) after 1m0s
[10:43:25.401] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:100:0)
[10:43:25.401] Timer tick, asking Buildbucket for the build status
[10:43:25.456] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:25.456] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:101:0) after 1m0s
[10:44:25.510] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:101:0)
[10:44:25.510] Timer tick, asking Buildbucket for the build status
[10:44:25.578] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:25.578] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:102:0) after 1m0s
[10:45:25.632] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:102:0)
[10:45:25.632] Timer tick, asking Buildbucket for the build status
[10:45:26.017] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:26.017] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:103:0) after 1m0s
[10:46:26.088] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:103:0)
[10:46:26.088] Timer tick, asking Buildbucket for the build status
[10:46:26.247] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:26.247] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:104:0) after 1m0s
[10:47:26.335] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:104:0)
[10:47:26.335] Timer tick, asking Buildbucket for the build status
[10:47:27.062] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:27.062] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:105:0) after 1m0s
[10:48:27.109] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:105:0)
[10:48:27.109] Timer tick, asking Buildbucket for the build status
[10:48:27.179] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:27.179] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:106:0) after 1m0s
[10:49:27.216] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:106:0)
[10:49:27.216] Timer tick, asking Buildbucket for the build status
[10:49:27.278] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:27.278] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:107:0) after 1m0s
[10:50:27.317] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:107:0)
[10:50:27.317] Timer tick, asking Buildbucket for the build status
[10:50:27.417] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:27.417] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:108:0) after 1m0s
[10:51:27.546] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:108:0)
[10:51:27.546] Timer tick, asking Buildbucket for the build status
[10:51:27.721] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:27.721] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:109:0) after 1m0s
[10:52:27.717] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:109:0)
[10:52:27.717] Timer tick, asking Buildbucket for the build status
[10:52:27.776] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:27.776] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:110:0) after 1m0s
[10:53:27.763] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:110:0)
[10:53:27.763] Timer tick, asking Buildbucket for the build status
[10:53:27.828] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:27.828] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:111:0) after 1m0s
[10:54:27.896] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:111:0)
[10:54:27.896] Timer tick, asking Buildbucket for the build status
[10:54:28.186] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:28.186] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:112:0) after 1m0s
[10:55:28.214] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:112:0)
[10:55:28.214] Timer tick, asking Buildbucket for the build status
[10:55:28.612] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:28.612] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:113:0) after 1m0s
[10:56:28.670] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:113:0)
[10:56:28.670] Timer tick, asking Buildbucket for the build status
[10:56:28.731] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:28.731] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:114:0) after 1m0s
[10:57:28.739] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:114:0)
[10:57:28.739] Timer tick, asking Buildbucket for the build status
[10:57:28.804] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:28.804] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:115:0) after 1m0s
[10:58:28.816] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:115:0)
[10:58:28.816] Timer tick, asking Buildbucket for the build status
[10:58:28.885] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:28.885] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:116:0) after 1m0s
[10:59:28.883] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:116:0)
[10:59:28.883] Timer tick, asking Buildbucket for the build status
[10:59:28.959] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:28.960] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:117:0) after 1m0s
[11:00:29.098] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:117:0)
[11:00:29.098] Timer tick, asking Buildbucket for the build status
[11:00:29.206] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:29.206] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:118:0) after 1m0s
[11:01:29.233] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:118:0)
[11:01:29.233] Timer tick, asking Buildbucket for the build status
[11:01:29.489] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:29.489] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:119:0) after 1m0s
[11:02:29.581] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:119:0)
[11:02:29.581] Timer tick, asking Buildbucket for the build status
[11:02:29.703] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:29.703] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:120:0) after 1m0s
[11:03:30.086] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:120:0)
[11:03:30.086] Timer tick, asking Buildbucket for the build status
[11:03:30.381] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:30.381] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:121:0) after 1m0s
[11:04:30.480] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:121:0)
[11:04:30.480] Timer tick, asking Buildbucket for the build status
[11:04:30.646] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:30.646] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:122:0) after 1m0s
[11:05:30.703] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:122:0)
[11:05:30.703] Timer tick, asking Buildbucket for the build status
[11:05:30.835] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:30.835] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:123:0) after 1m0s
[11:06:32.682] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:123:0)
[11:06:32.682] Timer tick, asking Buildbucket for the build status
[11:06:32.752] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:32.752] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:124:0) after 1m0s
[11:07:33.029] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:124:0)
[11:07:33.029] Timer tick, asking Buildbucket for the build status
[11:07:33.316] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:33.316] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:125:0) after 1m0s
[11:08:33.439] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:125:0)
[11:08:33.440] Timer tick, asking Buildbucket for the build status
[11:08:33.520] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:33.520] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:126:0) after 1m0s
[11:09:33.813] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:126:0)
[11:09:33.813] Timer tick, asking Buildbucket for the build status
[11:09:33.872] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:33.872] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:127:0) after 1m0s
[11:10:35.618] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:127:0)
[11:10:35.618] Timer tick, asking Buildbucket for the build status
[11:10:35.745] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:35.745] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:128:0) after 1m0s
[11:11:35.972] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:128:0)
[11:11:35.972] Timer tick, asking Buildbucket for the build status
[11:11:36.251] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:36.251] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:129:0) after 1m0s
[11:12:36.313] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:129:0)
[11:12:36.313] Timer tick, asking Buildbucket for the build status
[11:12:36.387] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:36.387] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:130:0) after 1m0s
[11:13:36.375] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:130:0)
[11:13:36.375] Timer tick, asking Buildbucket for the build status
[11:13:36.445] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:36.445] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:131:0) after 1m0s
[11:14:36.431] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:131:0)
[11:14:36.431] Timer tick, asking Buildbucket for the build status
[11:14:36.483] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:36.483] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:132:0) after 1m0s
[11:15:36.500] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:132:0)
[11:15:36.500] Timer tick, asking Buildbucket for the build status
[11:15:36.666] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:36.666] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:133:0) after 1m0s
[11:16:36.715] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:133:0)
[11:16:36.715] Timer tick, asking Buildbucket for the build status
[11:16:36.773] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:36.773] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:134:0) after 1m0s
[11:17:36.769] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:134:0)
[11:17:36.769] Timer tick, asking Buildbucket for the build status
[11:17:36.841] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:36.841] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:135:0) after 1m0s
[11:18:36.830] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:135:0)
[11:18:36.830] Timer tick, asking Buildbucket for the build status
[11:18:37.320] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:37.320] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:136:0) after 1m0s
[11:19:37.493] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:136:0)
[11:19:37.493] Timer tick, asking Buildbucket for the build status
[11:19:37.557] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:37.557] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:137:0) after 1m0s
[11:20:37.617] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:137:0)
[11:20:37.617] Timer tick, asking Buildbucket for the build status
[11:20:37.734] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:37.734] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:138:0) after 1m0s
[11:21:37.874] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:138:0)
[11:21:37.874] Timer tick, asking Buildbucket for the build status
[11:21:37.933] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:37.933] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:139:0) after 1m0s
[11:22:38.102] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:139:0)
[11:22:38.102] Timer tick, asking Buildbucket for the build status
[11:22:38.174] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:38.174] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:140:0) after 1m0s
[11:23:38.182] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:140:0)
[11:23:38.182] Timer tick, asking Buildbucket for the build status
[11:23:38.385] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:38.385] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:141:0) after 1m0s
[11:24:38.478] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:141:0)
[11:24:38.478] Timer tick, asking Buildbucket for the build status
[11:24:38.552] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:38.552] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:142:0) after 1m0s
[11:25:40.078] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:142:0)
[11:25:40.078] Timer tick, asking Buildbucket for the build status
[11:25:40.228] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:40.228] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:143:0) after 1m0s
[11:26:40.247] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:143:0)
[11:26:40.247] Timer tick, asking Buildbucket for the build status
[11:26:40.310] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:40.310] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:144:0) after 1m0s
[11:27:40.376] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:144:0)
[11:27:40.376] Timer tick, asking Buildbucket for the build status
[11:27:40.453] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:40.453] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:145:0) after 1m0s
[11:28:40.535] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:145:0)
[11:28:40.535] Timer tick, asking Buildbucket for the build status
[11:28:40.631] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:40.631] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:146:0) after 1m0s
[11:29:40.702] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:146:0)
[11:29:40.702] Timer tick, asking Buildbucket for the build status
[11:29:40.763] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:40.763] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:147:0) after 1m0s
[11:30:40.810] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:147:0)
[11:30:40.810] Timer tick, asking Buildbucket for the build status
[11:30:41.034] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:41.034] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:148:0) after 1m0s
[11:31:41.140] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:148:0)
[11:31:41.140] Timer tick, asking Buildbucket for the build status
[11:31:41.213] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:41.213] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:149:0) after 1m0s
[11:32:41.345] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:149:0)
[11:32:41.345] Timer tick, asking Buildbucket for the build status
[11:32:41.442] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:41.442] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:150:0) after 1m0s
[11:33:41.471] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:150:0)
[11:33:41.471] Timer tick, asking Buildbucket for the build status
[11:33:41.548] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:41.548] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:151:0) after 1m0s
[11:34:41.599] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:151:0)
[11:34:41.599] Timer tick, asking Buildbucket for the build status
[11:34:41.682] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:41.682] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:152:0) after 1m0s
[11:35:41.840] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:152:0)
[11:35:41.840] Timer tick, asking Buildbucket for the build status
[11:35:42.005] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:42.005] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:153:0) after 1m0s
[11:36:42.084] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:153:0)
[11:36:42.084] Timer tick, asking Buildbucket for the build status
[11:36:42.314] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:42.314] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:154:0) after 1m0s
[11:37:42.312] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:154:0)
[11:37:42.312] Timer tick, asking Buildbucket for the build status
[11:37:42.370] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:42.370] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:155:0) after 1m0s
[11:38:42.438] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:155:0)
[11:38:42.438] Timer tick, asking Buildbucket for the build status
[11:38:42.537] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:42.537] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:156:0) after 1m0s
[11:39:42.574] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:156:0)
[11:39:42.574] Timer tick, asking Buildbucket for the build status
[11:39:42.637] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:42.637] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:157:0) after 1m0s
[11:40:42.681] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:157:0)
[11:40:42.681] Timer tick, asking Buildbucket for the build status
[11:40:42.804] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:42.804] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:158:0) after 1m0s
[11:41:42.886] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:158:0)
[11:41:42.886] Timer tick, asking Buildbucket for the build status
[11:41:43.214] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:43.214] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:159:0) after 1m0s
[11:42:43.240] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:159:0)
[11:42:43.240] Timer tick, asking Buildbucket for the build status
[11:42:43.368] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:43.368] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:160:0) after 1m0s
[11:43:43.465] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:160:0)
[11:43:43.465] Timer tick, asking Buildbucket for the build status
[11:43:43.530] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:43.530] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:161:0) after 1m0s
[11:44:43.598] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:161:0)
[11:44:43.598] Timer tick, asking Buildbucket for the build status
[11:44:43.678] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:43.678] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:162:0) after 1m0s
[11:45:43.746] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:162:0)
[11:45:43.746] Timer tick, asking Buildbucket for the build status
[11:45:44.027] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:44.027] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:163:0) after 1m0s
[11:46:44.176] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:163:0)
[11:46:44.176] Timer tick, asking Buildbucket for the build status
[11:46:44.394] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:44.394] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:164:0) after 1m0s
[11:47:44.428] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:164:0)
[11:47:44.428] Timer tick, asking Buildbucket for the build status
[11:47:44.626] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:44.626] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:165:0) after 1m0s
[11:48:44.655] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:165:0)
[11:48:44.655] Timer tick, asking Buildbucket for the build status
[11:48:44.713] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:44.713] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:166:0) after 1m0s
[11:49:44.745] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:166:0)
[11:49:44.745] Timer tick, asking Buildbucket for the build status
[11:49:44.805] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:44.805] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:167:0) after 1m0s
[11:50:44.842] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:167:0)
[11:50:44.843] Timer tick, asking Buildbucket for the build status
[11:50:45.116] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:45.116] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:168:0) after 1m0s
[11:51:45.197] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:168:0)
[11:51:45.197] Timer tick, asking Buildbucket for the build status
[11:51:45.296] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:45.296] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:169:0) after 1m0s
[11:52:45.341] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:169:0)
[11:52:45.341] Timer tick, asking Buildbucket for the build status
[11:52:45.396] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:45.396] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:170:0) after 1m0s
[11:53:45.570] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:170:0)
[11:53:45.570] Timer tick, asking Buildbucket for the build status
[11:53:45.647] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:45.647] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:171:0) after 1m0s
[11:54:45.688] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:171:0)
[11:54:45.688] Timer tick, asking Buildbucket for the build status
[11:54:45.749] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:45.749] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:172:0) after 1m0s
[11:55:45.783] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:172:0)
[11:55:45.783] Timer tick, asking Buildbucket for the build status
[11:55:45.905] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:45.905] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:173:0) after 1m0s
[11:56:45.933] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:173:0)
[11:56:45.933] Timer tick, asking Buildbucket for the build status
[11:56:45.992] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:45.992] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:174:0) after 1m0s
[11:57:46.129] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:174:0)
[11:57:46.129] Timer tick, asking Buildbucket for the build status
[11:57:46.193] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:46.193] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:175:0) after 1m0s
[11:58:46.286] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:175:0)
[11:58:46.286] Timer tick, asking Buildbucket for the build status
[11:58:46.345] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:46.345] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:176:0) after 1m0s
[11:59:46.423] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:176:0)
[11:59:46.423] Timer tick, asking Buildbucket for the build status
[11:59:46.877] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:46.877] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:177:0) after 1m0s
[12:00:46.924] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:177:0)
[12:00:46.924] Timer tick, asking Buildbucket for the build status
[12:00:47.035] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:47.035] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:178:0) after 1m0s
[12:01:47.099] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:178:0)
[12:01:47.099] Timer tick, asking Buildbucket for the build status
[12:01:47.173] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:47.173] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:179:0) after 1m0s
[12:02:47.260] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:179:0)
[12:02:47.260] Timer tick, asking Buildbucket for the build status
[12:02:47.340] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:47.340] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:180:0) after 1m0s
[12:03:47.407] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:180:0)
[12:03:47.407] Timer tick, asking Buildbucket for the build status
[12:03:47.474] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:47.474] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:181:0) after 1m0s
[12:04:47.542] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:181:0)
[12:04:47.542] Timer tick, asking Buildbucket for the build status
[12:04:47.638] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:47.638] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:182:0) after 1m0s
[12:05:47.802] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:182:0)
[12:05:47.802] Timer tick, asking Buildbucket for the build status
[12:05:47.921] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:47.921] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:183:0) after 1m0s
[12:06:49.135] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:183:0)
[12:06:49.135] Timer tick, asking Buildbucket for the build status
[12:06:49.520] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:49.520] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:184:0) after 1m0s
[12:07:49.852] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:184:0)
[12:07:49.852] Timer tick, asking Buildbucket for the build status
[12:07:49.947] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:49.947] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:185:0) after 1m0s
[12:08:50.155] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:185:0)
[12:08:50.155] Timer tick, asking Buildbucket for the build status
[12:08:50.291] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:50.291] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:186:0) after 1m0s
[12:09:50.487] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:186:0)
[12:09:50.487] Timer tick, asking Buildbucket for the build status
[12:09:50.583] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:50.583] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:187:0) after 1m0s
[12:10:50.752] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:187:0)
[12:10:50.752] Timer tick, asking Buildbucket for the build status
[12:10:50.860] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:50.860] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:188:0) after 1m0s
[12:11:51.032] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:188:0)
[12:11:51.032] Timer tick, asking Buildbucket for the build status
[12:11:51.088] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:51.088] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:189:0) after 1m0s
[12:12:51.168] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:189:0)
[12:12:51.169] Timer tick, asking Buildbucket for the build status
[12:12:51.226] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:51.226] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:190:0) after 1m0s
[12:13:51.255] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:190:0)
[12:13:51.255] Timer tick, asking Buildbucket for the build status
[12:13:51.415] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:51.415] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:191:0) after 1m0s
[12:14:51.615] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:191:0)
[12:14:51.615] Timer tick, asking Buildbucket for the build status
[12:14:51.666] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:51.666] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:192:0) after 1m0s
[12:15:51.881] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:192:0)
[12:15:51.881] Timer tick, asking Buildbucket for the build status
[12:15:51.983] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:51.983] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:193:0) after 1m0s
[12:16:52.028] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:193:0)
[12:16:52.028] Timer tick, asking Buildbucket for the build status
[12:16:52.235] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:52.235] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:194:0) after 1m0s
[12:17:52.284] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:194:0)
[12:17:52.284] Timer tick, asking Buildbucket for the build status
[12:17:52.391] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:52.391] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:195:0) after 1m0s
[12:18:52.425] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:195:0)
[12:18:52.425] Timer tick, asking Buildbucket for the build status
[12:18:52.551] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:52.551] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:196:0) after 1m0s
[12:19:52.579] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:196:0)
[12:19:52.579] Timer tick, asking Buildbucket for the build status
[12:19:52.686] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:52.686] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:197:0) after 1m0s
[12:20:52.766] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:197:0)
[12:20:52.766] Timer tick, asking Buildbucket for the build status
[12:20:52.892] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:52.892] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:198:0) after 1m0s
[12:21:52.990] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:198:0)
[12:21:52.990] Timer tick, asking Buildbucket for the build status
[12:21:53.068] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:53.068] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:199:0) after 1m0s
[12:22:53.172] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:199:0)
[12:22:53.172] Timer tick, asking Buildbucket for the build status
[12:22:53.254] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:53.254] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:200:0) after 1m0s
[12:23:53.336] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:200:0)
[12:23:53.336] Timer tick, asking Buildbucket for the build status
[12:23:53.909] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:53.909] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:201:0) after 1m0s
[12:24:54.044] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:201:0)
[12:24:54.044] Timer tick, asking Buildbucket for the build status
[12:24:54.104] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:54.104] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:202:0) after 1m0s
[12:25:54.133] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:202:0)
[12:25:54.133] Timer tick, asking Buildbucket for the build status
[12:25:54.229] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:54.229] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:203:0) after 1m0s
[12:26:54.251] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:203:0)
[12:26:54.251] Timer tick, asking Buildbucket for the build status
[12:26:54.357] Build 8857507198626932704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:54.357] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022937260733364512:204:0) after 1m0s
[12:27:28.647] Received PubSub notification, asking Buildbucket for the build status
[12:27:28.749] Build 8857507198626932704: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:27:28.749] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611232047860211",
"created_by": "project:chromium",
"created_ts": "1611219899494149",
"id": "8857507198626932704",
"parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ec3ff6eb4d53bc3f448d7084087a532eb14611eb\"}}",
"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\": \"ec3ff6eb4d53bc3f448d7084087a532eb14611eb\", \"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-3-0m1t\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win32-official\", \"buildnumber\": 1381, \"got_angle_revision\": \"bb7660008b16bd0fea2bf114075aece585fbe1f1\", \"got_dawn_revision\": \"762814bd922932d3d9da9b220463b6ce5f167d76\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"ec3ff6eb4d53bc3f448d7084087a532eb14611eb\", \"got_revision_cp\": \"refs/heads/master@{#845563}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"1d5174b9dc3be500d63daf227b163b5e86bbc7b5\", \"got_v8_revision\": \"ed78a10326a2854dcf8561c61c974270f8e01dbe\", \"got_v8_revision_cp\": \"refs/heads/9.0.34@{#1}\", \"got_webrtc_revision\": \"49b20f919abe9a21227b0f6f86d223a3fb1e5ee4\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33048}\", \"mirrored_builders\": [\"tryserver.chromium:win32-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ec3ff6eb4d53bc3f448d7084087a532eb14611eb\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_bc0d7fca3bba32a7cb2a76c4cc7fbd17350dc3d147bb23130e4bc6899b47acfb_v2\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-3-0m1t\"], \"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\": [\"5671-1d9dea8\"], \"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": "1611219917550566",
"status": "COMPLETED",
"status_changed_ts": "1611232048296485",
"tags": [
"build_address:luci.chromium.ci/win32-official/1381",
"builder:win32-official",
"buildset:commit/git/ec3ff6eb4d53bc3f448d7084087a532eb14611eb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ec3ff6eb4d53bc3f448d7084087a532eb14611eb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022937260733364512",
"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/8857507198626932704/+/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:513d0220d8e04410",
"user_agent:luci-scheduler"
],
"updated_ts": "1611232048303125",
"url": "https://ci.chromium.org/b/8857507198626932704",
"utcnow_ts": "1611232048742771"
}
}
[12:27:28.749] Invocation finished in 3h22m30.647784036s with status SUCCEEDED