[18:56:58.821] New invocation is queued and will start shortly
[18:57:02.017] Starting the invocation (attempt 1)
[18:57:02.074] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:57:02.086] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:57:02.086] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9037123738312752096",
"parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"33555f9e56c8038ab49a38f98b8b3175b60b0857\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-official",
"scheduler_invocation_id:9037123738312752096",
"scheduler_job_id:chromium/win-official",
"user_agent:luci-scheduler",
"buildset:commit/git/33555f9e56c8038ab49a38f98b8b3175b60b0857",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/33555f9e56c8038ab49a38f98b8b3175b60b0857",
"gitiles_ref:refs/heads/master"
]
}
[18:57:03.759] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1597690622255724",
"id": "8871693674036477344",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"33555f9e56c8038ab49a38f98b8b3175b60b0857\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1597690623162242",
"tags": [
"build_address:luci.chromium.ci/win-official/368",
"builder:win-official",
"buildset:commit/git/33555f9e56c8038ab49a38f98b8b3175b60b0857",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/33555f9e56c8038ab49a38f98b8b3175b60b0857",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9037123738312752096",
"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/8871693674036477344/+/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": "1597690623162489",
"url": "https://ci.chromium.org/b/8871693674036477344",
"utcnow_ts": "1597690623658605"
}
}
[18:57:03.759] Task URL: https://ci.chromium.org/b/8871693674036477344
[18:57:03.759] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:2:0) after 1m0s
[18:57:05.865] Received PubSub notification, asking Buildbucket for the build status
[18:57:05.961] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:03.822] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:2:0)
[18:58:03.822] Timer tick, asking Buildbucket for the build status
[18:58:04.072] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:04.072] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:4:0) after 1m0s
[18:59:04.141] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:4:0)
[18:59:04.141] Timer tick, asking Buildbucket for the build status
[18:59:04.688] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:04.688] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:5:0) after 1m0s
[19:00:04.744] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:5:0)
[19:00:04.744] Timer tick, asking Buildbucket for the build status
[19:00:04.843] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:04.843] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:6:0) after 1m0s
[19:01:04.915] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:6:0)
[19:01:04.915] Timer tick, asking Buildbucket for the build status
[19:01:05.023] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:05.023] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:7:0) after 1m0s
[19:02:05.049] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:7:0)
[19:02:05.049] Timer tick, asking Buildbucket for the build status
[19:02:06.101] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:06.101] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:8:0) after 1m0s
[19:03:06.137] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:8:0)
[19:03:06.137] Timer tick, asking Buildbucket for the build status
[19:03:06.284] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:06.284] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:9:0) after 1m0s
[19:04:06.348] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:9:0)
[19:04:06.348] Timer tick, asking Buildbucket for the build status
[19:04:06.487] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:06.487] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:10:0) after 1m0s
[19:05:06.515] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:10:0)
[19:05:06.515] Timer tick, asking Buildbucket for the build status
[19:05:06.891] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:06.891] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:11:0) after 1m0s
[19:06:07.019] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:11:0)
[19:06:07.019] Timer tick, asking Buildbucket for the build status
[19:06:07.351] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:07.351] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:12:0) after 1m0s
[19:07:07.528] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:12:0)
[19:07:07.528] Timer tick, asking Buildbucket for the build status
[19:07:08.121] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:08.121] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:13:0) after 1m0s
[19:08:08.328] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:13:0)
[19:08:08.328] Timer tick, asking Buildbucket for the build status
[19:08:08.399] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:08.399] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:14:0) after 1m0s
[19:09:08.441] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:14:0)
[19:09:08.441] Timer tick, asking Buildbucket for the build status
[19:09:08.532] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:08.532] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:15:0) after 1m0s
[19:10:08.631] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:15:0)
[19:10:08.631] Timer tick, asking Buildbucket for the build status
[19:10:08.737] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:08.737] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:16:0) after 1m0s
[19:11:08.898] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:16:0)
[19:11:08.898] Timer tick, asking Buildbucket for the build status
[19:11:09.014] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:09.014] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:17:0) after 1m0s
[19:12:09.091] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:17:0)
[19:12:09.091] Timer tick, asking Buildbucket for the build status
[19:12:09.279] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:09.279] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:18:0) after 1m0s
[19:13:09.380] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:18:0)
[19:13:09.380] Timer tick, asking Buildbucket for the build status
[19:13:09.455] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:09.455] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:19:0) after 1m0s
[19:14:09.535] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:19:0)
[19:14:09.535] Timer tick, asking Buildbucket for the build status
[19:14:10.042] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:10.042] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:20:0) after 1m0s
[19:15:10.181] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:20:0)
[19:15:10.181] Timer tick, asking Buildbucket for the build status
[19:15:10.295] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:10.295] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:21:0) after 1m0s
[19:16:10.345] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:21:0)
[19:16:10.345] Timer tick, asking Buildbucket for the build status
[19:16:10.444] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:10.444] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:22:0) after 1m0s
[19:17:10.482] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:22:0)
[19:17:10.482] Timer tick, asking Buildbucket for the build status
[19:17:12.056] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:12.056] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:23:0) after 1m0s
[19:18:12.133] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:23:0)
[19:18:12.133] Timer tick, asking Buildbucket for the build status
[19:18:12.249] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:12.249] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:24:0) after 1m0s
[19:19:12.263] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:24:0)
[19:19:12.263] Timer tick, asking Buildbucket for the build status
[19:19:12.377] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:12.377] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:25:0) after 1m0s
[19:20:12.457] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:25:0)
[19:20:12.457] Timer tick, asking Buildbucket for the build status
[19:20:12.561] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:12.561] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:26:0) after 1m0s
[19:21:12.635] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:26:0)
[19:21:12.635] Timer tick, asking Buildbucket for the build status
[19:21:12.726] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:12.726] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:27:0) after 1m0s
[19:22:12.798] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:27:0)
[19:22:12.798] Timer tick, asking Buildbucket for the build status
[19:22:12.958] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:12.958] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:28:0) after 1m0s
[19:23:12.981] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:28:0)
[19:23:12.981] Timer tick, asking Buildbucket for the build status
[19:23:13.061] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:13.061] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:29:0) after 1m0s
[19:24:13.047] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:29:0)
[19:24:13.047] Timer tick, asking Buildbucket for the build status
[19:24:13.126] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:13.126] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:30:0) after 1m0s
[19:25:13.151] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:30:0)
[19:25:13.151] Timer tick, asking Buildbucket for the build status
[19:25:13.210] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:13.210] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:31:0) after 1m0s
[19:26:13.245] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:31:0)
[19:26:13.245] Timer tick, asking Buildbucket for the build status
[19:26:13.419] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:13.419] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:32:0) after 1m0s
[19:27:13.738] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:32:0)
[19:27:13.738] Timer tick, asking Buildbucket for the build status
[19:27:13.919] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:13.919] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:33:0) after 1m0s
[19:28:14.002] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:33:0)
[19:28:14.002] Timer tick, asking Buildbucket for the build status
[19:28:14.236] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:14.236] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:34:0) after 1m0s
[19:29:14.407] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:34:0)
[19:29:14.407] Timer tick, asking Buildbucket for the build status
[19:29:14.555] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:14.555] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:35:0) after 1m0s
[19:30:14.641] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:35:0)
[19:30:14.641] Timer tick, asking Buildbucket for the build status
[19:30:14.733] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:14.733] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:36:0) after 1m0s
[19:31:14.881] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:36:0)
[19:31:14.881] Timer tick, asking Buildbucket for the build status
[19:31:15.012] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:15.012] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:37:0) after 1m0s
[19:32:15.102] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:37:0)
[19:32:15.102] Timer tick, asking Buildbucket for the build status
[19:32:15.257] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:15.257] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:38:0) after 1m0s
[19:33:15.363] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:38:0)
[19:33:15.363] Timer tick, asking Buildbucket for the build status
[19:33:15.517] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:15.517] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:39:0) after 1m0s
[19:34:15.578] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:39:0)
[19:34:15.578] Timer tick, asking Buildbucket for the build status
[19:34:16.536] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:16.536] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:40:0) after 1m0s
[19:35:16.713] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:40:0)
[19:35:16.713] Timer tick, asking Buildbucket for the build status
[19:35:17.056] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:17.056] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:41:0) after 1m0s
[19:36:17.096] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:41:0)
[19:36:17.096] Timer tick, asking Buildbucket for the build status
[19:36:17.201] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:17.201] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:42:0) after 1m0s
[19:37:17.256] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:42:0)
[19:37:17.256] Timer tick, asking Buildbucket for the build status
[19:37:17.793] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:17.793] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:43:0) after 1m0s
[19:38:17.919] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:43:0)
[19:38:17.919] Timer tick, asking Buildbucket for the build status
[19:38:17.989] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:17.989] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:44:0) after 1m0s
[19:39:18.088] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:44:0)
[19:39:18.088] Timer tick, asking Buildbucket for the build status
[19:39:18.172] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:18.172] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:45:0) after 1m0s
[19:40:18.291] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:45:0)
[19:40:18.291] Timer tick, asking Buildbucket for the build status
[19:40:18.389] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:18.389] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:46:0) after 1m0s
[19:41:18.532] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:46:0)
[19:41:18.532] Timer tick, asking Buildbucket for the build status
[19:41:18.641] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:18.641] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:47:0) after 1m0s
[19:42:18.665] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:47:0)
[19:42:18.665] Timer tick, asking Buildbucket for the build status
[19:42:18.882] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:18.882] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:48:0) after 1m0s
[19:43:18.971] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:48:0)
[19:43:18.971] Timer tick, asking Buildbucket for the build status
[19:43:19.048] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:19.048] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:49:0) after 1m0s
[19:44:19.096] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:49:0)
[19:44:19.096] Timer tick, asking Buildbucket for the build status
[19:44:21.272] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:21.272] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:50:0) after 1m0s
[19:45:21.511] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:50:0)
[19:45:21.511] Timer tick, asking Buildbucket for the build status
[19:45:21.615] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:21.615] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:51:0) after 1m0s
[19:46:21.632] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:51:0)
[19:46:21.632] Timer tick, asking Buildbucket for the build status
[19:46:21.715] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:21.715] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:52:0) after 1m0s
[19:47:21.842] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:52:0)
[19:47:21.842] Timer tick, asking Buildbucket for the build status
[19:47:21.969] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:21.969] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:53:0) after 1m0s
[19:48:22.040] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:53:0)
[19:48:22.040] Timer tick, asking Buildbucket for the build status
[19:48:22.121] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:22.121] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:54:0) after 1m0s
[19:49:22.477] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:54:0)
[19:49:22.477] Timer tick, asking Buildbucket for the build status
[19:49:22.566] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:22.566] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:55:0) after 1m0s
[19:50:22.630] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:55:0)
[19:50:22.630] Timer tick, asking Buildbucket for the build status
[19:50:22.725] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:22.725] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:56:0) after 1m0s
[19:51:22.856] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:56:0)
[19:51:22.856] Timer tick, asking Buildbucket for the build status
[19:51:23.148] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:23.148] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:57:0) after 1m0s
[19:52:23.226] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:57:0)
[19:52:23.226] Timer tick, asking Buildbucket for the build status
[19:52:23.809] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:23.809] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:58:0) after 1m0s
[19:53:23.922] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:58:0)
[19:53:23.922] Timer tick, asking Buildbucket for the build status
[19:53:24.009] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:24.009] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:59:0) after 1m0s
[19:54:24.118] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:59:0)
[19:54:24.118] Timer tick, asking Buildbucket for the build status
[19:54:24.285] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:24.285] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:60:0) after 1m0s
[19:55:24.511] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:60:0)
[19:55:24.511] Timer tick, asking Buildbucket for the build status
[19:55:24.607] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:24.607] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:61:0) after 1m0s
[19:56:24.714] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:61:0)
[19:56:24.714] Timer tick, asking Buildbucket for the build status
[19:56:24.822] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:24.822] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:62:0) after 1m0s
[19:57:24.960] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:62:0)
[19:57:24.960] Timer tick, asking Buildbucket for the build status
[19:57:25.468] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:25.468] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:63:0) after 1m0s
[19:58:25.682] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:63:0)
[19:58:25.682] Timer tick, asking Buildbucket for the build status
[19:58:25.762] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:25.762] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:64:0) after 1m0s
[19:59:25.904] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:64:0)
[19:59:25.904] Timer tick, asking Buildbucket for the build status
[19:59:26.068] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:26.068] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:65:0) after 1m0s
[20:00:26.185] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:65:0)
[20:00:26.185] Timer tick, asking Buildbucket for the build status
[20:00:26.390] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:26.391] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:66:0) after 1m0s
[20:01:26.434] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:66:0)
[20:01:26.434] Timer tick, asking Buildbucket for the build status
[20:01:26.538] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:26.538] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:67:0) after 1m0s
[20:02:26.712] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:67:0)
[20:02:26.715] Timer tick, asking Buildbucket for the build status
[20:02:26.908] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:26.908] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:68:0) after 1m0s
[20:03:27.081] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:68:0)
[20:03:27.081] Timer tick, asking Buildbucket for the build status
[20:03:27.322] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:27.322] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:69:0) after 1m0s
[20:04:27.355] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:69:0)
[20:04:27.355] Timer tick, asking Buildbucket for the build status
[20:04:27.538] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:27.538] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:70:0) after 1m0s
[20:05:27.583] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:70:0)
[20:05:27.583] Timer tick, asking Buildbucket for the build status
[20:05:27.958] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:27.958] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:71:0) after 1m0s
[20:06:28.066] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:71:0)
[20:06:28.066] Timer tick, asking Buildbucket for the build status
[20:06:28.292] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:28.292] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:72:0) after 1m0s
[20:07:28.376] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:72:0)
[20:07:28.376] Timer tick, asking Buildbucket for the build status
[20:07:28.529] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:28.529] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:73:0) after 1m0s
[20:08:28.550] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:73:0)
[20:08:28.550] Timer tick, asking Buildbucket for the build status
[20:08:28.620] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:28.620] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:74:0) after 1m0s
[20:09:28.676] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:74:0)
[20:09:28.676] Timer tick, asking Buildbucket for the build status
[20:09:28.912] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:28.912] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:75:0) after 1m0s
[20:10:29.028] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:75:0)
[20:10:29.028] Timer tick, asking Buildbucket for the build status
[20:10:29.252] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:29.252] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:76:0) after 1m0s
[20:11:29.279] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:76:0)
[20:11:29.279] Timer tick, asking Buildbucket for the build status
[20:11:29.490] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:29.490] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:77:0) after 1m0s
[20:12:29.520] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:77:0)
[20:12:29.520] Timer tick, asking Buildbucket for the build status
[20:12:29.650] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:29.650] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:78:0) after 1m0s
[20:13:29.687] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:78:0)
[20:13:29.687] Timer tick, asking Buildbucket for the build status
[20:13:29.762] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:29.762] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:79:0) after 1m0s
[20:14:29.784] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:79:0)
[20:14:29.784] Timer tick, asking Buildbucket for the build status
[20:14:29.865] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:29.865] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:80:0) after 1m0s
[20:15:29.901] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:80:0)
[20:15:29.901] Timer tick, asking Buildbucket for the build status
[20:15:29.994] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:29.994] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:81:0) after 1m0s
[20:16:30.053] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:81:0)
[20:16:30.053] Timer tick, asking Buildbucket for the build status
[20:16:30.166] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:30.167] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:82:0) after 1m0s
[20:17:30.235] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:82:0)
[20:17:30.235] Timer tick, asking Buildbucket for the build status
[20:17:30.403] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:30.403] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:83:0) after 1m0s
[20:18:30.455] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:83:0)
[20:18:30.455] Timer tick, asking Buildbucket for the build status
[20:18:30.530] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:30.530] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:84:0) after 1m0s
[20:19:30.579] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:84:0)
[20:19:30.579] Timer tick, asking Buildbucket for the build status
[20:19:30.668] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:30.668] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:85:0) after 1m0s
[20:20:30.668] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:85:0)
[20:20:30.668] Timer tick, asking Buildbucket for the build status
[20:20:30.799] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:30.799] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:86:0) after 1m0s
[20:21:30.859] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:86:0)
[20:21:30.859] Timer tick, asking Buildbucket for the build status
[20:21:31.236] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:31.236] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:87:0) after 1m0s
[20:22:31.261] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:87:0)
[20:22:31.261] Timer tick, asking Buildbucket for the build status
[20:22:31.381] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:31.381] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:88:0) after 1m0s
[20:23:31.461] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:88:0)
[20:23:31.461] Timer tick, asking Buildbucket for the build status
[20:23:31.812] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:31.812] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:89:0) after 1m0s
[20:24:31.849] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:89:0)
[20:24:31.849] Timer tick, asking Buildbucket for the build status
[20:24:31.928] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:31.928] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:90:0) after 1m0s
[20:25:31.996] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:90:0)
[20:25:31.996] Timer tick, asking Buildbucket for the build status
[20:25:32.203] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:32.203] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:91:0) after 1m0s
[20:26:32.273] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:91:0)
[20:26:32.273] Timer tick, asking Buildbucket for the build status
[20:26:32.503] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:32.503] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:92:0) after 1m0s
[20:27:32.567] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:92:0)
[20:27:32.567] Timer tick, asking Buildbucket for the build status
[20:27:32.731] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:32.731] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:93:0) after 1m0s
[20:28:32.759] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:93:0)
[20:28:32.759] Timer tick, asking Buildbucket for the build status
[20:28:32.868] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:32.868] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:94:0) after 1m0s
[20:29:32.894] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:94:0)
[20:29:32.894] Timer tick, asking Buildbucket for the build status
[20:29:32.964] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:32.965] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:95:0) after 1m0s
[20:30:33.127] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:95:0)
[20:30:33.127] Timer tick, asking Buildbucket for the build status
[20:30:33.299] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:33.299] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:96:0) after 1m0s
[20:31:33.312] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:96:0)
[20:31:33.312] Timer tick, asking Buildbucket for the build status
[20:31:33.652] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:33.652] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:97:0) after 1m0s
[20:32:33.732] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:97:0)
[20:32:33.732] Timer tick, asking Buildbucket for the build status
[20:32:33.989] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:33.989] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:98:0) after 1m0s
[20:33:34.019] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:98:0)
[20:33:34.019] Timer tick, asking Buildbucket for the build status
[20:33:34.187] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:34.187] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:99:0) after 1m0s
[20:34:34.246] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:99:0)
[20:34:34.246] Timer tick, asking Buildbucket for the build status
[20:34:34.329] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:34.329] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:100:0) after 1m0s
[20:35:34.416] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:100:0)
[20:35:34.416] Timer tick, asking Buildbucket for the build status
[20:35:34.554] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:34.554] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:101:0) after 1m0s
[20:36:34.659] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:101:0)
[20:36:34.659] Timer tick, asking Buildbucket for the build status
[20:36:34.753] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:34.753] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:102:0) after 1m0s
[20:37:34.871] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:102:0)
[20:37:34.871] Timer tick, asking Buildbucket for the build status
[20:37:35.006] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:35.006] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:103:0) after 1m0s
[20:38:35.007] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:103:0)
[20:38:35.007] Timer tick, asking Buildbucket for the build status
[20:38:35.067] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:35.067] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:104:0) after 1m0s
[20:39:35.205] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:104:0)
[20:39:35.205] Timer tick, asking Buildbucket for the build status
[20:39:35.272] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:35.272] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:105:0) after 1m0s
[20:40:35.368] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:105:0)
[20:40:35.368] Timer tick, asking Buildbucket for the build status
[20:40:35.471] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:35.471] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:106:0) after 1m0s
[20:41:35.551] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:106:0)
[20:41:35.551] Timer tick, asking Buildbucket for the build status
[20:41:35.682] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:35.682] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:107:0) after 1m0s
[20:42:35.836] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:107:0)
[20:42:35.836] Timer tick, asking Buildbucket for the build status
[20:42:36.339] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:36.339] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:108:0) after 1m0s
[20:43:36.419] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:108:0)
[20:43:36.419] Timer tick, asking Buildbucket for the build status
[20:43:36.487] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:36.487] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:109:0) after 1m0s
[20:44:36.541] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:109:0)
[20:44:36.541] Timer tick, asking Buildbucket for the build status
[20:44:36.627] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:36.627] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:110:0) after 1m0s
[20:45:36.836] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:110:0)
[20:45:36.836] Timer tick, asking Buildbucket for the build status
[20:45:37.118] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:37.118] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:111:0) after 1m0s
[20:46:37.195] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:111:0)
[20:46:37.195] Timer tick, asking Buildbucket for the build status
[20:46:37.268] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:37.268] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:112:0) after 1m0s
[20:47:37.364] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:112:0)
[20:47:37.364] Timer tick, asking Buildbucket for the build status
[20:47:37.506] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:37.506] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:113:0) after 1m0s
[20:48:37.672] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:113:0)
[20:48:37.672] Timer tick, asking Buildbucket for the build status
[20:48:37.797] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:37.797] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:114:0) after 1m0s
[20:49:37.916] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:114:0)
[20:49:37.916] Timer tick, asking Buildbucket for the build status
[20:49:38.245] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:38.245] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:115:0) after 1m0s
[20:50:38.343] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:115:0)
[20:50:38.343] Timer tick, asking Buildbucket for the build status
[20:50:38.656] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:38.656] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:116:0) after 1m0s
[20:51:38.788] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:116:0)
[20:51:38.788] Timer tick, asking Buildbucket for the build status
[20:51:38.869] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:38.869] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:117:0) after 1m0s
[20:52:38.853] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:117:0)
[20:52:38.853] Timer tick, asking Buildbucket for the build status
[20:52:39.112] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:39.112] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:118:0) after 1m0s
[20:53:39.243] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:118:0)
[20:53:39.243] Timer tick, asking Buildbucket for the build status
[20:53:39.330] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:39.330] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:119:0) after 1m0s
[20:54:39.388] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:119:0)
[20:54:39.388] Timer tick, asking Buildbucket for the build status
[20:54:39.475] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:39.475] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:120:0) after 1m0s
[20:55:39.553] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:120:0)
[20:55:39.553] Timer tick, asking Buildbucket for the build status
[20:55:39.643] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:39.643] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:121:0) after 1m0s
[20:56:39.675] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:121:0)
[20:56:39.675] Timer tick, asking Buildbucket for the build status
[20:56:39.774] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:39.774] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:122:0) after 1m0s
[20:57:39.810] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:122:0)
[20:57:39.810] Timer tick, asking Buildbucket for the build status
[20:57:39.994] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:39.994] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:123:0) after 1m0s
[20:58:40.017] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:123:0)
[20:58:40.017] Timer tick, asking Buildbucket for the build status
[20:58:40.111] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:40.111] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:124:0) after 1m0s
[20:59:40.208] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:124:0)
[20:59:40.208] Timer tick, asking Buildbucket for the build status
[20:59:40.290] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:40.290] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:125:0) after 1m0s
[21:00:40.363] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:125:0)
[21:00:40.363] Timer tick, asking Buildbucket for the build status
[21:00:40.466] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:40.466] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:126:0) after 1m0s
[21:01:40.567] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:126:0)
[21:01:40.567] Timer tick, asking Buildbucket for the build status
[21:01:40.733] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:40.733] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:127:0) after 1m0s
[21:02:40.828] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:127:0)
[21:02:40.828] Timer tick, asking Buildbucket for the build status
[21:02:40.960] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:40.960] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:128:0) after 1m0s
[21:03:41.043] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:128:0)
[21:03:41.043] Timer tick, asking Buildbucket for the build status
[21:03:42.580] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:42.580] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:129:0) after 1m0s
[21:04:42.705] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:129:0)
[21:04:42.705] Timer tick, asking Buildbucket for the build status
[21:04:42.818] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:42.818] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:130:0) after 1m0s
[21:05:42.923] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:130:0)
[21:05:42.924] Timer tick, asking Buildbucket for the build status
[21:05:43.008] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:43.008] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:131:0) after 1m0s
[21:06:43.074] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:131:0)
[21:06:43.074] Timer tick, asking Buildbucket for the build status
[21:06:43.357] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:43.357] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:132:0) after 1m0s
[21:07:43.392] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:132:0)
[21:07:43.392] Timer tick, asking Buildbucket for the build status
[21:07:43.541] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:43.541] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:133:0) after 1m0s
[21:08:43.586] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:133:0)
[21:08:43.586] Timer tick, asking Buildbucket for the build status
[21:08:43.787] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:43.787] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:134:0) after 1m0s
[21:09:43.841] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:134:0)
[21:09:43.841] Timer tick, asking Buildbucket for the build status
[21:09:43.932] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:43.932] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:135:0) after 1m0s
[21:10:43.965] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:135:0)
[21:10:43.965] Timer tick, asking Buildbucket for the build status
[21:10:44.061] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:44.061] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:136:0) after 1m0s
[21:11:44.098] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:136:0)
[21:11:44.098] Timer tick, asking Buildbucket for the build status
[21:11:44.183] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:44.183] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:137:0) after 1m0s
[21:12:44.262] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:137:0)
[21:12:44.262] Timer tick, asking Buildbucket for the build status
[21:12:44.433] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:44.433] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:138:0) after 1m0s
[21:13:44.483] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:138:0)
[21:13:44.483] Timer tick, asking Buildbucket for the build status
[21:13:44.584] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:44.584] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:139:0) after 1m0s
[21:14:44.587] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:139:0)
[21:14:44.587] Timer tick, asking Buildbucket for the build status
[21:14:44.697] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:44.697] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:140:0) after 1m0s
[21:15:44.717] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:140:0)
[21:15:44.717] Timer tick, asking Buildbucket for the build status
[21:15:44.875] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:44.875] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:141:0) after 1m0s
[21:16:45.033] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:141:0)
[21:16:45.033] Timer tick, asking Buildbucket for the build status
[21:16:45.135] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:45.135] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:142:0) after 1m0s
[21:17:45.184] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:142:0)
[21:17:45.184] Timer tick, asking Buildbucket for the build status
[21:17:45.386] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:45.386] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:143:0) after 1m0s
[21:18:45.450] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:143:0)
[21:18:45.450] Timer tick, asking Buildbucket for the build status
[21:18:45.542] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:45.542] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:144:0) after 1m0s
[21:19:45.667] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:144:0)
[21:19:45.667] Timer tick, asking Buildbucket for the build status
[21:19:45.796] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:45.796] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:145:0) after 1m0s
[21:20:45.900] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:145:0)
[21:20:45.900] Timer tick, asking Buildbucket for the build status
[21:20:46.210] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:46.210] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:146:0) after 1m0s
[21:21:46.273] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:146:0)
[21:21:46.273] Timer tick, asking Buildbucket for the build status
[21:21:46.397] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:46.397] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:147:0) after 1m0s
[21:22:46.656] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:147:0)
[21:22:46.656] Timer tick, asking Buildbucket for the build status
[21:22:46.790] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:46.790] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:148:0) after 1m0s
[21:23:47.208] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:148:0)
[21:23:47.208] Timer tick, asking Buildbucket for the build status
[21:23:47.268] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:47.268] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:149:0) after 1m0s
[21:24:47.488] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:149:0)
[21:24:47.488] Timer tick, asking Buildbucket for the build status
[21:24:47.578] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:47.578] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:150:0) after 1m0s
[21:25:47.634] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:150:0)
[21:25:47.634] Timer tick, asking Buildbucket for the build status
[21:25:47.726] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:47.726] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:151:0) after 1m0s
[21:26:48.076] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:151:0)
[21:26:48.076] Timer tick, asking Buildbucket for the build status
[21:26:48.167] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:48.167] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:152:0) after 1m0s
[21:27:48.362] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:152:0)
[21:27:48.362] Timer tick, asking Buildbucket for the build status
[21:27:48.551] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:48.551] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:153:0) after 1m0s
[21:28:48.622] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:153:0)
[21:28:48.622] Timer tick, asking Buildbucket for the build status
[21:28:48.701] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:48.701] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:154:0) after 1m0s
[21:29:48.801] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:154:0)
[21:29:48.801] Timer tick, asking Buildbucket for the build status
[21:29:48.934] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:48.934] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:155:0) after 1m0s
[21:30:49.038] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:155:0)
[21:30:49.038] Timer tick, asking Buildbucket for the build status
[21:30:49.183] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:49.183] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:156:0) after 1m0s
[21:31:49.245] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:156:0)
[21:31:49.246] Timer tick, asking Buildbucket for the build status
[21:31:49.366] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:49.366] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:157:0) after 1m0s
[21:32:49.506] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:157:0)
[21:32:49.506] Timer tick, asking Buildbucket for the build status
[21:32:49.647] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:49.647] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:158:0) after 1m0s
[21:33:49.944] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:158:0)
[21:33:49.944] Timer tick, asking Buildbucket for the build status
[21:33:50.086] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:50.086] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:159:0) after 1m0s
[21:34:50.188] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:159:0)
[21:34:50.188] Timer tick, asking Buildbucket for the build status
[21:34:50.297] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:50.297] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:160:0) after 1m0s
[21:35:50.469] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:160:0)
[21:35:50.469] Timer tick, asking Buildbucket for the build status
[21:35:50.866] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:50.866] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:161:0) after 1m0s
[21:36:51.068] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:161:0)
[21:36:51.068] Timer tick, asking Buildbucket for the build status
[21:36:51.228] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:51.228] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:162:0) after 1m0s
[21:37:51.331] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:162:0)
[21:37:51.331] Timer tick, asking Buildbucket for the build status
[21:37:52.415] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:52.415] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:163:0) after 1m0s
[21:38:52.880] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:163:0)
[21:38:52.880] Timer tick, asking Buildbucket for the build status
[21:38:53.088] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:53.088] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:164:0) after 1m0s
[21:39:53.179] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:164:0)
[21:39:53.179] Timer tick, asking Buildbucket for the build status
[21:39:53.256] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:53.256] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:165:0) after 1m0s
[21:40:53.291] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:165:0)
[21:40:53.291] Timer tick, asking Buildbucket for the build status
[21:40:53.358] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:53.358] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:166:0) after 1m0s
[21:41:53.420] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:166:0)
[21:41:53.420] Timer tick, asking Buildbucket for the build status
[21:41:53.487] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:53.487] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:167:0) after 1m0s
[21:42:53.594] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:167:0)
[21:42:53.594] Timer tick, asking Buildbucket for the build status
[21:42:54.085] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:54.085] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:168:0) after 1m0s
[21:43:54.193] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:168:0)
[21:43:54.193] Timer tick, asking Buildbucket for the build status
[21:43:54.260] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:54.260] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:169:0) after 1m0s
[21:44:54.297] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:169:0)
[21:44:54.297] Timer tick, asking Buildbucket for the build status
[21:44:54.575] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:54.575] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:170:0) after 1m0s
[21:45:54.666] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:170:0)
[21:45:54.666] Timer tick, asking Buildbucket for the build status
[21:45:54.840] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:54.840] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:171:0) after 1m0s
[21:46:54.863] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:171:0)
[21:46:54.863] Timer tick, asking Buildbucket for the build status
[21:46:55.000] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:55.000] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:172:0) after 1m0s
[21:47:55.027] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:172:0)
[21:47:55.027] Timer tick, asking Buildbucket for the build status
[21:47:55.150] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:55.150] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:173:0) after 1m0s
[21:48:55.261] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:173:0)
[21:48:55.261] Timer tick, asking Buildbucket for the build status
[21:48:55.334] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:55.334] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:174:0) after 1m0s
[21:49:55.585] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:174:0)
[21:49:55.585] Timer tick, asking Buildbucket for the build status
[21:49:55.653] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:55.653] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:175:0) after 1m0s
[21:50:55.772] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:175:0)
[21:50:55.772] Timer tick, asking Buildbucket for the build status
[21:50:55.861] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:55.861] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:176:0) after 1m0s
[21:51:55.976] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:176:0)
[21:51:55.976] Timer tick, asking Buildbucket for the build status
[21:51:56.121] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:56.121] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:177:0) after 1m0s
[21:52:56.481] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:177:0)
[21:52:56.481] Timer tick, asking Buildbucket for the build status
[21:52:56.658] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:56.658] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:178:0) after 1m0s
[21:53:56.818] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:178:0)
[21:53:56.818] Timer tick, asking Buildbucket for the build status
[21:53:58.043] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:58.043] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:179:0) after 1m0s
[21:54:58.070] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:179:0)
[21:54:58.070] Timer tick, asking Buildbucket for the build status
[21:54:58.282] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:58.282] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:180:0) after 1m0s
[21:55:58.277] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:180:0)
[21:55:58.277] Timer tick, asking Buildbucket for the build status
[21:55:58.346] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:58.346] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:181:0) after 1m0s
[21:56:58.379] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:181:0)
[21:56:58.379] Timer tick, asking Buildbucket for the build status
[21:56:58.443] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:58.443] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:182:0) after 1m0s
[21:57:58.487] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:182:0)
[21:57:58.487] Timer tick, asking Buildbucket for the build status
[21:57:58.613] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:58.613] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:183:0) after 1m0s
[21:58:59.227] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:183:0)
[21:58:59.227] Timer tick, asking Buildbucket for the build status
[21:59:00.160] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:00.160] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:184:0) after 1m0s
[22:00:01.719] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:184:0)
[22:00:01.719] Timer tick, asking Buildbucket for the build status
[22:00:02.583] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:02.583] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:185:0) after 1m0s
[22:01:02.595] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:185:0)
[22:01:02.595] Timer tick, asking Buildbucket for the build status
[22:01:02.793] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:02.793] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:186:0) after 1m0s
[22:02:02.822] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:186:0)
[22:02:02.822] Timer tick, asking Buildbucket for the build status
[22:02:02.911] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:02.911] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:187:0) after 1m0s
[22:03:03.010] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:187:0)
[22:03:03.010] Timer tick, asking Buildbucket for the build status
[22:03:03.175] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:03.175] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:188:0) after 1m0s
[22:04:03.577] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:188:0)
[22:04:03.577] Timer tick, asking Buildbucket for the build status
[22:04:03.668] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:03.668] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:189:0) after 1m0s
[22:05:03.847] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:189:0)
[22:05:03.847] Timer tick, asking Buildbucket for the build status
[22:05:04.203] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:04.203] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:190:0) after 1m0s
[22:06:04.484] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:190:0)
[22:06:04.484] Timer tick, asking Buildbucket for the build status
[22:06:04.580] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:04.580] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:191:0) after 1m0s
[22:07:04.720] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:191:0)
[22:07:04.720] Timer tick, asking Buildbucket for the build status
[22:07:04.900] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:04.900] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:192:0) after 1m0s
[22:08:04.947] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:192:0)
[22:08:04.947] Timer tick, asking Buildbucket for the build status
[22:08:05.057] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:05.057] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:193:0) after 1m0s
[22:09:05.173] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:193:0)
[22:09:05.173] Timer tick, asking Buildbucket for the build status
[22:09:05.261] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:05.261] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:194:0) after 1m0s
[22:10:05.346] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:194:0)
[22:10:05.346] Timer tick, asking Buildbucket for the build status
[22:10:05.491] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:05.491] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:195:0) after 1m0s
[22:11:05.570] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:195:0)
[22:11:05.570] Timer tick, asking Buildbucket for the build status
[22:11:05.704] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:05.704] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:196:0) after 1m0s
[22:12:06.259] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:196:0)
[22:12:06.259] Timer tick, asking Buildbucket for the build status
[22:12:06.333] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:06.333] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:197:0) after 1m0s
[22:13:06.596] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:197:0)
[22:13:06.596] Timer tick, asking Buildbucket for the build status
[22:13:07.099] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:07.099] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:198:0) after 1m0s
[22:14:07.241] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:198:0)
[22:14:07.241] Timer tick, asking Buildbucket for the build status
[22:14:07.329] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:07.329] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:199:0) after 1m0s
[22:15:07.371] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:199:0)
[22:15:07.371] Timer tick, asking Buildbucket for the build status
[22:15:08.756] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:08.756] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:200:0) after 1m0s
[22:16:08.833] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:200:0)
[22:16:08.833] Timer tick, asking Buildbucket for the build status
[22:16:08.947] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:08.947] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:201:0) after 1m0s
[22:17:09.003] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:201:0)
[22:17:09.003] Timer tick, asking Buildbucket for the build status
[22:17:09.081] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:09.081] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:202:0) after 1m0s
[22:18:09.145] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:202:0)
[22:18:09.145] Timer tick, asking Buildbucket for the build status
[22:18:09.258] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:09.258] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:203:0) after 1m0s
[22:19:09.378] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:203:0)
[22:19:09.378] Timer tick, asking Buildbucket for the build status
[22:19:09.473] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:09.473] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:204:0) after 1m0s
[22:20:09.639] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:204:0)
[22:20:09.639] Timer tick, asking Buildbucket for the build status
[22:20:09.963] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:09.963] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:205:0) after 1m0s
[22:21:10.262] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:205:0)
[22:21:10.262] Timer tick, asking Buildbucket for the build status
[22:21:10.976] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:10.976] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:206:0) after 1m0s
[22:22:11.201] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:206:0)
[22:22:11.201] Timer tick, asking Buildbucket for the build status
[22:22:11.291] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:11.291] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:207:0) after 1m0s
[22:23:11.407] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:207:0)
[22:23:11.407] Timer tick, asking Buildbucket for the build status
[22:23:11.542] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:11.542] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:208:0) after 1m0s
[22:24:11.759] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:208:0)
[22:24:11.759] Timer tick, asking Buildbucket for the build status
[22:24:11.844] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:11.844] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:209:0) after 1m0s
[22:25:11.984] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:209:0)
[22:25:11.984] Timer tick, asking Buildbucket for the build status
[22:25:12.099] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:12.099] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:210:0) after 1m0s
[22:26:12.204] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:210:0)
[22:26:12.204] Timer tick, asking Buildbucket for the build status
[22:26:12.325] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:12.325] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:211:0) after 1m0s
[22:27:12.372] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:211:0)
[22:27:12.372] Timer tick, asking Buildbucket for the build status
[22:27:12.448] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:12.448] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:212:0) after 1m0s
[22:28:12.495] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:212:0)
[22:28:12.495] Timer tick, asking Buildbucket for the build status
[22:28:12.662] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:12.662] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:213:0) after 1m0s
[22:29:12.924] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:213:0)
[22:29:12.924] Timer tick, asking Buildbucket for the build status
[22:29:13.086] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:13.086] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:214:0) after 1m0s
[22:30:13.278] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:214:0)
[22:30:13.278] Timer tick, asking Buildbucket for the build status
[22:30:13.384] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:13.384] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:215:0) after 1m0s
[22:31:13.568] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:215:0)
[22:31:13.568] Timer tick, asking Buildbucket for the build status
[22:31:13.642] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:13.642] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:216:0) after 1m0s
[22:32:14.474] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:216:0)
[22:32:14.474] Timer tick, asking Buildbucket for the build status
[22:32:14.555] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:14.555] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:217:0) after 1m0s
[22:33:14.615] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:217:0)
[22:33:14.615] Timer tick, asking Buildbucket for the build status
[22:33:14.734] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:14.734] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:218:0) after 1m0s
[22:34:14.892] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:218:0)
[22:34:14.892] Timer tick, asking Buildbucket for the build status
[22:34:14.962] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:14.962] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:219:0) after 1m0s
[22:35:15.161] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:219:0)
[22:35:15.161] Timer tick, asking Buildbucket for the build status
[22:35:15.524] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:15.524] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:220:0) after 1m0s
[22:36:15.629] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:220:0)
[22:36:15.629] Timer tick, asking Buildbucket for the build status
[22:36:15.908] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:15.908] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:221:0) after 1m0s
[22:37:15.939] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:221:0)
[22:37:15.939] Timer tick, asking Buildbucket for the build status
[22:37:16.102] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:16.102] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:222:0) after 1m0s
[22:38:16.256] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:222:0)
[22:38:16.256] Timer tick, asking Buildbucket for the build status
[22:38:16.370] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:16.370] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:223:0) after 1m0s
[22:39:16.443] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:223:0)
[22:39:16.443] Timer tick, asking Buildbucket for the build status
[22:39:16.517] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:16.517] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:224:0) after 1m0s
[22:40:16.589] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:224:0)
[22:40:16.589] Timer tick, asking Buildbucket for the build status
[22:40:16.908] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:16.908] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:225:0) after 1m0s
[22:41:16.965] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:225:0)
[22:41:16.965] Timer tick, asking Buildbucket for the build status
[22:41:17.128] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:17.128] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:226:0) after 1m0s
[22:42:17.276] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:226:0)
[22:42:17.276] Timer tick, asking Buildbucket for the build status
[22:42:17.383] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:17.383] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:227:0) after 1m0s
[22:43:17.419] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:227:0)
[22:43:17.419] Timer tick, asking Buildbucket for the build status
[22:43:17.590] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:17.590] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:228:0) after 1m0s
[22:44:17.655] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:228:0)
[22:44:17.655] Timer tick, asking Buildbucket for the build status
[22:44:17.743] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:17.743] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:229:0) after 1m0s
[22:45:17.828] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:229:0)
[22:45:17.828] Timer tick, asking Buildbucket for the build status
[22:45:17.982] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:17.982] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:230:0) after 1m0s
[22:46:18.085] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:230:0)
[22:46:18.085] Timer tick, asking Buildbucket for the build status
[22:46:18.173] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:18.173] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:231:0) after 1m0s
[22:47:18.419] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:231:0)
[22:47:18.419] Timer tick, asking Buildbucket for the build status
[22:47:18.581] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:18.581] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:232:0) after 1m0s
[22:48:18.644] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:232:0)
[22:48:18.644] Timer tick, asking Buildbucket for the build status
[22:48:18.719] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:18.719] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:233:0) after 1m0s
[22:49:18.809] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:233:0)
[22:49:18.809] Timer tick, asking Buildbucket for the build status
[22:49:19.287] Build 8871693674036477344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:19.287] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037123738312752096:234:0) after 1m0s
[22:50:00.719] Received PubSub notification, asking Buildbucket for the build status
[22:50:01.351] Build 8871693674036477344: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:50:01.351] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1597704599614940",
"created_by": "project:chromium",
"created_ts": "1597690622255724",
"id": "8871693674036477344",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"33555f9e56c8038ab49a38f98b8b3175b60b0857\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/chromium_tests\": {\"bucketed_triggers\": true}, \"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$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-8-yk3i\", \"branch\": \"refs/heads/master\", \"buildername\": \"win-official\", \"buildnumber\": 368, \"got_angle_revision\": \"064bbf297d3702ff9b7ecfb8a81de7cc97a9a12b\", \"got_dawn_revision\": \"5e9b29fab92d6d79125555ea0d84afde9ace908b\", \"got_nacl_revision\": \"3008f9e6de122325d8f9dbf02f7cdd51fa1ec306\", \"got_revision\": \"33555f9e56c8038ab49a38f98b8b3175b60b0857\", \"got_revision_cp\": \"refs/heads/master@{#798749}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"e7cd224e55fa55ba248d8fba0d0dd34b948c12ae\", \"got_v8_revision\": \"0c2650adcc949784fe629ebba7b7255ebe2b48f5\", \"got_v8_revision_cp\": \"refs/heads/8.6.390@{#1}\", \"got_webrtc_revision\": \"383f2cfca4a1ebd9626134101fe70d5a716b2d92\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31921}\", \"mastername\": \"chromium\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"33555f9e56c8038ab49a38f98b8b3175b60b0857\"}, \"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-8-yk3i\"], \"image\": [\"chrome-win10-1703-20081200-b8de48ff3cf\"], \"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\": [\"5488-fc78d20\"], \"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": "1597690625010443",
"status": "COMPLETED",
"status_changed_ts": "1597704600314143",
"tags": [
"build_address:luci.chromium.ci/win-official/368",
"builder:win-official",
"buildset:commit/git/33555f9e56c8038ab49a38f98b8b3175b60b0857",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/33555f9e56c8038ab49a38f98b8b3175b60b0857",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9037123738312752096",
"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/8871693674036477344/+/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:4e1699bdfb870810",
"user_agent:luci-scheduler"
],
"updated_ts": "1597704600320020",
"url": "https://ci.chromium.org/b/8871693674036477344",
"utcnow_ts": "1597704601344467"
}
}
[22:50:01.351] Invocation finished in 3h53m2.558026894s with status SUCCEEDED