[10:01:12.746] New invocation is queued and will start shortly
[10:01:13.833] Starting the invocation (attempt 1)
[10:01:13.887] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:01:13.887] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:01:13.887] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020306410151727168",
"parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"b9fdcea4807d0db240c842a233d0bcf4a270666a\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-official",
"scheduler_invocation_id:9020306410151727168",
"scheduler_job_id:chromium/win-official",
"user_agent:luci-scheduler",
"buildset:commit/git/b9fdcea4807d0db240c842a233d0bcf4a270666a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b9fdcea4807d0db240c842a233d0bcf4a270666a",
"gitiles_ref:refs/heads/master"
]
}
[10:01:14.622] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613728874018123",
"id": "8854876348156435136",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b9fdcea4807d0db240c842a233d0bcf4a270666a\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613728874500752",
"tags": [
"build_address:luci.chromium.ci/win-official/1624",
"builder:win-official",
"buildset:commit/git/b9fdcea4807d0db240c842a233d0bcf4a270666a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b9fdcea4807d0db240c842a233d0bcf4a270666a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020306410151727168",
"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/8854876348156435136/+/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": "1613728874500877",
"url": "https://ci.chromium.org/b/8854876348156435136",
"utcnow_ts": "1613728874615362"
}
}
[10:01:14.622] Task URL: https://ci.chromium.org/b/8854876348156435136
[10:01:14.622] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:2:0) after 1m0s
[10:02:14.676] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:2:0)
[10:02:14.676] Timer tick, asking Buildbucket for the build status
[10:02:14.792] Build 8854876348156435136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:02:14.792] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:3:0) after 1m0s
[10:03:10.248] Received PubSub notification, asking Buildbucket for the build status
[10:03:10.362] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:14.831] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:3:0)
[10:03:14.831] Timer tick, asking Buildbucket for the build status
[10:03:14.903] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:14.903] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:5:0) after 1m0s
[10:04:14.982] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:5:0)
[10:04:14.982] Timer tick, asking Buildbucket for the build status
[10:04:15.046] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:15.046] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:6:0) after 1m0s
[10:05:15.125] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:6:0)
[10:05:15.125] Timer tick, asking Buildbucket for the build status
[10:05:15.202] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:15.202] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:7:0) after 1m0s
[10:06:15.239] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:7:0)
[10:06:15.239] Timer tick, asking Buildbucket for the build status
[10:06:15.313] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:15.313] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:8:0) after 1m0s
[10:07:15.318] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:8:0)
[10:07:15.318] Timer tick, asking Buildbucket for the build status
[10:07:15.400] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:15.400] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:9:0) after 1m0s
[10:08:15.460] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:9:0)
[10:08:15.460] Timer tick, asking Buildbucket for the build status
[10:08:15.710] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:15.710] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:10:0) after 1m0s
[10:09:15.793] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:10:0)
[10:09:15.793] Timer tick, asking Buildbucket for the build status
[10:09:15.888] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:15.888] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:11:0) after 1m0s
[10:10:15.974] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:11:0)
[10:10:15.974] Timer tick, asking Buildbucket for the build status
[10:10:16.060] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:16.060] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:12:0) after 1m0s
[10:11:16.100] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:12:0)
[10:11:16.100] Timer tick, asking Buildbucket for the build status
[10:11:16.174] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:16.174] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:13:0) after 1m0s
[10:12:16.283] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:13:0)
[10:12:16.283] Timer tick, asking Buildbucket for the build status
[10:12:16.378] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:16.378] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:14:0) after 1m0s
[10:13:16.583] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:14:0)
[10:13:16.583] Timer tick, asking Buildbucket for the build status
[10:13:16.834] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:16.834] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:15:0) after 1m0s
[10:14:16.977] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:15:0)
[10:14:16.977] Timer tick, asking Buildbucket for the build status
[10:14:17.104] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:17.104] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:16:0) after 1m0s
[10:15:17.124] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:16:0)
[10:15:17.124] Timer tick, asking Buildbucket for the build status
[10:15:17.202] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:17.202] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:17:0) after 1m0s
[10:16:17.262] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:17:0)
[10:16:17.262] Timer tick, asking Buildbucket for the build status
[10:16:17.335] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:17.335] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:18:0) after 1m0s
[10:17:17.380] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:18:0)
[10:17:17.380] Timer tick, asking Buildbucket for the build status
[10:17:17.915] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:17.915] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:19:0) after 1m0s
[10:18:18.028] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:19:0)
[10:18:18.028] Timer tick, asking Buildbucket for the build status
[10:18:18.116] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:18.116] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:20:0) after 1m0s
[10:19:18.135] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:20:0)
[10:19:18.135] Timer tick, asking Buildbucket for the build status
[10:19:18.462] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:18.462] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:21:0) after 1m0s
[10:20:18.508] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:21:0)
[10:20:18.508] Timer tick, asking Buildbucket for the build status
[10:20:18.589] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:18.589] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:22:0) after 1m0s
[10:21:18.616] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:22:0)
[10:21:18.616] Timer tick, asking Buildbucket for the build status
[10:21:18.783] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:18.783] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:23:0) after 1m0s
[10:22:18.816] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:23:0)
[10:22:18.816] Timer tick, asking Buildbucket for the build status
[10:22:18.910] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:18.910] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:24:0) after 1m0s
[10:23:18.939] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:24:0)
[10:23:18.939] Timer tick, asking Buildbucket for the build status
[10:23:19.021] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:19.021] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:25:0) after 1m0s
[10:24:19.056] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:25:0)
[10:24:19.056] Timer tick, asking Buildbucket for the build status
[10:24:19.352] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:19.352] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:26:0) after 1m0s
[10:25:19.394] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:26:0)
[10:25:19.394] Timer tick, asking Buildbucket for the build status
[10:25:19.488] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:19.488] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:27:0) after 1m0s
[10:26:19.540] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:27:0)
[10:26:19.540] Timer tick, asking Buildbucket for the build status
[10:26:19.656] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:19.656] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:28:0) after 1m0s
[10:27:19.708] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:28:0)
[10:27:19.708] Timer tick, asking Buildbucket for the build status
[10:27:19.802] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:19.802] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:29:0) after 1m0s
[10:28:19.832] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:29:0)
[10:28:19.832] Timer tick, asking Buildbucket for the build status
[10:28:19.966] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:19.966] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:30:0) after 1m0s
[10:29:20.088] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:30:0)
[10:29:20.088] Timer tick, asking Buildbucket for the build status
[10:29:20.166] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:20.166] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:31:0) after 1m0s
[10:30:20.210] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:31:0)
[10:30:20.210] Timer tick, asking Buildbucket for the build status
[10:30:20.282] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:20.282] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:32:0) after 1m0s
[10:31:20.309] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:32:0)
[10:31:20.309] Timer tick, asking Buildbucket for the build status
[10:31:20.702] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:20.702] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:33:0) after 1m0s
[10:32:20.722] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:33:0)
[10:32:20.722] Timer tick, asking Buildbucket for the build status
[10:32:20.792] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:20.792] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:34:0) after 1m0s
[10:33:20.785] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:34:0)
[10:33:20.785] Timer tick, asking Buildbucket for the build status
[10:33:20.873] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:20.873] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:35:0) after 1m0s
[10:34:20.920] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:35:0)
[10:34:20.920] Timer tick, asking Buildbucket for the build status
[10:34:21.399] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:21.399] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:36:0) after 1m0s
[10:35:21.444] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:36:0)
[10:35:21.444] Timer tick, asking Buildbucket for the build status
[10:35:21.518] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:21.518] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:37:0) after 1m0s
[10:36:21.583] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:37:0)
[10:36:21.583] Timer tick, asking Buildbucket for the build status
[10:36:21.828] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:21.829] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:38:0) after 1m0s
[10:37:21.874] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:38:0)
[10:37:21.874] Timer tick, asking Buildbucket for the build status
[10:37:22.032] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:22.032] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:39:0) after 1m0s
[10:38:22.085] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:39:0)
[10:38:22.085] Timer tick, asking Buildbucket for the build status
[10:38:22.751] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:22.751] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:40:0) after 1m0s
[10:39:22.776] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:40:0)
[10:39:22.776] Timer tick, asking Buildbucket for the build status
[10:39:22.863] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:22.863] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:41:0) after 1m0s
[10:40:22.891] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:41:0)
[10:40:22.891] Timer tick, asking Buildbucket for the build status
[10:40:22.981] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:22.981] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:42:0) after 1m0s
[10:41:22.967] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:42:0)
[10:41:22.967] Timer tick, asking Buildbucket for the build status
[10:41:23.302] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:23.302] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:43:0) after 1m0s
[10:42:23.373] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:43:0)
[10:42:23.373] Timer tick, asking Buildbucket for the build status
[10:42:23.456] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:23.456] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:44:0) after 1m0s
[10:43:23.478] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:44:0)
[10:43:23.478] Timer tick, asking Buildbucket for the build status
[10:43:23.552] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:23.552] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:45:0) after 1m0s
[10:44:23.574] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:45:0)
[10:44:23.574] Timer tick, asking Buildbucket for the build status
[10:44:23.670] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:23.670] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:46:0) after 1m0s
[10:45:23.802] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:46:0)
[10:45:23.802] Timer tick, asking Buildbucket for the build status
[10:45:23.955] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:23.955] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:47:0) after 1m0s
[10:46:24.076] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:47:0)
[10:46:24.076] Timer tick, asking Buildbucket for the build status
[10:46:24.281] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:24.281] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:48:0) after 1m0s
[10:47:24.311] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:48:0)
[10:47:24.311] Timer tick, asking Buildbucket for the build status
[10:47:24.513] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:24.513] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:49:0) after 1m0s
[10:48:24.528] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:49:0)
[10:48:24.528] Timer tick, asking Buildbucket for the build status
[10:48:24.789] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:24.789] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:50:0) after 1m0s
[10:49:25.150] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:50:0)
[10:49:25.150] Timer tick, asking Buildbucket for the build status
[10:49:25.244] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:25.244] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:51:0) after 1m0s
[10:50:25.423] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:51:0)
[10:50:25.423] Timer tick, asking Buildbucket for the build status
[10:50:25.513] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:25.513] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:52:0) after 1m0s
[10:51:25.669] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:52:0)
[10:51:25.669] Timer tick, asking Buildbucket for the build status
[10:51:26.007] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:26.007] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:53:0) after 1m0s
[10:52:26.250] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:53:0)
[10:52:26.250] Timer tick, asking Buildbucket for the build status
[10:52:26.346] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:26.346] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:54:0) after 1m0s
[10:53:26.539] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:54:0)
[10:53:26.539] Timer tick, asking Buildbucket for the build status
[10:53:26.613] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:26.613] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:55:0) after 1m0s
[10:54:26.732] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:55:0)
[10:54:26.732] Timer tick, asking Buildbucket for the build status
[10:54:26.819] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:26.819] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:56:0) after 1m0s
[10:55:26.903] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:56:0)
[10:55:26.903] Timer tick, asking Buildbucket for the build status
[10:55:26.980] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:26.980] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:57:0) after 1m0s
[10:56:27.178] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:57:0)
[10:56:27.178] Timer tick, asking Buildbucket for the build status
[10:56:27.262] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:27.262] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:58:0) after 1m0s
[10:57:27.327] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:58:0)
[10:57:27.327] Timer tick, asking Buildbucket for the build status
[10:57:27.405] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:27.405] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:59:0) after 1m0s
[10:58:28.779] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:59:0)
[10:58:28.779] Timer tick, asking Buildbucket for the build status
[10:58:29.012] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:29.012] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:60:0) after 1m0s
[10:59:29.163] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:60:0)
[10:59:29.163] Timer tick, asking Buildbucket for the build status
[10:59:29.488] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:29.488] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:61:0) after 1m0s
[11:00:29.959] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:61:0)
[11:00:29.959] Timer tick, asking Buildbucket for the build status
[11:00:30.075] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:30.075] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:62:0) after 1m0s
[11:01:30.274] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:62:0)
[11:01:30.274] Timer tick, asking Buildbucket for the build status
[11:01:30.407] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:30.407] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:63:0) after 1m0s
[11:02:30.506] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:63:0)
[11:02:30.506] Timer tick, asking Buildbucket for the build status
[11:02:30.593] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:30.593] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:64:0) after 1m0s
[11:03:30.681] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:64:0)
[11:03:30.681] Timer tick, asking Buildbucket for the build status
[11:03:30.758] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:30.758] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:65:0) after 1m0s
[11:04:30.810] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:65:0)
[11:04:30.810] Timer tick, asking Buildbucket for the build status
[11:04:30.890] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:30.890] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:66:0) after 1m0s
[11:05:30.984] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:66:0)
[11:05:30.984] Timer tick, asking Buildbucket for the build status
[11:05:31.058] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:31.058] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:67:0) after 1m0s
[11:06:31.076] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:67:0)
[11:06:31.076] Timer tick, asking Buildbucket for the build status
[11:06:31.195] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:31.195] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:68:0) after 1m0s
[11:07:31.390] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:68:0)
[11:07:31.390] Timer tick, asking Buildbucket for the build status
[11:07:31.470] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:31.470] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:69:0) after 1m0s
[11:08:32.065] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:69:0)
[11:08:32.065] Timer tick, asking Buildbucket for the build status
[11:08:32.158] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:32.158] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:70:0) after 1m0s
[11:09:32.729] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:70:0)
[11:09:32.729] Timer tick, asking Buildbucket for the build status
[11:09:32.872] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:32.872] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:71:0) after 1m0s
[11:10:32.986] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:71:0)
[11:10:32.986] Timer tick, asking Buildbucket for the build status
[11:10:33.069] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:33.069] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:72:0) after 1m0s
[11:11:33.132] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:72:0)
[11:11:33.133] Timer tick, asking Buildbucket for the build status
[11:11:33.766] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:33.766] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:73:0) after 1m0s
[11:12:34.960] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:73:0)
[11:12:34.960] Timer tick, asking Buildbucket for the build status
[11:12:35.040] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:35.040] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:74:0) after 1m0s
[11:13:35.463] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:74:0)
[11:13:35.463] Timer tick, asking Buildbucket for the build status
[11:13:35.649] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:35.649] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:75:0) after 1m0s
[11:14:35.700] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:75:0)
[11:14:35.700] Timer tick, asking Buildbucket for the build status
[11:14:35.820] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:35.820] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:76:0) after 1m0s
[11:15:35.962] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:76:0)
[11:15:35.962] Timer tick, asking Buildbucket for the build status
[11:15:36.044] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:36.044] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:77:0) after 1m0s
[11:16:36.118] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:77:0)
[11:16:36.118] Timer tick, asking Buildbucket for the build status
[11:16:36.201] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:36.201] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:78:0) after 1m0s
[11:17:36.357] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:78:0)
[11:17:36.357] Timer tick, asking Buildbucket for the build status
[11:17:36.443] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:36.443] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:79:0) after 1m0s
[11:18:36.487] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:79:0)
[11:18:36.487] Timer tick, asking Buildbucket for the build status
[11:18:36.722] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:36.722] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:80:0) after 1m0s
[11:19:36.815] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:80:0)
[11:19:36.815] Timer tick, asking Buildbucket for the build status
[11:19:36.925] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:36.925] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:81:0) after 1m0s
[11:20:37.099] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:81:0)
[11:20:37.099] Timer tick, asking Buildbucket for the build status
[11:20:37.178] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:37.178] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:82:0) after 1m0s
[11:21:37.226] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:82:0)
[11:21:37.227] Timer tick, asking Buildbucket for the build status
[11:21:37.320] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:37.320] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:83:0) after 1m0s
[11:22:37.398] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:83:0)
[11:22:37.398] Timer tick, asking Buildbucket for the build status
[11:22:37.468] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:37.468] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:84:0) after 1m0s
[11:23:37.468] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:84:0)
[11:23:37.468] Timer tick, asking Buildbucket for the build status
[11:23:37.552] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:37.552] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:85:0) after 1m0s
[11:24:37.575] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:85:0)
[11:24:37.575] Timer tick, asking Buildbucket for the build status
[11:24:37.652] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:37.652] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:86:0) after 1m0s
[11:25:37.683] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:86:0)
[11:25:37.683] Timer tick, asking Buildbucket for the build status
[11:25:37.745] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:37.745] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:87:0) after 1m0s
[11:26:37.787] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:87:0)
[11:26:37.787] Timer tick, asking Buildbucket for the build status
[11:26:37.870] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:37.870] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:88:0) after 1m0s
[11:27:37.867] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:88:0)
[11:27:37.867] Timer tick, asking Buildbucket for the build status
[11:27:37.940] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:37.940] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:89:0) after 1m0s
[11:28:37.970] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:89:0)
[11:28:37.970] Timer tick, asking Buildbucket for the build status
[11:28:38.106] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:38.106] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:90:0) after 1m0s
[11:29:38.219] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:90:0)
[11:29:38.219] Timer tick, asking Buildbucket for the build status
[11:29:38.322] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:38.322] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:91:0) after 1m0s
[11:30:38.383] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:91:0)
[11:30:38.383] Timer tick, asking Buildbucket for the build status
[11:30:38.480] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:38.480] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:92:0) after 1m0s
[11:31:38.526] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:92:0)
[11:31:38.526] Timer tick, asking Buildbucket for the build status
[11:31:38.617] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:38.617] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:93:0) after 1m0s
[11:32:38.666] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:93:0)
[11:32:38.666] Timer tick, asking Buildbucket for the build status
[11:32:38.741] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:38.741] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:94:0) after 1m0s
[11:33:38.757] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:94:0)
[11:33:38.757] Timer tick, asking Buildbucket for the build status
[11:33:38.853] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:38.853] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:95:0) after 1m0s
[11:34:38.914] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:95:0)
[11:34:38.914] Timer tick, asking Buildbucket for the build status
[11:34:39.002] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:39.002] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:96:0) after 1m0s
[11:35:39.045] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:96:0)
[11:35:39.045] Timer tick, asking Buildbucket for the build status
[11:35:39.118] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:39.118] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:97:0) after 1m0s
[11:36:39.094] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:97:0)
[11:36:39.094] Timer tick, asking Buildbucket for the build status
[11:36:39.191] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:39.191] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:98:0) after 1m0s
[11:37:39.204] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:98:0)
[11:37:39.204] Timer tick, asking Buildbucket for the build status
[11:37:39.278] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:39.278] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:99:0) after 1m0s
[11:38:39.317] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:99:0)
[11:38:39.317] Timer tick, asking Buildbucket for the build status
[11:38:43.964] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:43.964] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:100:0) after 1m0s
[11:39:44.122] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:100:0)
[11:39:44.122] Timer tick, asking Buildbucket for the build status
[11:39:44.200] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:44.200] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:101:0) after 1m0s
[11:40:44.258] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:101:0)
[11:40:44.258] Timer tick, asking Buildbucket for the build status
[11:40:44.407] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:44.407] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:102:0) after 1m0s
[11:41:44.480] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:102:0)
[11:41:44.480] Timer tick, asking Buildbucket for the build status
[11:41:44.746] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:44.746] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:103:0) after 1m0s
[11:42:44.800] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:103:0)
[11:42:44.800] Timer tick, asking Buildbucket for the build status
[11:42:44.993] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:44.993] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:104:0) after 1m0s
[11:43:45.030] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:104:0)
[11:43:45.030] Timer tick, asking Buildbucket for the build status
[11:43:45.307] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:45.308] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:105:0) after 1m0s
[11:44:45.333] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:105:0)
[11:44:45.333] Timer tick, asking Buildbucket for the build status
[11:44:45.402] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:45.402] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:106:0) after 1m0s
[11:45:45.494] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:106:0)
[11:45:45.494] Timer tick, asking Buildbucket for the build status
[11:45:45.608] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:45.608] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:107:0) after 1m0s
[11:46:45.670] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:107:0)
[11:46:45.670] Timer tick, asking Buildbucket for the build status
[11:46:45.753] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:45.754] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:108:0) after 1m0s
[11:47:45.729] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:108:0)
[11:47:45.729] Timer tick, asking Buildbucket for the build status
[11:47:45.792] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:45.792] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:109:0) after 1m0s
[11:48:45.884] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:109:0)
[11:48:45.884] Timer tick, asking Buildbucket for the build status
[11:48:46.319] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:46.319] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:110:0) after 1m0s
[11:49:46.320] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:110:0)
[11:49:46.320] Timer tick, asking Buildbucket for the build status
[11:49:46.394] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:46.394] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:111:0) after 1m0s
[11:50:46.472] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:111:0)
[11:50:46.472] Timer tick, asking Buildbucket for the build status
[11:50:46.560] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:46.560] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:112:0) after 1m0s
[11:51:46.581] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:112:0)
[11:51:46.581] Timer tick, asking Buildbucket for the build status
[11:51:46.690] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:46.690] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:113:0) after 1m0s
[11:52:46.713] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:113:0)
[11:52:46.713] Timer tick, asking Buildbucket for the build status
[11:52:46.789] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:46.789] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:114:0) after 1m0s
[11:53:46.841] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:114:0)
[11:53:46.841] Timer tick, asking Buildbucket for the build status
[11:53:47.031] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:47.031] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:115:0) after 1m0s
[11:54:47.026] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:115:0)
[11:54:47.026] Timer tick, asking Buildbucket for the build status
[11:54:47.294] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:47.294] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:116:0) after 1m0s
[11:55:47.298] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:116:0)
[11:55:47.298] Timer tick, asking Buildbucket for the build status
[11:55:54.749] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:54.749] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:117:0) after 1m0s
[11:56:54.805] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:117:0)
[11:56:54.805] Timer tick, asking Buildbucket for the build status
[11:56:54.887] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:54.887] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:118:0) after 1m0s
[11:57:54.893] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:118:0)
[11:57:54.893] Timer tick, asking Buildbucket for the build status
[11:57:54.978] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:54.978] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:119:0) after 1m0s
[11:58:54.998] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:119:0)
[11:58:54.998] Timer tick, asking Buildbucket for the build status
[11:58:55.098] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:55.098] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:120:0) after 1m0s
[11:59:55.152] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:120:0)
[11:59:55.152] Timer tick, asking Buildbucket for the build status
[11:59:55.247] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:55.247] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:121:0) after 1m0s
[12:00:55.279] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:121:0)
[12:00:55.279] Timer tick, asking Buildbucket for the build status
[12:00:55.358] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:55.358] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:122:0) after 1m0s
[12:01:55.418] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:122:0)
[12:01:55.418] Timer tick, asking Buildbucket for the build status
[12:01:55.524] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:55.524] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:123:0) after 1m0s
[12:02:55.552] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:123:0)
[12:02:55.552] Timer tick, asking Buildbucket for the build status
[12:02:55.656] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:55.656] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:124:0) after 1m0s
[12:03:55.704] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:124:0)
[12:03:55.704] Timer tick, asking Buildbucket for the build status
[12:03:55.831] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:55.831] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:125:0) after 1m0s
[12:04:55.858] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:125:0)
[12:04:55.858] Timer tick, asking Buildbucket for the build status
[12:04:56.104] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:56.104] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:126:0) after 1m0s
[12:05:56.130] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:126:0)
[12:05:56.130] Timer tick, asking Buildbucket for the build status
[12:05:56.208] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:56.208] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:127:0) after 1m0s
[12:06:56.262] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:127:0)
[12:06:56.262] Timer tick, asking Buildbucket for the build status
[12:06:56.395] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:56.395] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:128:0) after 1m0s
[12:07:56.414] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:128:0)
[12:07:56.414] Timer tick, asking Buildbucket for the build status
[12:07:56.818] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:56.818] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:129:0) after 1m0s
[12:08:56.943] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:129:0)
[12:08:56.943] Timer tick, asking Buildbucket for the build status
[12:08:57.151] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:57.151] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:130:0) after 1m0s
[12:09:57.616] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:130:0)
[12:09:57.616] Timer tick, asking Buildbucket for the build status
[12:09:57.708] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:57.708] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:131:0) after 1m0s
[12:10:57.732] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:131:0)
[12:10:57.732] Timer tick, asking Buildbucket for the build status
[12:10:58.204] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:58.204] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:132:0) after 1m0s
[12:11:58.299] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:132:0)
[12:11:58.299] Timer tick, asking Buildbucket for the build status
[12:11:58.395] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:58.395] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:133:0) after 1m0s
[12:12:58.384] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:133:0)
[12:12:58.384] Timer tick, asking Buildbucket for the build status
[12:12:58.466] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:58.466] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:134:0) after 1m0s
[12:13:58.550] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:134:0)
[12:13:58.550] Timer tick, asking Buildbucket for the build status
[12:13:58.793] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:58.793] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:135:0) after 1m0s
[12:14:58.781] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:135:0)
[12:14:58.781] Timer tick, asking Buildbucket for the build status
[12:14:58.859] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:58.859] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:136:0) after 1m0s
[12:15:58.934] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:136:0)
[12:15:58.934] Timer tick, asking Buildbucket for the build status
[12:15:59.346] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:59.346] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:137:0) after 1m0s
[12:16:59.368] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:137:0)
[12:16:59.368] Timer tick, asking Buildbucket for the build status
[12:16:59.467] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:59.467] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:138:0) after 1m0s
[12:17:59.524] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:138:0)
[12:17:59.524] Timer tick, asking Buildbucket for the build status
[12:17:59.617] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:59.617] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:139:0) after 1m0s
[12:18:59.660] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:139:0)
[12:18:59.660] Timer tick, asking Buildbucket for the build status
[12:18:59.725] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:59.725] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:140:0) after 1m0s
[12:19:59.753] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:140:0)
[12:19:59.753] Timer tick, asking Buildbucket for the build status
[12:19:59.847] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:59.847] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:141:0) after 1m0s
[12:20:59.882] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:141:0)
[12:20:59.882] Timer tick, asking Buildbucket for the build status
[12:21:00.200] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:00.200] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:142:0) after 1m0s
[12:22:00.189] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:142:0)
[12:22:00.189] Timer tick, asking Buildbucket for the build status
[12:22:00.275] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:00.275] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:143:0) after 1m0s
[12:23:00.365] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:143:0)
[12:23:00.365] Timer tick, asking Buildbucket for the build status
[12:23:00.447] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:00.447] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:144:0) after 1m0s
[12:24:00.501] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:144:0)
[12:24:00.501] Timer tick, asking Buildbucket for the build status
[12:24:00.616] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:00.616] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:145:0) after 1m0s
[12:25:00.638] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:145:0)
[12:25:00.638] Timer tick, asking Buildbucket for the build status
[12:25:00.802] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:00.802] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:146:0) after 1m0s
[12:26:01.824] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:146:0)
[12:26:01.824] Timer tick, asking Buildbucket for the build status
[12:26:02.194] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:02.194] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:147:0) after 1m0s
[12:27:02.231] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:147:0)
[12:27:02.231] Timer tick, asking Buildbucket for the build status
[12:27:02.326] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:02.326] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:148:0) after 1m0s
[12:28:02.361] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:148:0)
[12:28:02.361] Timer tick, asking Buildbucket for the build status
[12:28:02.433] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:02.433] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:149:0) after 1m0s
[12:29:03.470] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:149:0)
[12:29:03.470] Timer tick, asking Buildbucket for the build status
[12:29:03.694] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:03.694] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:150:0) after 1m0s
[12:30:03.730] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:150:0)
[12:30:03.730] Timer tick, asking Buildbucket for the build status
[12:30:03.830] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:03.830] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:151:0) after 1m0s
[12:31:03.871] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:151:0)
[12:31:03.871] Timer tick, asking Buildbucket for the build status
[12:31:03.944] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:03.944] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:152:0) after 1m0s
[12:32:04.008] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:152:0)
[12:32:04.008] Timer tick, asking Buildbucket for the build status
[12:32:04.094] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:04.094] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:153:0) after 1m0s
[12:33:04.149] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:153:0)
[12:33:04.149] Timer tick, asking Buildbucket for the build status
[12:33:04.232] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:04.232] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:154:0) after 1m0s
[12:34:04.313] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:154:0)
[12:34:04.313] Timer tick, asking Buildbucket for the build status
[12:34:04.391] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:04.391] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:155:0) after 1m0s
[12:35:04.508] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:155:0)
[12:35:04.508] Timer tick, asking Buildbucket for the build status
[12:35:04.585] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:04.585] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:156:0) after 1m0s
[12:36:04.658] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:156:0)
[12:36:04.658] Timer tick, asking Buildbucket for the build status
[12:36:04.735] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:04.735] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:157:0) after 1m0s
[12:37:04.747] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:157:0)
[12:37:04.747] Timer tick, asking Buildbucket for the build status
[12:37:05.123] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:05.123] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:158:0) after 1m0s
[12:38:05.147] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:158:0)
[12:38:05.147] Timer tick, asking Buildbucket for the build status
[12:38:05.324] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:05.324] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:159:0) after 1m0s
[12:39:05.348] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:159:0)
[12:39:05.348] Timer tick, asking Buildbucket for the build status
[12:39:05.781] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:05.781] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:160:0) after 1m0s
[12:40:06.599] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:160:0)
[12:40:06.599] Timer tick, asking Buildbucket for the build status
[12:40:06.825] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:06.825] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:161:0) after 1m0s
[12:41:06.847] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:161:0)
[12:41:06.847] Timer tick, asking Buildbucket for the build status
[12:41:06.982] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:06.983] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:162:0) after 1m0s
[12:42:07.007] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:162:0)
[12:42:07.007] Timer tick, asking Buildbucket for the build status
[12:42:07.124] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:07.124] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:163:0) after 1m0s
[12:43:07.175] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:163:0)
[12:43:07.175] Timer tick, asking Buildbucket for the build status
[12:43:07.499] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:07.499] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:164:0) after 1m0s
[12:44:07.534] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:164:0)
[12:44:07.534] Timer tick, asking Buildbucket for the build status
[12:44:07.896] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:07.896] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:165:0) after 1m0s
[12:45:07.928] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:165:0)
[12:45:07.928] Timer tick, asking Buildbucket for the build status
[12:45:08.050] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:08.050] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:166:0) after 1m0s
[12:46:08.081] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:166:0)
[12:46:08.081] Timer tick, asking Buildbucket for the build status
[12:46:08.302] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:08.302] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:167:0) after 1m0s
[12:47:08.314] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:167:0)
[12:47:08.314] Timer tick, asking Buildbucket for the build status
[12:47:08.403] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:08.403] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:168:0) after 1m0s
[12:48:08.434] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:168:0)
[12:48:08.434] Timer tick, asking Buildbucket for the build status
[12:48:08.495] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:08.495] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:169:0) after 1m0s
[12:49:08.535] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:169:0)
[12:49:08.535] Timer tick, asking Buildbucket for the build status
[12:49:08.645] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:08.645] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:170:0) after 1m0s
[12:50:08.671] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:170:0)
[12:50:08.671] Timer tick, asking Buildbucket for the build status
[12:50:08.996] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:08.996] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:171:0) after 1m0s
[12:51:08.998] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:171:0)
[12:51:08.998] Timer tick, asking Buildbucket for the build status
[12:51:09.088] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:09.088] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:172:0) after 1m0s
[12:52:09.137] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:172:0)
[12:52:09.137] Timer tick, asking Buildbucket for the build status
[12:52:09.311] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:09.311] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:173:0) after 1m0s
[12:53:09.347] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:173:0)
[12:53:09.347] Timer tick, asking Buildbucket for the build status
[12:53:09.593] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:09.593] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:174:0) after 1m0s
[12:54:09.641] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:174:0)
[12:54:09.641] Timer tick, asking Buildbucket for the build status
[12:54:09.793] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:09.793] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:175:0) after 1m0s
[12:55:09.909] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:175:0)
[12:55:09.909] Timer tick, asking Buildbucket for the build status
[12:55:09.981] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:09.981] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:176:0) after 1m0s
[12:56:10.312] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:176:0)
[12:56:10.312] Timer tick, asking Buildbucket for the build status
[12:56:10.459] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:10.459] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:177:0) after 1m0s
[12:57:10.593] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:177:0)
[12:57:10.593] Timer tick, asking Buildbucket for the build status
[12:57:10.823] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:10.823] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:178:0) after 1m0s
[12:58:10.850] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:178:0)
[12:58:10.850] Timer tick, asking Buildbucket for the build status
[12:58:10.928] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:10.928] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:179:0) after 1m0s
[12:59:11.076] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:179:0)
[12:59:11.076] Timer tick, asking Buildbucket for the build status
[12:59:11.142] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:11.142] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:180:0) after 1m0s
[13:00:11.229] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:180:0)
[13:00:11.229] Timer tick, asking Buildbucket for the build status
[13:00:11.330] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:11.330] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:181:0) after 1m0s
[13:01:11.427] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:181:0)
[13:01:11.427] Timer tick, asking Buildbucket for the build status
[13:01:11.510] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:11.510] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:182:0) after 1m0s
[13:02:11.774] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:182:0)
[13:02:11.774] Timer tick, asking Buildbucket for the build status
[13:02:11.886] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:11.886] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:183:0) after 1m0s
[13:03:11.917] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:183:0)
[13:03:11.917] Timer tick, asking Buildbucket for the build status
[13:03:12.005] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:12.005] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:184:0) after 1m0s
[13:04:12.289] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:184:0)
[13:04:12.289] Timer tick, asking Buildbucket for the build status
[13:04:12.377] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:12.378] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:185:0) after 1m0s
[13:05:12.787] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:185:0)
[13:05:12.787] Timer tick, asking Buildbucket for the build status
[13:05:13.948] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:13.948] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:186:0) after 1m0s
[13:06:14.405] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:186:0)
[13:06:14.405] Timer tick, asking Buildbucket for the build status
[13:06:14.527] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:14.527] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:187:0) after 1m0s
[13:07:14.709] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:187:0)
[13:07:14.709] Timer tick, asking Buildbucket for the build status
[13:07:16.841] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:16.841] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:188:0) after 1m0s
[13:08:17.069] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:188:0)
[13:08:17.070] Timer tick, asking Buildbucket for the build status
[13:08:17.149] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:17.149] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:189:0) after 1m0s
[13:09:17.246] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:189:0)
[13:09:17.246] Timer tick, asking Buildbucket for the build status
[13:09:17.616] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:17.616] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:190:0) after 1m0s
[13:10:17.828] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:190:0)
[13:10:17.828] Timer tick, asking Buildbucket for the build status
[13:10:17.896] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:17.896] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:191:0) after 1m0s
[13:11:18.013] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:191:0)
[13:11:18.013] Timer tick, asking Buildbucket for the build status
[13:11:18.189] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:18.189] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:192:0) after 1m0s
[13:12:18.334] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:192:0)
[13:12:18.334] Timer tick, asking Buildbucket for the build status
[13:12:18.496] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:18.496] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:193:0) after 1m0s
[13:13:18.714] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:193:0)
[13:13:18.714] Timer tick, asking Buildbucket for the build status
[13:13:18.815] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:18.815] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:194:0) after 1m0s
[13:14:19.054] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:194:0)
[13:14:19.054] Timer tick, asking Buildbucket for the build status
[13:14:19.130] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:19.130] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:195:0) after 1m0s
[13:15:19.133] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:195:0)
[13:15:19.133] Timer tick, asking Buildbucket for the build status
[13:15:19.223] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:19.223] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:196:0) after 1m0s
[13:16:19.309] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:196:0)
[13:16:19.309] Timer tick, asking Buildbucket for the build status
[13:16:19.433] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:19.433] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:197:0) after 1m0s
[13:17:19.596] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:197:0)
[13:17:19.596] Timer tick, asking Buildbucket for the build status
[13:17:20.012] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:20.012] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:198:0) after 1m0s
[13:18:20.073] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:198:0)
[13:18:20.073] Timer tick, asking Buildbucket for the build status
[13:18:20.444] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:20.444] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:199:0) after 1m0s
[13:19:20.480] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:199:0)
[13:19:20.480] Timer tick, asking Buildbucket for the build status
[13:19:20.576] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:20.576] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:200:0) after 1m0s
[13:20:20.604] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:200:0)
[13:20:20.604] Timer tick, asking Buildbucket for the build status
[13:20:21.066] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:21.066] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:201:0) after 1m0s
[13:21:21.181] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:201:0)
[13:21:21.181] Timer tick, asking Buildbucket for the build status
[13:21:21.267] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:21.267] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:202:0) after 1m0s
[13:22:21.325] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:202:0)
[13:22:21.325] Timer tick, asking Buildbucket for the build status
[13:22:21.424] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:21.424] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:203:0) after 1m0s
[13:23:21.453] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:203:0)
[13:23:21.453] Timer tick, asking Buildbucket for the build status
[13:23:21.634] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:21.634] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:204:0) after 1m0s
[13:24:21.673] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:204:0)
[13:24:21.673] Timer tick, asking Buildbucket for the build status
[13:24:22.132] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:22.132] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:205:0) after 1m0s
[13:25:22.166] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:205:0)
[13:25:22.166] Timer tick, asking Buildbucket for the build status
[13:25:22.265] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:22.265] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:206:0) after 1m0s
[13:26:22.295] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:206:0)
[13:26:22.295] Timer tick, asking Buildbucket for the build status
[13:26:22.635] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:22.635] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:207:0) after 1m0s
[13:27:22.719] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:207:0)
[13:27:22.719] Timer tick, asking Buildbucket for the build status
[13:27:22.817] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:22.817] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:208:0) after 1m0s
[13:28:22.900] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:208:0)
[13:28:22.900] Timer tick, asking Buildbucket for the build status
[13:28:23.015] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:23.015] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:209:0) after 1m0s
[13:29:23.092] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:209:0)
[13:29:23.092] Timer tick, asking Buildbucket for the build status
[13:29:23.272] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:23.272] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:210:0) after 1m0s
[13:30:23.380] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:210:0)
[13:30:23.380] Timer tick, asking Buildbucket for the build status
[13:30:23.486] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:23.486] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:211:0) after 1m0s
[13:31:23.560] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:211:0)
[13:31:23.561] Timer tick, asking Buildbucket for the build status
[13:31:23.971] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:23.971] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:212:0) after 1m0s
[13:32:24.043] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:212:0)
[13:32:24.043] Timer tick, asking Buildbucket for the build status
[13:32:24.164] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:24.164] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:213:0) after 1m0s
[13:33:24.347] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:213:0)
[13:33:24.347] Timer tick, asking Buildbucket for the build status
[13:33:24.448] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:24.448] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:214:0) after 1m0s
[13:34:24.614] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:214:0)
[13:34:24.614] Timer tick, asking Buildbucket for the build status
[13:34:24.684] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:24.684] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:215:0) after 1m0s
[13:35:24.704] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:215:0)
[13:35:24.704] Timer tick, asking Buildbucket for the build status
[13:35:24.777] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:24.777] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:216:0) after 1m0s
[13:36:24.808] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:216:0)
[13:36:24.808] Timer tick, asking Buildbucket for the build status
[13:36:24.880] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:24.880] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:217:0) after 1m0s
[13:37:24.949] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:217:0)
[13:37:24.949] Timer tick, asking Buildbucket for the build status
[13:37:25.048] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:25.048] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:218:0) after 1m0s
[13:38:25.117] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:218:0)
[13:38:25.117] Timer tick, asking Buildbucket for the build status
[13:38:25.448] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:25.448] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:219:0) after 1m0s
[13:39:25.475] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:219:0)
[13:39:25.475] Timer tick, asking Buildbucket for the build status
[13:39:25.818] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:25.818] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:220:0) after 1m0s
[13:40:25.849] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:220:0)
[13:40:25.849] Timer tick, asking Buildbucket for the build status
[13:40:26.264] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:26.264] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:221:0) after 1m0s
[13:41:26.290] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:221:0)
[13:41:26.290] Timer tick, asking Buildbucket for the build status
[13:41:26.372] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:26.372] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:222:0) after 1m0s
[13:42:26.389] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:222:0)
[13:42:26.389] Timer tick, asking Buildbucket for the build status
[13:42:26.473] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:26.473] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:223:0) after 1m0s
[13:43:26.509] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:223:0)
[13:43:26.509] Timer tick, asking Buildbucket for the build status
[13:43:26.584] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:26.584] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:224:0) after 1m0s
[13:44:26.594] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:224:0)
[13:44:26.594] Timer tick, asking Buildbucket for the build status
[13:44:26.745] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:26.745] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:225:0) after 1m0s
[13:45:26.840] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:225:0)
[13:45:26.840] Timer tick, asking Buildbucket for the build status
[13:45:29.370] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:29.370] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:226:0) after 1m0s
[13:46:29.395] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:226:0)
[13:46:29.395] Timer tick, asking Buildbucket for the build status
[13:46:29.483] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:29.484] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:227:0) after 1m0s
[13:47:29.515] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:227:0)
[13:47:29.515] Timer tick, asking Buildbucket for the build status
[13:47:29.608] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:29.608] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:228:0) after 1m0s
[13:48:29.793] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:228:0)
[13:48:29.793] Timer tick, asking Buildbucket for the build status
[13:48:29.941] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:29.941] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:229:0) after 1m0s
[13:49:30.076] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:229:0)
[13:49:30.076] Timer tick, asking Buildbucket for the build status
[13:49:30.150] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:30.150] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:230:0) after 1m0s
[13:50:30.189] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:230:0)
[13:50:30.189] Timer tick, asking Buildbucket for the build status
[13:50:30.363] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:30.363] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:231:0) after 1m0s
[13:51:30.415] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:231:0)
[13:51:30.415] Timer tick, asking Buildbucket for the build status
[13:51:30.602] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:30.602] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:232:0) after 1m0s
[13:52:30.629] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:232:0)
[13:52:30.629] Timer tick, asking Buildbucket for the build status
[13:52:30.695] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:30.695] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:233:0) after 1m0s
[13:53:30.712] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:233:0)
[13:53:30.712] Timer tick, asking Buildbucket for the build status
[13:53:31.364] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:31.364] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:234:0) after 1m0s
[13:54:31.349] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:234:0)
[13:54:31.349] Timer tick, asking Buildbucket for the build status
[13:54:32.095] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:32.095] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:235:0) after 1m0s
[13:55:32.165] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:235:0)
[13:55:32.165] Timer tick, asking Buildbucket for the build status
[13:55:32.246] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:32.246] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:236:0) after 1m0s
[13:56:32.269] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:236:0)
[13:56:32.269] Timer tick, asking Buildbucket for the build status
[13:56:32.689] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:32.689] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:237:0) after 1m0s
[13:57:32.798] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:237:0)
[13:57:32.798] Timer tick, asking Buildbucket for the build status
[13:57:32.890] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:32.890] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:238:0) after 1m0s
[13:58:32.950] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:238:0)
[13:58:32.950] Timer tick, asking Buildbucket for the build status
[13:58:33.027] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:33.027] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:239:0) after 1m0s
[13:59:33.043] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:239:0)
[13:59:33.043] Timer tick, asking Buildbucket for the build status
[13:59:33.122] Build 8854876348156435136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:33.122] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020306410151727168:240:0) after 1m0s
[13:59:57.356] Received PubSub notification, asking Buildbucket for the build status
[13:59:57.434] Build 8854876348156435136: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[13:59:57.434] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613743196394276",
"created_by": "project:chromium",
"created_ts": "1613728874018123",
"id": "8854876348156435136",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b9fdcea4807d0db240c842a233d0bcf4a270666a\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"b9fdcea4807d0db240c842a233d0bcf4a270666a\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"win-dbg-9-wqii\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 1624, \"got_angle_revision\": \"fd132e4e7a9c84333b4fb4730f79367fe75f53e7\", \"got_dawn_revision\": \"0b17eb8e19c886680b12b73ba28de8d30adccda9\", \"got_nacl_revision\": \"8a92e6ba1b6d62631f8d3ba3f4f8872ae8b6cca1\", \"got_revision\": \"b9fdcea4807d0db240c842a233d0bcf4a270666a\", \"got_revision_cp\": \"refs/heads/master@{#855659}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"8603b126b3d599f0ab8781163729fd226a93cf17\", \"got_v8_revision\": \"aaf128851c4dd86978eaf9d41ce297c5af31597f\", \"got_v8_revision_cp\": \"refs/heads/9.0.217@{#1}\", \"got_webrtc_revision\": \"735e33fae0a06ae05a9c0be6f5d8b06a6ad820a4\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33297}\", \"mirrored_builders\": [\"tryserver.chromium:win-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b9fdcea4807d0db240c842a233d0bcf4a270666a\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_9b3ebe5fd1c5be87380c40d216747346a59b28cf26de183f0e8e2b32e944d3c8_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-9-wqii\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5706-397711c\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1613728989301503",
"status": "COMPLETED",
"status_changed_ts": "1613743196819592",
"tags": [
"build_address:luci.chromium.ci/win-official/1624",
"builder:win-official",
"buildset:commit/git/b9fdcea4807d0db240c842a233d0bcf4a270666a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b9fdcea4807d0db240c842a233d0bcf4a270666a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020306410151727168",
"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/8854876348156435136/+/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:51d28e0e463cd410",
"user_agent:luci-scheduler"
],
"updated_ts": "1613743196864055",
"url": "https://ci.chromium.org/b/8854876348156435136",
"utcnow_ts": "1613743197426661"
}
}
[13:59:57.434] Invocation finished in 3h58m44.70287692s with status SUCCEEDED