[13:59:59.126] New invocation is queued and will start shortly
[14:00:00.548] Starting the invocation (attempt 1)
[14:00:00.587] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:00:00.587] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:00:00.587] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020291387872863904",
"parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"e58536e2b0a1756a7b9dab419b60b93eb6eea4c6\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-official",
"scheduler_invocation_id:9020291387872863904",
"scheduler_job_id:chromium/win-official",
"user_agent:luci-scheduler",
"buildset:commit/git/e58536e2b0a1756a7b9dab419b60b93eb6eea4c6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e58536e2b0a1756a7b9dab419b60b93eb6eea4c6",
"gitiles_ref:refs/heads/master"
]
}
[14:00:01.657] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613743200719008",
"id": "8854861325520967424",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e58536e2b0a1756a7b9dab419b60b93eb6eea4c6\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613743201369704",
"tags": [
"build_address:luci.chromium.ci/win-official/1625",
"builder:win-official",
"buildset:commit/git/e58536e2b0a1756a7b9dab419b60b93eb6eea4c6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e58536e2b0a1756a7b9dab419b60b93eb6eea4c6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020291387872863904",
"scheduler_job_id:chromium/win-official",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8854861325520967424/+/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": "1613743201369822",
"url": "https://ci.chromium.org/b/8854861325520967424",
"utcnow_ts": "1613743201650545"
}
}
[14:00:01.658] Task URL: https://ci.chromium.org/b/8854861325520967424
[14:00:01.658] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:2:0) after 1m0s
[14:00:06.356] Received PubSub notification, asking Buildbucket for the build status
[14:00:06.656] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:02.348] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:2:0)
[14:01:02.348] Timer tick, asking Buildbucket for the build status
[14:01:02.419] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:02.419] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:4:0) after 1m0s
[14:02:02.448] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:4:0)
[14:02:02.448] Timer tick, asking Buildbucket for the build status
[14:02:02.548] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:02.548] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:5:0) after 1m0s
[14:03:02.596] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:5:0)
[14:03:02.596] Timer tick, asking Buildbucket for the build status
[14:03:02.676] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:02.676] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:6:0) after 1m0s
[14:04:02.785] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:6:0)
[14:04:02.785] Timer tick, asking Buildbucket for the build status
[14:04:02.869] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:02.869] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:7:0) after 1m0s
[14:05:02.961] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:7:0)
[14:05:02.961] Timer tick, asking Buildbucket for the build status
[14:05:03.061] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:03.061] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:8:0) after 1m0s
[14:06:03.108] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:8:0)
[14:06:03.108] Timer tick, asking Buildbucket for the build status
[14:06:03.624] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:03.624] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:9:0) after 1m0s
[14:07:03.712] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:9:0)
[14:07:03.713] Timer tick, asking Buildbucket for the build status
[14:07:03.810] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:03.810] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:10:0) after 1m0s
[14:08:03.837] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:10:0)
[14:08:03.837] Timer tick, asking Buildbucket for the build status
[14:08:04.098] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:04.098] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:11:0) after 1m0s
[14:09:04.132] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:11:0)
[14:09:04.132] Timer tick, asking Buildbucket for the build status
[14:09:04.696] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:04.696] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:12:0) after 1m0s
[14:10:04.813] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:12:0)
[14:10:04.813] Timer tick, asking Buildbucket for the build status
[14:10:05.307] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:05.307] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:13:0) after 1m0s
[14:11:05.387] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:13:0)
[14:11:05.387] Timer tick, asking Buildbucket for the build status
[14:11:05.543] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:05.543] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:14:0) after 1m0s
[14:12:05.534] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:14:0)
[14:12:05.534] Timer tick, asking Buildbucket for the build status
[14:12:05.610] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:05.610] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:15:0) after 1m0s
[14:13:05.630] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:15:0)
[14:13:05.630] Timer tick, asking Buildbucket for the build status
[14:13:05.716] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:05.716] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:16:0) after 1m0s
[14:14:05.751] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:16:0)
[14:14:05.751] Timer tick, asking Buildbucket for the build status
[14:14:06.307] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:06.307] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:17:0) after 1m0s
[14:15:06.433] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:17:0)
[14:15:06.433] Timer tick, asking Buildbucket for the build status
[14:15:06.548] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:06.548] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:18:0) after 1m0s
[14:16:06.744] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:18:0)
[14:16:06.744] Timer tick, asking Buildbucket for the build status
[14:16:06.936] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:06.936] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:19:0) after 1m0s
[14:17:07.264] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:19:0)
[14:17:07.264] Timer tick, asking Buildbucket for the build status
[14:17:07.379] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:07.379] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:20:0) after 1m0s
[14:18:07.472] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:20:0)
[14:18:07.472] Timer tick, asking Buildbucket for the build status
[14:18:07.653] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:07.653] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:21:0) after 1m0s
[14:19:07.769] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:21:0)
[14:19:07.769] Timer tick, asking Buildbucket for the build status
[14:19:07.904] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:07.904] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:22:0) after 1m0s
[14:20:07.963] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:22:0)
[14:20:07.963] Timer tick, asking Buildbucket for the build status
[14:20:08.200] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:08.200] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:23:0) after 1m0s
[14:21:08.408] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:23:0)
[14:21:08.408] Timer tick, asking Buildbucket for the build status
[14:21:08.636] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:08.636] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:24:0) after 1m0s
[14:22:08.706] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:24:0)
[14:22:08.706] Timer tick, asking Buildbucket for the build status
[14:22:08.813] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:08.813] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:25:0) after 1m0s
[14:23:09.030] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:25:0)
[14:23:09.030] Timer tick, asking Buildbucket for the build status
[14:23:09.353] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:09.353] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:26:0) after 1m0s
[14:24:09.535] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:26:0)
[14:24:09.535] Timer tick, asking Buildbucket for the build status
[14:24:09.927] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:09.927] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:27:0) after 1m0s
[14:25:09.995] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:27:0)
[14:25:09.995] Timer tick, asking Buildbucket for the build status
[14:25:10.105] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:10.105] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:28:0) after 1m0s
[14:26:11.440] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:28:0)
[14:26:11.440] Timer tick, asking Buildbucket for the build status
[14:26:11.610] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:11.610] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:29:0) after 1m0s
[14:27:11.771] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:29:0)
[14:27:11.771] Timer tick, asking Buildbucket for the build status
[14:27:11.867] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:11.867] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:30:0) after 1m0s
[14:28:12.191] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:30:0)
[14:28:12.191] Timer tick, asking Buildbucket for the build status
[14:28:12.270] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:12.270] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:31:0) after 1m0s
[14:29:12.499] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:31:0)
[14:29:12.499] Timer tick, asking Buildbucket for the build status
[14:29:12.926] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:12.926] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:32:0) after 1m0s
[14:30:13.019] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:32:0)
[14:30:13.019] Timer tick, asking Buildbucket for the build status
[14:30:13.132] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:13.132] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:33:0) after 1m0s
[14:31:13.295] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:33:0)
[14:31:13.295] Timer tick, asking Buildbucket for the build status
[14:31:13.836] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:13.836] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:34:0) after 1m0s
[14:32:13.965] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:34:0)
[14:32:13.965] Timer tick, asking Buildbucket for the build status
[14:32:14.042] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:14.042] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:35:0) after 1m0s
[14:33:14.196] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:35:0)
[14:33:14.196] Timer tick, asking Buildbucket for the build status
[14:33:14.278] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:14.278] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:36:0) after 1m0s
[14:34:14.347] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:36:0)
[14:34:14.347] Timer tick, asking Buildbucket for the build status
[14:34:14.465] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:14.465] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:37:0) after 1m0s
[14:35:14.491] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:37:0)
[14:35:14.491] Timer tick, asking Buildbucket for the build status
[14:35:14.589] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:14.589] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:38:0) after 1m0s
[14:36:14.635] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:38:0)
[14:36:14.635] Timer tick, asking Buildbucket for the build status
[14:36:14.713] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:14.713] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:39:0) after 1m0s
[14:37:14.736] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:39:0)
[14:37:14.736] Timer tick, asking Buildbucket for the build status
[14:37:15.216] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:15.216] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:40:0) after 1m0s
[14:38:15.269] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:40:0)
[14:38:15.269] Timer tick, asking Buildbucket for the build status
[14:38:15.359] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:15.359] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:41:0) after 1m0s
[14:39:15.527] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:41:0)
[14:39:15.527] Timer tick, asking Buildbucket for the build status
[14:39:16.303] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:16.303] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:42:0) after 1m0s
[14:40:16.384] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:42:0)
[14:40:16.384] Timer tick, asking Buildbucket for the build status
[14:40:16.500] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:16.500] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:43:0) after 1m0s
[14:41:16.543] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:43:0)
[14:41:16.543] Timer tick, asking Buildbucket for the build status
[14:41:16.653] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:16.653] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:44:0) after 1m0s
[14:42:16.703] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:44:0)
[14:42:16.703] Timer tick, asking Buildbucket for the build status
[14:42:16.881] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:16.881] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:45:0) after 1m0s
[14:43:16.937] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:45:0)
[14:43:16.937] Timer tick, asking Buildbucket for the build status
[14:43:17.012] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:17.013] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:46:0) after 1m0s
[14:44:17.086] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:46:0)
[14:44:17.086] Timer tick, asking Buildbucket for the build status
[14:44:17.640] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:17.640] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:47:0) after 1m0s
[14:45:17.787] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:47:0)
[14:45:17.787] Timer tick, asking Buildbucket for the build status
[14:45:17.962] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:17.962] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:48:0) after 1m0s
[14:46:18.291] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:48:0)
[14:46:18.291] Timer tick, asking Buildbucket for the build status
[14:46:18.420] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:18.420] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:49:0) after 1m0s
[14:47:18.899] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:49:0)
[14:47:18.899] Timer tick, asking Buildbucket for the build status
[14:47:19.051] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:19.051] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:50:0) after 1m0s
[14:48:19.212] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:50:0)
[14:48:19.212] Timer tick, asking Buildbucket for the build status
[14:48:19.489] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:19.489] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:51:0) after 1m0s
[14:49:19.728] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:51:0)
[14:49:19.728] Timer tick, asking Buildbucket for the build status
[14:49:19.808] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:19.808] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:52:0) after 1m0s
[14:50:19.943] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:52:0)
[14:50:19.943] Timer tick, asking Buildbucket for the build status
[14:50:20.104] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:20.104] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:53:0) after 1m0s
[14:51:20.227] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:53:0)
[14:51:20.227] Timer tick, asking Buildbucket for the build status
[14:51:20.306] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:20.306] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:54:0) after 1m0s
[14:52:20.698] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:54:0)
[14:52:20.698] Timer tick, asking Buildbucket for the build status
[14:52:20.762] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:20.762] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:55:0) after 1m0s
[14:53:20.923] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:55:0)
[14:53:20.923] Timer tick, asking Buildbucket for the build status
[14:53:20.992] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:20.992] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:56:0) after 1m0s
[14:54:21.091] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:56:0)
[14:54:21.091] Timer tick, asking Buildbucket for the build status
[14:54:21.247] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:21.247] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:57:0) after 1m0s
[14:55:21.325] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:57:0)
[14:55:21.325] Timer tick, asking Buildbucket for the build status
[14:55:21.419] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:21.419] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:58:0) after 1m0s
[14:56:21.553] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:58:0)
[14:56:21.553] Timer tick, asking Buildbucket for the build status
[14:56:21.621] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:21.621] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:59:0) after 1m0s
[14:57:21.838] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:59:0)
[14:57:21.838] Timer tick, asking Buildbucket for the build status
[14:57:21.905] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:21.905] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:60:0) after 1m0s
[14:58:22.206] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:60:0)
[14:58:22.206] Timer tick, asking Buildbucket for the build status
[14:58:22.291] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:22.291] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:61:0) after 1m0s
[14:59:22.561] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:61:0)
[14:59:22.561] Timer tick, asking Buildbucket for the build status
[14:59:22.644] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:22.644] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:62:0) after 1m0s
[15:00:22.772] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:62:0)
[15:00:22.772] Timer tick, asking Buildbucket for the build status
[15:00:22.922] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:22.922] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:63:0) after 1m0s
[15:01:22.960] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:63:0)
[15:01:22.960] Timer tick, asking Buildbucket for the build status
[15:01:23.082] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:23.082] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:64:0) after 1m0s
[15:02:23.180] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:64:0)
[15:02:23.180] Timer tick, asking Buildbucket for the build status
[15:02:23.496] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:23.496] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:65:0) after 1m0s
[15:03:23.585] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:65:0)
[15:03:23.585] Timer tick, asking Buildbucket for the build status
[15:03:23.673] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:23.673] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:66:0) after 1m0s
[15:04:23.696] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:66:0)
[15:04:23.696] Timer tick, asking Buildbucket for the build status
[15:04:23.912] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:23.912] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:67:0) after 1m0s
[15:05:23.939] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:67:0)
[15:05:23.939] Timer tick, asking Buildbucket for the build status
[15:05:24.033] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:24.033] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:68:0) after 1m0s
[15:06:24.043] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:68:0)
[15:06:24.043] Timer tick, asking Buildbucket for the build status
[15:06:24.400] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:24.400] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:69:0) after 1m0s
[15:07:24.401] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:69:0)
[15:07:24.401] Timer tick, asking Buildbucket for the build status
[15:07:24.480] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:24.480] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:70:0) after 1m0s
[15:08:24.507] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:70:0)
[15:08:24.507] Timer tick, asking Buildbucket for the build status
[15:08:24.885] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:24.885] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:71:0) after 1m0s
[15:09:24.955] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:71:0)
[15:09:24.955] Timer tick, asking Buildbucket for the build status
[15:09:25.035] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:25.035] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:72:0) after 1m0s
[15:10:25.130] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:72:0)
[15:10:25.130] Timer tick, asking Buildbucket for the build status
[15:10:25.312] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:25.312] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:73:0) after 1m0s
[15:11:25.777] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:73:0)
[15:11:25.777] Timer tick, asking Buildbucket for the build status
[15:11:25.955] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:25.955] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:74:0) after 1m0s
[15:12:26.282] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:74:0)
[15:12:26.282] Timer tick, asking Buildbucket for the build status
[15:12:26.360] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:26.360] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:75:0) after 1m0s
[15:13:26.843] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:75:0)
[15:13:26.843] Timer tick, asking Buildbucket for the build status
[15:13:26.930] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:26.930] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:76:0) after 1m0s
[15:14:27.190] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:76:0)
[15:14:27.190] Timer tick, asking Buildbucket for the build status
[15:14:27.344] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:27.344] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:77:0) after 1m0s
[15:15:27.447] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:77:0)
[15:15:27.447] Timer tick, asking Buildbucket for the build status
[15:15:27.537] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:27.537] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:78:0) after 1m0s
[15:16:27.713] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:78:0)
[15:16:27.713] Timer tick, asking Buildbucket for the build status
[15:16:27.772] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:27.772] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:79:0) after 1m0s
[15:17:27.875] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:79:0)
[15:17:27.875] Timer tick, asking Buildbucket for the build status
[15:17:27.963] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:27.963] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:80:0) after 1m0s
[15:18:28.145] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:80:0)
[15:18:28.145] Timer tick, asking Buildbucket for the build status
[15:18:28.254] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:28.254] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:81:0) after 1m0s
[15:19:28.414] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:81:0)
[15:19:28.414] Timer tick, asking Buildbucket for the build status
[15:19:28.482] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:28.482] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:82:0) after 1m0s
[15:20:28.470] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:82:0)
[15:20:28.470] Timer tick, asking Buildbucket for the build status
[15:20:28.562] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:28.562] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:83:0) after 1m0s
[15:21:28.546] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:83:0)
[15:21:28.546] Timer tick, asking Buildbucket for the build status
[15:21:28.700] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:28.700] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:84:0) after 1m0s
[15:22:28.732] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:84:0)
[15:22:28.732] Timer tick, asking Buildbucket for the build status
[15:22:28.830] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:28.830] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:85:0) after 1m0s
[15:23:28.876] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:85:0)
[15:23:28.876] Timer tick, asking Buildbucket for the build status
[15:23:28.952] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:28.953] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:86:0) after 1m0s
[15:24:28.964] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:86:0)
[15:24:28.964] Timer tick, asking Buildbucket for the build status
[15:24:29.049] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:29.049] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:87:0) after 1m0s
[15:25:29.157] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:87:0)
[15:25:29.157] Timer tick, asking Buildbucket for the build status
[15:25:29.314] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:29.314] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:88:0) after 1m0s
[15:26:29.390] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:88:0)
[15:26:29.390] Timer tick, asking Buildbucket for the build status
[15:26:29.581] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:29.581] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:89:0) after 1m0s
[15:27:29.637] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:89:0)
[15:27:29.637] Timer tick, asking Buildbucket for the build status
[15:27:29.730] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:29.730] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:90:0) after 1m0s
[15:28:29.746] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:90:0)
[15:28:29.746] Timer tick, asking Buildbucket for the build status
[15:28:29.882] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:29.882] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:91:0) after 1m0s
[15:29:29.917] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:91:0)
[15:29:29.917] Timer tick, asking Buildbucket for the build status
[15:29:30.126] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:30.126] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:92:0) after 1m0s
[15:30:30.203] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:92:0)
[15:30:30.203] Timer tick, asking Buildbucket for the build status
[15:30:30.576] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:30.576] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:93:0) after 1m0s
[15:31:30.580] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:93:0)
[15:31:30.580] Timer tick, asking Buildbucket for the build status
[15:31:30.735] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:30.735] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:94:0) after 1m0s
[15:32:30.737] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:94:0)
[15:32:30.738] Timer tick, asking Buildbucket for the build status
[15:32:30.994] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:30.994] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:95:0) after 1m0s
[15:33:31.034] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:95:0)
[15:33:31.034] Timer tick, asking Buildbucket for the build status
[15:33:31.126] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:31.126] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:96:0) after 1m0s
[15:34:31.175] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:96:0)
[15:34:31.175] Timer tick, asking Buildbucket for the build status
[15:34:31.416] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:31.416] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:97:0) after 1m0s
[15:35:31.460] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:97:0)
[15:35:31.460] Timer tick, asking Buildbucket for the build status
[15:35:31.547] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:31.547] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:98:0) after 1m0s
[15:36:31.553] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:98:0)
[15:36:31.554] Timer tick, asking Buildbucket for the build status
[15:36:31.620] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:31.620] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:99:0) after 1m0s
[15:37:31.685] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:99:0)
[15:37:31.685] Timer tick, asking Buildbucket for the build status
[15:37:32.168] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:32.168] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:100:0) after 1m0s
[15:38:32.210] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:100:0)
[15:38:32.210] Timer tick, asking Buildbucket for the build status
[15:38:32.278] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:32.278] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:101:0) after 1m0s
[15:39:32.306] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:101:0)
[15:39:32.306] Timer tick, asking Buildbucket for the build status
[15:39:32.384] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:32.384] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:102:0) after 1m0s
[15:40:32.407] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:102:0)
[15:40:32.407] Timer tick, asking Buildbucket for the build status
[15:40:32.630] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:32.630] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:103:0) after 1m0s
[15:41:32.732] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:103:0)
[15:41:32.732] Timer tick, asking Buildbucket for the build status
[15:41:32.968] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:32.968] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:104:0) after 1m0s
[15:42:33.031] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:104:0)
[15:42:33.031] Timer tick, asking Buildbucket for the build status
[15:42:33.108] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:33.108] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:105:0) after 1m0s
[15:43:33.138] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:105:0)
[15:43:33.138] Timer tick, asking Buildbucket for the build status
[15:43:33.368] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:33.368] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:106:0) after 1m0s
[15:44:33.429] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:106:0)
[15:44:33.430] Timer tick, asking Buildbucket for the build status
[15:44:33.505] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:33.505] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:107:0) after 1m0s
[15:45:33.551] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:107:0)
[15:45:33.551] Timer tick, asking Buildbucket for the build status
[15:45:33.803] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:33.803] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:108:0) after 1m0s
[15:46:33.877] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:108:0)
[15:46:33.877] Timer tick, asking Buildbucket for the build status
[15:46:33.964] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:33.964] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:109:0) after 1m0s
[15:47:33.997] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:109:0)
[15:47:33.997] Timer tick, asking Buildbucket for the build status
[15:47:34.072] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:34.072] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:110:0) after 1m0s
[15:48:34.100] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:110:0)
[15:48:34.100] Timer tick, asking Buildbucket for the build status
[15:48:34.586] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:34.586] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:111:0) after 1m0s
[15:49:34.674] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:111:0)
[15:49:34.674] Timer tick, asking Buildbucket for the build status
[15:49:34.748] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:34.748] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:112:0) after 1m0s
[15:50:34.780] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:112:0)
[15:50:34.780] Timer tick, asking Buildbucket for the build status
[15:50:34.871] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:34.871] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:113:0) after 1m0s
[15:51:34.885] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:113:0)
[15:51:34.885] Timer tick, asking Buildbucket for the build status
[15:51:34.961] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:34.961] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:114:0) after 1m0s
[15:52:35.014] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:114:0)
[15:52:35.015] Timer tick, asking Buildbucket for the build status
[15:52:35.098] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:35.098] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:115:0) after 1m0s
[15:53:35.141] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:115:0)
[15:53:35.141] Timer tick, asking Buildbucket for the build status
[15:53:35.286] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:35.286] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:116:0) after 1m0s
[15:54:35.306] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:116:0)
[15:54:35.306] Timer tick, asking Buildbucket for the build status
[15:54:35.499] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:35.499] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:117:0) after 1m0s
[15:55:35.553] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:117:0)
[15:55:35.553] Timer tick, asking Buildbucket for the build status
[15:55:35.833] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:35.833] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:118:0) after 1m0s
[15:56:35.870] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:118:0)
[15:56:35.870] Timer tick, asking Buildbucket for the build status
[15:56:35.941] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:35.941] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:119:0) after 1m0s
[15:57:35.925] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:119:0)
[15:57:35.925] Timer tick, asking Buildbucket for the build status
[15:57:36.230] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:36.230] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:120:0) after 1m0s
[15:58:36.229] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:120:0)
[15:58:36.229] Timer tick, asking Buildbucket for the build status
[15:58:36.333] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:36.333] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:121:0) after 1m0s
[15:59:36.390] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:121:0)
[15:59:36.390] Timer tick, asking Buildbucket for the build status
[15:59:36.626] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:36.626] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:122:0) after 1m0s
[16:00:36.656] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:122:0)
[16:00:36.656] Timer tick, asking Buildbucket for the build status
[16:00:36.740] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:36.740] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:123:0) after 1m0s
[16:01:36.781] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:123:0)
[16:01:36.781] Timer tick, asking Buildbucket for the build status
[16:01:36.868] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:36.868] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:124:0) after 1m0s
[16:02:36.924] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:124:0)
[16:02:36.924] Timer tick, asking Buildbucket for the build status
[16:02:37.001] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:37.001] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:125:0) after 1m0s
[16:03:37.064] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:125:0)
[16:03:37.064] Timer tick, asking Buildbucket for the build status
[16:03:37.137] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:37.137] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:126:0) after 1m0s
[16:04:37.173] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:126:0)
[16:04:37.173] Timer tick, asking Buildbucket for the build status
[16:04:37.286] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:37.286] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:127:0) after 1m0s
[16:05:37.350] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:127:0)
[16:05:37.350] Timer tick, asking Buildbucket for the build status
[16:05:37.508] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:37.508] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:128:0) after 1m0s
[16:06:37.678] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:128:0)
[16:06:37.678] Timer tick, asking Buildbucket for the build status
[16:06:38.378] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:38.378] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:129:0) after 1m0s
[16:07:38.502] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:129:0)
[16:07:38.502] Timer tick, asking Buildbucket for the build status
[16:07:38.638] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:38.638] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:130:0) after 1m0s
[16:08:38.668] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:130:0)
[16:08:38.668] Timer tick, asking Buildbucket for the build status
[16:08:38.745] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:38.745] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:131:0) after 1m0s
[16:09:38.940] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:131:0)
[16:09:38.940] Timer tick, asking Buildbucket for the build status
[16:09:39.008] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:39.008] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:132:0) after 1m0s
[16:10:39.100] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:132:0)
[16:10:39.100] Timer tick, asking Buildbucket for the build status
[16:10:39.525] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:39.525] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:133:0) after 1m0s
[16:11:39.562] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:133:0)
[16:11:39.562] Timer tick, asking Buildbucket for the build status
[16:11:41.054] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:41.054] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:134:0) after 1m0s
[16:12:41.077] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:134:0)
[16:12:41.077] Timer tick, asking Buildbucket for the build status
[16:12:41.153] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:41.153] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:135:0) after 1m0s
[16:13:41.219] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:135:0)
[16:13:41.219] Timer tick, asking Buildbucket for the build status
[16:13:41.456] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:41.456] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:136:0) after 1m0s
[16:14:41.517] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:136:0)
[16:14:41.517] Timer tick, asking Buildbucket for the build status
[16:14:41.622] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:41.622] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:137:0) after 1m0s
[16:15:41.628] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:137:0)
[16:15:41.628] Timer tick, asking Buildbucket for the build status
[16:15:41.720] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:41.720] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:138:0) after 1m0s
[16:16:41.749] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:138:0)
[16:16:41.749] Timer tick, asking Buildbucket for the build status
[16:16:41.840] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:41.840] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:139:0) after 1m0s
[16:17:41.915] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:139:0)
[16:17:41.915] Timer tick, asking Buildbucket for the build status
[16:17:42.806] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:42.806] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:140:0) after 1m0s
[16:18:42.856] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:140:0)
[16:18:42.856] Timer tick, asking Buildbucket for the build status
[16:18:42.942] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:42.942] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:141:0) after 1m0s
[16:19:42.970] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:141:0)
[16:19:42.970] Timer tick, asking Buildbucket for the build status
[16:19:43.047] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:43.047] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:142:0) after 1m0s
[16:20:43.100] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:142:0)
[16:20:43.100] Timer tick, asking Buildbucket for the build status
[16:20:43.266] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:43.266] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:143:0) after 1m0s
[16:21:43.328] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:143:0)
[16:21:43.328] Timer tick, asking Buildbucket for the build status
[16:21:43.433] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:43.433] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:144:0) after 1m0s
[16:22:43.481] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:144:0)
[16:22:43.481] Timer tick, asking Buildbucket for the build status
[16:22:43.691] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:43.691] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:145:0) after 1m0s
[16:23:43.785] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:145:0)
[16:23:43.785] Timer tick, asking Buildbucket for the build status
[16:23:43.890] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:43.890] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:146:0) after 1m0s
[16:24:43.892] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:146:0)
[16:24:43.892] Timer tick, asking Buildbucket for the build status
[16:24:43.969] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:43.969] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:147:0) after 1m0s
[16:25:44.016] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:147:0)
[16:25:44.016] Timer tick, asking Buildbucket for the build status
[16:25:44.172] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:44.172] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:148:0) after 1m0s
[16:26:44.177] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:148:0)
[16:26:44.177] Timer tick, asking Buildbucket for the build status
[16:26:44.454] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:44.454] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:149:0) after 1m0s
[16:27:44.476] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:149:0)
[16:27:44.476] Timer tick, asking Buildbucket for the build status
[16:27:44.564] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:44.564] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:150:0) after 1m0s
[16:28:44.648] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:150:0)
[16:28:44.648] Timer tick, asking Buildbucket for the build status
[16:28:44.746] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:44.746] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:151:0) after 1m0s
[16:29:44.799] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:151:0)
[16:29:44.799] Timer tick, asking Buildbucket for the build status
[16:29:44.862] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:44.862] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:152:0) after 1m0s
[16:30:44.886] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:152:0)
[16:30:44.886] Timer tick, asking Buildbucket for the build status
[16:30:45.209] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:45.209] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:153:0) after 1m0s
[16:31:48.221] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:153:0)
[16:31:48.221] Timer tick, asking Buildbucket for the build status
[16:31:48.491] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:48.491] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:154:0) after 1m0s
[16:32:48.585] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:154:0)
[16:32:48.585] Timer tick, asking Buildbucket for the build status
[16:32:48.715] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:48.715] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:155:0) after 1m0s
[16:33:48.785] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:155:0)
[16:33:48.785] Timer tick, asking Buildbucket for the build status
[16:33:48.933] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:48.933] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:156:0) after 1m0s
[16:34:48.995] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:156:0)
[16:34:48.995] Timer tick, asking Buildbucket for the build status
[16:34:49.056] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:49.056] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:157:0) after 1m0s
[16:35:49.122] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:157:0)
[16:35:49.122] Timer tick, asking Buildbucket for the build status
[16:35:49.254] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:49.254] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:158:0) after 1m0s
[16:36:49.336] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:158:0)
[16:36:49.336] Timer tick, asking Buildbucket for the build status
[16:36:49.418] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:49.418] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:159:0) after 1m0s
[16:37:49.463] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:159:0)
[16:37:49.463] Timer tick, asking Buildbucket for the build status
[16:37:49.563] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:49.563] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:160:0) after 1m0s
[16:38:54.261] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:160:0)
[16:38:54.261] Timer tick, asking Buildbucket for the build status
[16:38:54.432] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:54.432] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:161:0) after 1m0s
[16:39:54.504] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:161:0)
[16:39:54.504] Timer tick, asking Buildbucket for the build status
[16:39:54.568] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:54.568] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:162:0) after 1m0s
[16:40:54.622] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:162:0)
[16:40:54.622] Timer tick, asking Buildbucket for the build status
[16:40:54.713] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:54.713] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:163:0) after 1m0s
[16:41:54.831] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:163:0)
[16:41:54.831] Timer tick, asking Buildbucket for the build status
[16:41:55.109] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:55.109] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:164:0) after 1m0s
[16:42:55.174] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:164:0)
[16:42:55.174] Timer tick, asking Buildbucket for the build status
[16:42:55.316] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:55.316] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:165:0) after 1m0s
[16:43:55.346] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:165:0)
[16:43:55.346] Timer tick, asking Buildbucket for the build status
[16:43:55.418] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:55.418] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:166:0) after 1m0s
[16:44:55.494] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:166:0)
[16:44:55.494] Timer tick, asking Buildbucket for the build status
[16:44:55.561] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:55.561] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:167:0) after 1m0s
[16:45:55.548] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:167:0)
[16:45:55.548] Timer tick, asking Buildbucket for the build status
[16:45:55.649] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:55.649] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:168:0) after 1m0s
[16:46:55.670] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:168:0)
[16:46:55.670] Timer tick, asking Buildbucket for the build status
[16:46:55.881] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:55.881] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:169:0) after 1m0s
[16:47:55.955] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:169:0)
[16:47:55.955] Timer tick, asking Buildbucket for the build status
[16:47:56.029] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:56.029] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:170:0) after 1m0s
[16:48:56.150] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:170:0)
[16:48:56.150] Timer tick, asking Buildbucket for the build status
[16:48:56.227] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:56.227] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:171:0) after 1m0s
[16:49:56.253] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:171:0)
[16:49:56.253] Timer tick, asking Buildbucket for the build status
[16:49:56.398] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:56.398] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:172:0) after 1m0s
[16:50:56.402] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:172:0)
[16:50:56.402] Timer tick, asking Buildbucket for the build status
[16:50:56.521] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:56.521] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:173:0) after 1m0s
[16:51:56.546] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:173:0)
[16:51:56.546] Timer tick, asking Buildbucket for the build status
[16:51:56.636] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:56.636] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:174:0) after 1m0s
[16:52:56.683] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:174:0)
[16:52:56.683] Timer tick, asking Buildbucket for the build status
[16:52:56.749] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:56.749] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:175:0) after 1m0s
[16:53:56.829] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:175:0)
[16:53:56.829] Timer tick, asking Buildbucket for the build status
[16:53:56.897] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:56.897] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:176:0) after 1m0s
[16:54:56.954] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:176:0)
[16:54:56.954] Timer tick, asking Buildbucket for the build status
[16:54:57.026] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:57.026] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:177:0) after 1m0s
[16:55:57.082] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:177:0)
[16:55:57.082] Timer tick, asking Buildbucket for the build status
[16:55:57.308] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:57.308] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:178:0) after 1m0s
[16:56:57.421] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:178:0)
[16:56:57.421] Timer tick, asking Buildbucket for the build status
[16:56:57.519] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:57.519] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:179:0) after 1m0s
[16:57:57.517] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:179:0)
[16:57:57.517] Timer tick, asking Buildbucket for the build status
[16:57:57.587] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:57.587] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:180:0) after 1m0s
[16:58:57.630] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:180:0)
[16:58:57.630] Timer tick, asking Buildbucket for the build status
[16:58:57.710] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:57.710] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:181:0) after 1m0s
[16:59:57.776] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:181:0)
[16:59:57.776] Timer tick, asking Buildbucket for the build status
[16:59:57.856] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:57.856] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:182:0) after 1m0s
[17:00:57.901] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:182:0)
[17:00:57.901] Timer tick, asking Buildbucket for the build status
[17:00:58.667] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:58.667] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:183:0) after 1m0s
[17:01:58.752] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:183:0)
[17:01:58.752] Timer tick, asking Buildbucket for the build status
[17:01:58.842] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:58.842] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:184:0) after 1m0s
[17:02:58.914] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:184:0)
[17:02:58.914] Timer tick, asking Buildbucket for the build status
[17:02:58.985] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:58.985] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:185:0) after 1m0s
[17:03:59.061] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:185:0)
[17:03:59.061] Timer tick, asking Buildbucket for the build status
[17:03:59.165] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:59.165] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:186:0) after 1m0s
[17:04:59.262] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:186:0)
[17:04:59.262] Timer tick, asking Buildbucket for the build status
[17:04:59.366] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:59.366] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:187:0) after 1m0s
[17:06:05.741] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:187:0)
[17:06:05.741] Timer tick, asking Buildbucket for the build status
[17:06:05.994] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:05.994] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:188:0) after 1m0s
[17:07:06.058] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:188:0)
[17:07:06.058] Timer tick, asking Buildbucket for the build status
[17:07:06.298] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:06.298] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:189:0) after 1m0s
[17:08:06.338] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:189:0)
[17:08:06.338] Timer tick, asking Buildbucket for the build status
[17:08:06.406] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:06.406] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:190:0) after 1m0s
[17:09:06.461] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:190:0)
[17:09:06.461] Timer tick, asking Buildbucket for the build status
[17:09:06.541] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:06.541] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:191:0) after 1m0s
[17:10:06.552] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:191:0)
[17:10:06.552] Timer tick, asking Buildbucket for the build status
[17:10:06.679] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:06.679] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:192:0) after 1m0s
[17:11:06.971] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:192:0)
[17:11:06.971] Timer tick, asking Buildbucket for the build status
[17:11:07.885] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:07.885] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:193:0) after 1m0s
[17:12:07.939] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:193:0)
[17:12:07.939] Timer tick, asking Buildbucket for the build status
[17:12:08.196] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:08.196] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:194:0) after 1m0s
[17:13:08.295] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:194:0)
[17:13:08.295] Timer tick, asking Buildbucket for the build status
[17:13:08.994] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:08.994] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:195:0) after 1m0s
[17:14:09.013] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:195:0)
[17:14:09.013] Timer tick, asking Buildbucket for the build status
[17:14:10.670] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:10.670] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:196:0) after 1m0s
[17:15:10.825] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:196:0)
[17:15:10.825] Timer tick, asking Buildbucket for the build status
[17:15:10.892] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:10.892] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:197:0) after 1m0s
[17:16:10.993] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:197:0)
[17:16:10.993] Timer tick, asking Buildbucket for the build status
[17:16:11.089] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:11.089] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:198:0) after 1m0s
[17:17:11.149] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:198:0)
[17:17:11.149] Timer tick, asking Buildbucket for the build status
[17:17:11.215] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:11.215] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:199:0) after 1m0s
[17:18:11.294] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:199:0)
[17:18:11.294] Timer tick, asking Buildbucket for the build status
[17:18:11.623] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:11.623] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:200:0) after 1m0s
[17:19:11.647] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:200:0)
[17:19:11.647] Timer tick, asking Buildbucket for the build status
[17:19:11.714] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:11.714] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:201:0) after 1m0s
[17:20:11.765] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:201:0)
[17:20:11.765] Timer tick, asking Buildbucket for the build status
[17:20:11.961] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:11.961] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:202:0) after 1m0s
[17:21:12.113] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:202:0)
[17:21:12.113] Timer tick, asking Buildbucket for the build status
[17:21:12.184] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:12.184] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:203:0) after 1m0s
[17:22:12.191] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:203:0)
[17:22:12.191] Timer tick, asking Buildbucket for the build status
[17:22:12.259] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:12.259] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:204:0) after 1m0s
[17:23:12.379] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:204:0)
[17:23:12.379] Timer tick, asking Buildbucket for the build status
[17:23:12.476] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:12.476] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:205:0) after 1m0s
[17:24:12.523] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:205:0)
[17:24:12.523] Timer tick, asking Buildbucket for the build status
[17:24:12.614] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:12.614] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:206:0) after 1m0s
[17:25:12.658] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:206:0)
[17:25:12.658] Timer tick, asking Buildbucket for the build status
[17:25:12.782] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:12.782] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:207:0) after 1m0s
[17:26:12.855] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:207:0)
[17:26:12.855] Timer tick, asking Buildbucket for the build status
[17:26:12.967] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:12.967] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:208:0) after 1m0s
[17:27:12.967] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:208:0)
[17:27:12.967] Timer tick, asking Buildbucket for the build status
[17:27:13.075] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:13.076] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:209:0) after 1m0s
[17:28:15.908] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:209:0)
[17:28:15.908] Timer tick, asking Buildbucket for the build status
[17:28:15.991] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:15.991] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:210:0) after 1m0s
[17:29:16.199] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:210:0)
[17:29:16.199] Timer tick, asking Buildbucket for the build status
[17:29:16.277] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:16.277] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:211:0) after 1m0s
[17:30:16.741] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:211:0)
[17:30:16.741] Timer tick, asking Buildbucket for the build status
[17:30:16.844] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:16.844] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:212:0) after 1m0s
[17:31:16.845] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:212:0)
[17:31:16.845] Timer tick, asking Buildbucket for the build status
[17:31:16.941] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:16.941] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:213:0) after 1m0s
[17:32:17.005] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:213:0)
[17:32:17.005] Timer tick, asking Buildbucket for the build status
[17:32:17.498] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:17.498] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:214:0) after 1m0s
[17:33:17.485] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:214:0)
[17:33:17.485] Timer tick, asking Buildbucket for the build status
[17:33:17.732] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:17.732] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:215:0) after 1m0s
[17:34:17.782] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:215:0)
[17:34:17.782] Timer tick, asking Buildbucket for the build status
[17:34:17.877] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:17.877] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:216:0) after 1m0s
[17:35:17.912] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:216:0)
[17:35:17.912] Timer tick, asking Buildbucket for the build status
[17:35:18.026] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:18.026] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:217:0) after 1m0s
[17:36:18.016] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:217:0)
[17:36:18.016] Timer tick, asking Buildbucket for the build status
[17:36:18.358] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:18.358] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:218:0) after 1m0s
[17:37:18.398] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:218:0)
[17:37:18.398] Timer tick, asking Buildbucket for the build status
[17:37:18.473] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:18.473] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:219:0) after 1m0s
[17:38:18.476] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:219:0)
[17:38:18.476] Timer tick, asking Buildbucket for the build status
[17:38:18.556] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:18.556] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:220:0) after 1m0s
[17:39:18.583] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:220:0)
[17:39:18.583] Timer tick, asking Buildbucket for the build status
[17:39:18.667] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:18.668] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:221:0) after 1m0s
[17:40:18.685] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:221:0)
[17:40:18.685] Timer tick, asking Buildbucket for the build status
[17:40:18.803] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:18.803] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:222:0) after 1m0s
[17:41:18.889] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:222:0)
[17:41:18.889] Timer tick, asking Buildbucket for the build status
[17:41:18.995] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:18.995] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:223:0) after 1m0s
[17:42:19.037] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:223:0)
[17:42:19.037] Timer tick, asking Buildbucket for the build status
[17:42:19.119] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:19.119] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:224:0) after 1m0s
[17:43:19.180] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:224:0)
[17:43:19.180] Timer tick, asking Buildbucket for the build status
[17:43:19.268] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:19.268] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:225:0) after 1m0s
[17:44:19.423] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:225:0)
[17:44:19.423] Timer tick, asking Buildbucket for the build status
[17:44:19.888] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:19.888] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:226:0) after 1m0s
[17:45:19.876] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:226:0)
[17:45:19.876] Timer tick, asking Buildbucket for the build status
[17:45:20.013] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:20.013] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:227:0) after 1m0s
[17:46:20.035] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:227:0)
[17:46:20.035] Timer tick, asking Buildbucket for the build status
[17:46:20.129] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:20.129] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:228:0) after 1m0s
[17:47:20.193] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:228:0)
[17:47:20.193] Timer tick, asking Buildbucket for the build status
[17:47:20.278] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:20.278] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:229:0) after 1m0s
[17:48:20.351] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:229:0)
[17:48:20.351] Timer tick, asking Buildbucket for the build status
[17:48:20.424] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:20.424] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:230:0) after 1m0s
[17:49:20.439] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:230:0)
[17:49:20.439] Timer tick, asking Buildbucket for the build status
[17:49:20.510] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:20.510] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:231:0) after 1m0s
[17:50:20.498] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:231:0)
[17:50:20.498] Timer tick, asking Buildbucket for the build status
[17:50:20.593] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:20.593] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:232:0) after 1m0s
[17:51:20.672] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:232:0)
[17:51:20.672] Timer tick, asking Buildbucket for the build status
[17:51:20.919] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:20.919] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:233:0) after 1m0s
[17:52:21.001] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:233:0)
[17:52:21.001] Timer tick, asking Buildbucket for the build status
[17:52:21.071] Build 8854861325520967424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:21.071] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020291387872863904:234:0) after 1m0s
[17:52:35.924] Received PubSub notification, asking Buildbucket for the build status
[17:52:36.003] Build 8854861325520967424: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:52:36.003] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613757148981100",
"created_by": "project:chromium",
"created_ts": "1613743200719008",
"id": "8854861325520967424",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e58536e2b0a1756a7b9dab419b60b93eb6eea4c6\"}}",
"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\": \"e58536e2b0a1756a7b9dab419b60b93eb6eea4c6\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"win-dbg-9-wqii\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 1625, \"got_angle_revision\": \"fd132e4e7a9c84333b4fb4730f79367fe75f53e7\", \"got_dawn_revision\": \"0b17eb8e19c886680b12b73ba28de8d30adccda9\", \"got_nacl_revision\": \"4ad2ff292145e8613ec371302875f0eaf8b4fa14\", \"got_revision\": \"e58536e2b0a1756a7b9dab419b60b93eb6eea4c6\", \"got_revision_cp\": \"refs/heads/master@{#855684}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"8603b126b3d599f0ab8781163729fd226a93cf17\", \"got_v8_revision\": \"aaf128851c4dd86978eaf9d41ce297c5af31597f\", \"got_v8_revision_cp\": \"refs/heads/9.0.217@{#1}\", \"got_webrtc_revision\": \"735e33fae0a06ae05a9c0be6f5d8b06a6ad820a4\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33297}\", \"mirrored_builders\": [\"tryserver.chromium:win-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e58536e2b0a1756a7b9dab419b60b93eb6eea4c6\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_9b3ebe5fd1c5be87380c40d216747346a59b28cf26de183f0e8e2b32e944d3c8_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-9-wqii\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5706-397711c\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1613743205279647",
"status": "COMPLETED",
"status_changed_ts": "1613757149252258",
"tags": [
"build_address:luci.chromium.ci/win-official/1625",
"builder:win-official",
"buildset:commit/git/e58536e2b0a1756a7b9dab419b60b93eb6eea4c6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e58536e2b0a1756a7b9dab419b60b93eb6eea4c6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020291387872863904",
"scheduler_job_id:chromium/win-official",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8854861325520967424/+/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:51d368a5b30b1d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1613757149256378",
"url": "https://ci.chromium.org/b/8854861325520967424",
"utcnow_ts": "1613757155994933"
}
}
[17:52:36.003] Invocation finished in 3h52m36.910150556s with status SUCCEEDED