[06:50:12.159] New invocation is queued and will start shortly
[06:50:13.286] Starting the invocation (attempt 1)
[06:50:13.321] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:50:13.321] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:50:13.321] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019774845650187792",
"parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d42ce26c376c7667f3247739dea92e34f27f8c90\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-official",
"scheduler_invocation_id:9019774845650187792",
"scheduler_job_id:chromium/win-official",
"user_agent:luci-scheduler",
"buildset:commit/git/d42ce26c376c7667f3247739dea92e34f27f8c90",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d42ce26c376c7667f3247739dea92e34f27f8c90",
"gitiles_ref:refs/heads/master"
]
}
[06:50:14.228] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614235813415105",
"id": "8854344783670575584",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d42ce26c376c7667f3247739dea92e34f27f8c90\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614235814068884",
"tags": [
"build_address:luci.chromium.ci/win-official/1655",
"builder:win-official",
"buildset:commit/git/d42ce26c376c7667f3247739dea92e34f27f8c90",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d42ce26c376c7667f3247739dea92e34f27f8c90",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019774845650187792",
"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/8854344783670575584/+/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": "1614235814069050",
"url": "https://ci.chromium.org/b/8854344783670575584",
"utcnow_ts": "1614235814221149"
}
}
[06:50:14.228] Task URL: https://ci.chromium.org/b/8854344783670575584
[06:50:14.228] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:2:0) after 1m0s
[06:50:47.799] Received PubSub notification, asking Buildbucket for the build status
[06:50:47.871] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:14.248] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:2:0)
[06:51:14.248] Timer tick, asking Buildbucket for the build status
[06:51:14.451] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:14.451] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:4:0) after 1m0s
[06:52:14.468] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:4:0)
[06:52:14.468] Timer tick, asking Buildbucket for the build status
[06:52:14.536] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:14.536] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:5:0) after 1m0s
[06:53:14.556] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:5:0)
[06:53:14.556] Timer tick, asking Buildbucket for the build status
[06:53:14.623] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:14.623] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:6:0) after 1m0s
[06:54:14.639] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:6:0)
[06:54:14.639] Timer tick, asking Buildbucket for the build status
[06:54:14.793] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:14.793] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:7:0) after 1m0s
[06:55:14.778] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:7:0)
[06:55:14.778] Timer tick, asking Buildbucket for the build status
[06:55:14.853] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:14.853] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:8:0) after 1m0s
[06:56:14.896] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:8:0)
[06:56:14.896] Timer tick, asking Buildbucket for the build status
[06:56:15.020] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:15.020] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:9:0) after 1m0s
[06:57:15.061] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:9:0)
[06:57:15.061] Timer tick, asking Buildbucket for the build status
[06:57:15.259] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:15.259] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:10:0) after 1m0s
[06:58:15.287] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:10:0)
[06:58:15.287] Timer tick, asking Buildbucket for the build status
[06:58:15.378] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:15.378] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:11:0) after 1m0s
[06:59:15.454] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:11:0)
[06:59:15.454] Timer tick, asking Buildbucket for the build status
[06:59:15.528] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:15.528] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:12:0) after 1m0s
[07:00:15.677] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:12:0)
[07:00:15.677] Timer tick, asking Buildbucket for the build status
[07:00:15.789] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:15.789] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:13:0) after 1m0s
[07:01:16.033] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:13:0)
[07:01:16.033] Timer tick, asking Buildbucket for the build status
[07:01:16.154] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:16.155] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:14:0) after 1m0s
[07:02:16.206] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:14:0)
[07:02:16.206] Timer tick, asking Buildbucket for the build status
[07:02:16.298] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:16.298] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:15:0) after 1m0s
[07:03:16.531] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:15:0)
[07:03:16.531] Timer tick, asking Buildbucket for the build status
[07:03:16.631] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:16.631] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:16:0) after 1m0s
[07:04:16.852] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:16:0)
[07:04:16.852] Timer tick, asking Buildbucket for the build status
[07:04:16.935] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:16.935] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:17:0) after 1m0s
[07:05:17.175] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:17:0)
[07:05:17.175] Timer tick, asking Buildbucket for the build status
[07:05:17.284] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:17.284] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:18:0) after 1m0s
[07:06:17.540] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:18:0)
[07:06:17.540] Timer tick, asking Buildbucket for the build status
[07:06:17.661] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:17.661] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:19:0) after 1m0s
[07:07:17.670] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:19:0)
[07:07:17.670] Timer tick, asking Buildbucket for the build status
[07:07:17.823] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:17.823] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:20:0) after 1m0s
[07:08:17.818] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:20:0)
[07:08:17.818] Timer tick, asking Buildbucket for the build status
[07:08:17.962] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:17.962] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:21:0) after 1m0s
[07:09:18.023] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:21:0)
[07:09:18.023] Timer tick, asking Buildbucket for the build status
[07:09:18.192] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:18.192] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:22:0) after 1m0s
[07:10:18.305] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:22:0)
[07:10:18.305] Timer tick, asking Buildbucket for the build status
[07:10:18.432] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:18.432] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:23:0) after 1m0s
[07:11:18.451] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:23:0)
[07:11:18.451] Timer tick, asking Buildbucket for the build status
[07:11:18.549] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:18.549] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:24:0) after 1m0s
[07:12:18.617] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:24:0)
[07:12:18.617] Timer tick, asking Buildbucket for the build status
[07:12:18.718] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:18.718] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:25:0) after 1m0s
[07:13:18.716] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:25:0)
[07:13:18.716] Timer tick, asking Buildbucket for the build status
[07:13:19.040] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:19.040] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:26:0) after 1m0s
[07:14:19.067] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:26:0)
[07:14:19.068] Timer tick, asking Buildbucket for the build status
[07:14:19.142] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:19.142] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:27:0) after 1m0s
[07:15:19.111] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:27:0)
[07:15:19.111] Timer tick, asking Buildbucket for the build status
[07:15:19.288] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:19.288] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:28:0) after 1m0s
[07:16:19.321] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:28:0)
[07:16:19.321] Timer tick, asking Buildbucket for the build status
[07:16:19.421] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:19.421] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:29:0) after 1m0s
[07:17:19.443] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:29:0)
[07:17:19.443] Timer tick, asking Buildbucket for the build status
[07:17:19.517] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:19.517] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:30:0) after 1m0s
[07:18:19.537] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:30:0)
[07:18:19.537] Timer tick, asking Buildbucket for the build status
[07:18:19.638] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:19.638] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:31:0) after 1m0s
[07:19:19.696] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:31:0)
[07:19:19.696] Timer tick, asking Buildbucket for the build status
[07:19:19.871] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:19.871] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:32:0) after 1m0s
[07:20:19.965] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:32:0)
[07:20:19.965] Timer tick, asking Buildbucket for the build status
[07:20:20.280] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:20.280] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:33:0) after 1m0s
[07:21:20.347] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:33:0)
[07:21:20.347] Timer tick, asking Buildbucket for the build status
[07:21:20.666] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:20.666] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:34:0) after 1m0s
[07:22:20.750] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:34:0)
[07:22:20.750] Timer tick, asking Buildbucket for the build status
[07:22:21.016] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:21.016] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:35:0) after 1m0s
[07:23:21.130] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:35:0)
[07:23:21.130] Timer tick, asking Buildbucket for the build status
[07:23:21.222] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:21.222] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:36:0) after 1m0s
[07:24:21.335] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:36:0)
[07:24:21.335] Timer tick, asking Buildbucket for the build status
[07:24:21.415] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:21.415] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:37:0) after 1m0s
[07:25:21.517] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:37:0)
[07:25:21.517] Timer tick, asking Buildbucket for the build status
[07:25:21.587] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:21.587] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:38:0) after 1m0s
[07:26:21.657] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:38:0)
[07:26:21.657] Timer tick, asking Buildbucket for the build status
[07:26:21.856] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:21.856] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:39:0) after 1m0s
[07:27:21.897] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:39:0)
[07:27:21.897] Timer tick, asking Buildbucket for the build status
[07:27:22.082] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:22.082] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:40:0) after 1m0s
[07:28:22.265] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:40:0)
[07:28:22.265] Timer tick, asking Buildbucket for the build status
[07:28:22.471] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:22.471] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:41:0) after 1m0s
[07:29:22.492] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:41:0)
[07:29:22.492] Timer tick, asking Buildbucket for the build status
[07:29:22.714] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:22.714] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:42:0) after 1m0s
[07:30:22.810] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:42:0)
[07:30:22.810] Timer tick, asking Buildbucket for the build status
[07:30:22.889] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:22.889] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:43:0) after 1m0s
[07:31:22.915] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:43:0)
[07:31:22.915] Timer tick, asking Buildbucket for the build status
[07:31:23.049] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:23.049] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:44:0) after 1m0s
[07:32:23.088] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:44:0)
[07:32:23.088] Timer tick, asking Buildbucket for the build status
[07:32:23.207] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:23.207] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:45:0) after 1m0s
[07:33:23.245] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:45:0)
[07:33:23.245] Timer tick, asking Buildbucket for the build status
[07:33:23.404] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:23.404] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:46:0) after 1m0s
[07:34:23.551] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:46:0)
[07:34:23.551] Timer tick, asking Buildbucket for the build status
[07:34:23.644] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:23.644] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:47:0) after 1m0s
[07:35:23.616] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:47:0)
[07:35:23.616] Timer tick, asking Buildbucket for the build status
[07:35:23.685] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:23.685] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:48:0) after 1m0s
[07:36:23.738] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:48:0)
[07:36:23.738] Timer tick, asking Buildbucket for the build status
[07:36:23.845] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:23.845] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:49:0) after 1m0s
[07:37:23.869] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:49:0)
[07:37:23.869] Timer tick, asking Buildbucket for the build status
[07:37:23.964] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:23.964] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:50:0) after 1m0s
[07:38:24.038] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:50:0)
[07:38:24.038] Timer tick, asking Buildbucket for the build status
[07:38:24.307] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:24.307] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:51:0) after 1m0s
[07:39:24.297] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:51:0)
[07:39:24.297] Timer tick, asking Buildbucket for the build status
[07:39:24.390] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:24.390] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:52:0) after 1m0s
[07:40:24.479] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:52:0)
[07:40:24.479] Timer tick, asking Buildbucket for the build status
[07:40:24.802] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:24.802] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:53:0) after 1m0s
[07:41:24.827] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:53:0)
[07:41:24.827] Timer tick, asking Buildbucket for the build status
[07:41:24.916] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:24.916] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:54:0) after 1m0s
[07:42:24.972] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:54:0)
[07:42:24.972] Timer tick, asking Buildbucket for the build status
[07:42:25.068] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:25.068] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:55:0) after 1m0s
[07:43:25.091] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:55:0)
[07:43:25.091] Timer tick, asking Buildbucket for the build status
[07:43:25.324] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:25.324] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:56:0) after 1m0s
[07:44:25.441] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:56:0)
[07:44:25.441] Timer tick, asking Buildbucket for the build status
[07:44:25.802] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:25.802] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:57:0) after 1m0s
[07:45:25.835] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:57:0)
[07:45:25.835] Timer tick, asking Buildbucket for the build status
[07:45:25.928] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:25.928] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:58:0) after 1m0s
[07:46:25.938] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:58:0)
[07:46:25.938] Timer tick, asking Buildbucket for the build status
[07:46:26.055] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:26.055] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:59:0) after 1m0s
[07:47:26.120] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:59:0)
[07:47:26.120] Timer tick, asking Buildbucket for the build status
[07:47:26.194] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:26.194] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:60:0) after 1m0s
[07:48:26.236] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:60:0)
[07:48:26.236] Timer tick, asking Buildbucket for the build status
[07:48:26.413] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:26.413] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:61:0) after 1m0s
[07:49:26.434] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:61:0)
[07:49:26.434] Timer tick, asking Buildbucket for the build status
[07:49:26.524] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:26.524] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:62:0) after 1m0s
[07:50:26.543] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:62:0)
[07:50:26.543] Timer tick, asking Buildbucket for the build status
[07:50:26.629] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:26.629] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:63:0) after 1m0s
[07:51:26.647] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:63:0)
[07:51:26.647] Timer tick, asking Buildbucket for the build status
[07:51:26.916] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:26.916] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:64:0) after 1m0s
[07:52:26.949] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:64:0)
[07:52:26.949] Timer tick, asking Buildbucket for the build status
[07:52:27.133] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:27.133] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:65:0) after 1m0s
[07:53:27.149] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:65:0)
[07:53:27.149] Timer tick, asking Buildbucket for the build status
[07:53:27.229] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:27.229] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:66:0) after 1m0s
[07:54:27.240] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:66:0)
[07:54:27.240] Timer tick, asking Buildbucket for the build status
[07:54:27.341] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:27.341] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:67:0) after 1m0s
[07:55:27.387] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:67:0)
[07:55:27.387] Timer tick, asking Buildbucket for the build status
[07:55:27.572] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:27.572] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:68:0) after 1m0s
[07:56:27.591] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:68:0)
[07:56:27.591] Timer tick, asking Buildbucket for the build status
[07:56:27.766] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:27.766] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:69:0) after 1m0s
[07:57:27.790] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:69:0)
[07:57:27.790] Timer tick, asking Buildbucket for the build status
[07:57:28.174] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:28.174] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:70:0) after 1m0s
[07:58:28.209] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:70:0)
[07:58:28.209] Timer tick, asking Buildbucket for the build status
[07:58:28.280] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:28.280] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:71:0) after 1m0s
[07:59:28.320] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:71:0)
[07:59:28.320] Timer tick, asking Buildbucket for the build status
[07:59:28.420] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:28.421] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:72:0) after 1m0s
[08:00:28.461] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:72:0)
[08:00:28.461] Timer tick, asking Buildbucket for the build status
[08:00:28.620] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:28.620] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:73:0) after 1m0s
[08:01:29.059] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:73:0)
[08:01:29.059] Timer tick, asking Buildbucket for the build status
[08:01:29.824] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:29.824] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:74:0) after 1m0s
[08:02:30.341] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:74:0)
[08:02:30.342] Timer tick, asking Buildbucket for the build status
[08:02:30.798] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:30.799] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:75:0) after 1m0s
[08:03:31.003] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:75:0)
[08:03:31.003] Timer tick, asking Buildbucket for the build status
[08:03:31.197] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:31.197] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:76:0) after 1m0s
[08:04:31.336] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:76:0)
[08:04:31.336] Timer tick, asking Buildbucket for the build status
[08:04:31.427] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:31.427] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:77:0) after 1m0s
[08:05:31.639] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:77:0)
[08:05:31.639] Timer tick, asking Buildbucket for the build status
[08:05:31.726] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:31.726] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:78:0) after 1m0s
[08:06:32.027] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:78:0)
[08:06:32.027] Timer tick, asking Buildbucket for the build status
[08:06:32.134] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:32.134] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:79:0) after 1m0s
[08:07:32.232] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:79:0)
[08:07:32.232] Timer tick, asking Buildbucket for the build status
[08:07:32.389] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:32.389] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:80:0) after 1m0s
[08:08:32.457] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:80:0)
[08:08:32.457] Timer tick, asking Buildbucket for the build status
[08:08:32.520] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:32.520] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:81:0) after 1m0s
[08:09:32.586] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:81:0)
[08:09:32.586] Timer tick, asking Buildbucket for the build status
[08:09:32.669] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:32.669] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:82:0) after 1m0s
[08:10:32.694] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:82:0)
[08:10:32.694] Timer tick, asking Buildbucket for the build status
[08:10:32.774] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:32.775] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:83:0) after 1m0s
[08:11:32.799] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:83:0)
[08:11:32.799] Timer tick, asking Buildbucket for the build status
[08:11:33.111] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:33.111] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:84:0) after 1m0s
[08:12:33.126] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:84:0)
[08:12:33.126] Timer tick, asking Buildbucket for the build status
[08:12:33.195] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:33.195] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:85:0) after 1m0s
[08:13:33.223] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:85:0)
[08:13:33.223] Timer tick, asking Buildbucket for the build status
[08:13:33.287] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:33.287] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:86:0) after 1m0s
[08:14:33.315] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:86:0)
[08:14:33.315] Timer tick, asking Buildbucket for the build status
[08:14:33.511] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:33.511] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:87:0) after 1m0s
[08:15:33.529] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:87:0)
[08:15:33.529] Timer tick, asking Buildbucket for the build status
[08:15:33.613] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:33.613] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:88:0) after 1m0s
[08:16:33.665] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:88:0)
[08:16:33.665] Timer tick, asking Buildbucket for the build status
[08:16:33.835] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:33.835] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:89:0) after 1m0s
[08:17:33.873] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:89:0)
[08:17:33.873] Timer tick, asking Buildbucket for the build status
[08:17:33.950] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:33.951] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:90:0) after 1m0s
[08:18:33.989] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:90:0)
[08:18:33.989] Timer tick, asking Buildbucket for the build status
[08:18:34.175] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:34.175] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:91:0) after 1m0s
[08:19:34.167] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:91:0)
[08:19:34.167] Timer tick, asking Buildbucket for the build status
[08:19:34.565] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:34.565] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:92:0) after 1m0s
[08:20:34.564] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:92:0)
[08:20:34.564] Timer tick, asking Buildbucket for the build status
[08:20:34.653] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:34.653] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:93:0) after 1m0s
[08:21:34.728] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:93:0)
[08:21:34.728] Timer tick, asking Buildbucket for the build status
[08:21:34.846] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:34.846] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:94:0) after 1m0s
[08:22:34.898] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:94:0)
[08:22:34.898] Timer tick, asking Buildbucket for the build status
[08:22:35.057] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:35.057] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:95:0) after 1m0s
[08:23:35.140] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:95:0)
[08:23:35.140] Timer tick, asking Buildbucket for the build status
[08:23:35.214] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:35.215] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:96:0) after 1m0s
[08:24:35.279] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:96:0)
[08:24:35.279] Timer tick, asking Buildbucket for the build status
[08:24:35.354] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:35.354] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:97:0) after 1m0s
[08:25:35.378] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:97:0)
[08:25:35.378] Timer tick, asking Buildbucket for the build status
[08:25:35.587] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:35.587] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:98:0) after 1m0s
[08:26:35.590] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:98:0)
[08:26:35.590] Timer tick, asking Buildbucket for the build status
[08:26:35.713] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:35.713] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:99:0) after 1m0s
[08:27:35.884] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:99:0)
[08:27:35.884] Timer tick, asking Buildbucket for the build status
[08:27:35.966] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:35.966] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:100:0) after 1m0s
[08:28:36.042] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:100:0)
[08:28:36.042] Timer tick, asking Buildbucket for the build status
[08:28:36.117] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:36.118] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:101:0) after 1m0s
[08:29:36.111] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:101:0)
[08:29:36.111] Timer tick, asking Buildbucket for the build status
[08:29:36.312] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:36.312] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:102:0) after 1m0s
[08:30:36.304] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:102:0)
[08:30:36.304] Timer tick, asking Buildbucket for the build status
[08:30:36.487] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:36.487] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:103:0) after 1m0s
[08:31:36.537] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:103:0)
[08:31:36.537] Timer tick, asking Buildbucket for the build status
[08:31:36.686] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:36.686] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:104:0) after 1m0s
[08:32:36.718] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:104:0)
[08:32:36.718] Timer tick, asking Buildbucket for the build status
[08:32:36.892] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:36.892] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:105:0) after 1m0s
[08:33:36.921] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:105:0)
[08:33:36.921] Timer tick, asking Buildbucket for the build status
[08:33:37.007] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:37.007] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:106:0) after 1m0s
[08:34:37.034] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:106:0)
[08:34:37.034] Timer tick, asking Buildbucket for the build status
[08:34:37.140] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:37.140] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:107:0) after 1m0s
[08:35:37.300] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:107:0)
[08:35:37.300] Timer tick, asking Buildbucket for the build status
[08:35:37.562] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:37.562] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:108:0) after 1m0s
[08:36:37.591] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:108:0)
[08:36:37.591] Timer tick, asking Buildbucket for the build status
[08:36:37.683] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:37.683] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:109:0) after 1m0s
[08:37:37.735] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:109:0)
[08:37:37.735] Timer tick, asking Buildbucket for the build status
[08:37:38.000] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:38.000] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:110:0) after 1m0s
[08:38:38.096] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:110:0)
[08:38:38.096] Timer tick, asking Buildbucket for the build status
[08:38:38.297] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:38.297] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:111:0) after 1m0s
[08:39:38.336] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:111:0)
[08:39:38.336] Timer tick, asking Buildbucket for the build status
[08:39:38.408] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:38.408] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:112:0) after 1m0s
[08:40:38.474] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:112:0)
[08:40:38.474] Timer tick, asking Buildbucket for the build status
[08:40:38.789] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:38.789] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:113:0) after 1m0s
[08:41:38.823] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:113:0)
[08:41:38.823] Timer tick, asking Buildbucket for the build status
[08:41:38.917] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:38.917] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:114:0) after 1m0s
[08:42:39.012] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:114:0)
[08:42:39.012] Timer tick, asking Buildbucket for the build status
[08:42:39.127] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:39.127] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:115:0) after 1m0s
[08:43:39.161] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:115:0)
[08:43:39.161] Timer tick, asking Buildbucket for the build status
[08:43:39.329] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:39.329] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:116:0) after 1m0s
[08:44:39.484] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:116:0)
[08:44:39.484] Timer tick, asking Buildbucket for the build status
[08:44:39.551] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:39.551] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:117:0) after 1m0s
[08:45:39.683] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:117:0)
[08:45:39.683] Timer tick, asking Buildbucket for the build status
[08:45:39.772] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:39.772] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:118:0) after 1m0s
[08:46:39.828] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:118:0)
[08:46:39.828] Timer tick, asking Buildbucket for the build status
[08:46:39.900] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:39.900] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:119:0) after 1m0s
[08:47:39.888] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:119:0)
[08:47:39.888] Timer tick, asking Buildbucket for the build status
[08:47:41.881] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:41.881] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:120:0) after 1m0s
[08:48:41.901] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:120:0)
[08:48:41.901] Timer tick, asking Buildbucket for the build status
[08:48:41.990] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:41.990] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:121:0) after 1m0s
[08:49:42.064] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:121:0)
[08:49:42.064] Timer tick, asking Buildbucket for the build status
[08:49:42.146] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:42.146] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:122:0) after 1m0s
[08:50:42.166] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:122:0)
[08:50:42.166] Timer tick, asking Buildbucket for the build status
[08:50:42.243] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:42.243] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:123:0) after 1m0s
[08:51:42.502] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:123:0)
[08:51:42.502] Timer tick, asking Buildbucket for the build status
[08:51:42.579] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:42.579] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:124:0) after 1m0s
[08:52:43.203] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:124:0)
[08:52:43.203] Timer tick, asking Buildbucket for the build status
[08:52:43.307] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:43.307] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:125:0) after 1m0s
[08:53:43.432] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:125:0)
[08:53:43.432] Timer tick, asking Buildbucket for the build status
[08:53:43.797] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:43.797] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:126:0) after 1m0s
[08:54:43.895] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:126:0)
[08:54:43.895] Timer tick, asking Buildbucket for the build status
[08:54:43.967] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:43.967] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:127:0) after 1m0s
[08:55:44.047] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:127:0)
[08:55:44.047] Timer tick, asking Buildbucket for the build status
[08:55:44.116] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:44.116] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:128:0) after 1m0s
[08:56:44.117] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:128:0)
[08:56:44.117] Timer tick, asking Buildbucket for the build status
[08:56:44.199] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:44.199] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:129:0) after 1m0s
[08:57:44.257] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:129:0)
[08:57:44.257] Timer tick, asking Buildbucket for the build status
[08:57:44.358] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:44.358] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:130:0) after 1m0s
[08:58:45.486] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:130:0)
[08:58:45.486] Timer tick, asking Buildbucket for the build status
[08:58:45.782] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:45.782] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:131:0) after 1m0s
[08:59:45.831] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:131:0)
[08:59:45.831] Timer tick, asking Buildbucket for the build status
[08:59:46.070] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:46.070] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:132:0) after 1m0s
[09:00:46.114] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:132:0)
[09:00:46.114] Timer tick, asking Buildbucket for the build status
[09:00:46.218] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:46.218] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:133:0) after 1m0s
[09:01:46.242] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:133:0)
[09:01:46.242] Timer tick, asking Buildbucket for the build status
[09:01:46.334] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:46.334] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:134:0) after 1m0s
[09:02:46.379] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:134:0)
[09:02:46.379] Timer tick, asking Buildbucket for the build status
[09:02:46.461] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:46.461] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:135:0) after 1m0s
[09:03:46.506] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:135:0)
[09:03:46.506] Timer tick, asking Buildbucket for the build status
[09:03:46.580] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:46.580] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:136:0) after 1m0s
[09:04:46.591] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:136:0)
[09:04:46.591] Timer tick, asking Buildbucket for the build status
[09:04:46.711] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:46.711] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:137:0) after 1m0s
[09:05:46.743] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:137:0)
[09:05:46.743] Timer tick, asking Buildbucket for the build status
[09:05:46.818] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:46.818] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:138:0) after 1m0s
[09:06:46.901] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:138:0)
[09:06:46.901] Timer tick, asking Buildbucket for the build status
[09:06:47.327] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:47.327] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:139:0) after 1m0s
[09:07:47.350] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:139:0)
[09:07:47.350] Timer tick, asking Buildbucket for the build status
[09:07:47.424] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:47.424] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:140:0) after 1m0s
[09:08:47.423] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:140:0)
[09:08:47.423] Timer tick, asking Buildbucket for the build status
[09:08:47.502] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:47.502] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:141:0) after 1m0s
[09:09:47.525] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:141:0)
[09:09:47.525] Timer tick, asking Buildbucket for the build status
[09:09:47.782] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:47.782] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:142:0) after 1m0s
[09:10:47.831] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:142:0)
[09:10:47.831] Timer tick, asking Buildbucket for the build status
[09:10:47.906] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:47.906] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:143:0) after 1m0s
[09:11:47.911] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:143:0)
[09:11:47.911] Timer tick, asking Buildbucket for the build status
[09:11:48.048] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:48.048] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:144:0) after 1m0s
[09:12:48.145] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:144:0)
[09:12:48.145] Timer tick, asking Buildbucket for the build status
[09:12:48.216] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:48.216] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:145:0) after 1m0s
[09:13:48.243] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:145:0)
[09:13:48.243] Timer tick, asking Buildbucket for the build status
[09:13:48.624] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:48.624] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:146:0) after 1m0s
[09:14:48.670] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:146:0)
[09:14:48.670] Timer tick, asking Buildbucket for the build status
[09:14:49.158] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:49.158] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:147:0) after 1m0s
[09:15:49.171] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:147:0)
[09:15:49.171] Timer tick, asking Buildbucket for the build status
[09:15:49.258] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:49.258] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:148:0) after 1m0s
[09:16:49.237] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:148:0)
[09:16:49.237] Timer tick, asking Buildbucket for the build status
[09:16:49.324] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:49.324] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:149:0) after 1m0s
[09:17:49.378] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:149:0)
[09:17:49.378] Timer tick, asking Buildbucket for the build status
[09:17:49.607] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:49.607] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:150:0) after 1m0s
[09:18:49.608] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:150:0)
[09:18:49.608] Timer tick, asking Buildbucket for the build status
[09:18:49.678] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:49.678] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:151:0) after 1m0s
[09:19:49.948] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:151:0)
[09:19:49.948] Timer tick, asking Buildbucket for the build status
[09:19:50.043] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:50.043] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:152:0) after 1m0s
[09:20:50.098] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:152:0)
[09:20:50.098] Timer tick, asking Buildbucket for the build status
[09:20:50.386] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:50.386] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:153:0) after 1m0s
[09:21:50.481] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:153:0)
[09:21:50.481] Timer tick, asking Buildbucket for the build status
[09:21:50.575] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:50.575] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:154:0) after 1m0s
[09:22:50.649] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:154:0)
[09:22:50.649] Timer tick, asking Buildbucket for the build status
[09:22:50.719] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:50.719] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:155:0) after 1m0s
[09:23:50.940] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:155:0)
[09:23:50.940] Timer tick, asking Buildbucket for the build status
[09:23:51.001] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:51.001] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:156:0) after 1m0s
[09:24:51.093] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:156:0)
[09:24:51.093] Timer tick, asking Buildbucket for the build status
[09:24:51.170] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:51.170] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:157:0) after 1m0s
[09:25:51.399] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:157:0)
[09:25:51.399] Timer tick, asking Buildbucket for the build status
[09:25:51.501] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:51.501] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:158:0) after 1m0s
[09:26:51.684] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:158:0)
[09:26:51.684] Timer tick, asking Buildbucket for the build status
[09:26:52.006] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:52.006] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:159:0) after 1m0s
[09:27:52.059] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:159:0)
[09:27:52.059] Timer tick, asking Buildbucket for the build status
[09:27:52.131] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:52.131] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:160:0) after 1m0s
[09:28:52.280] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:160:0)
[09:28:52.280] Timer tick, asking Buildbucket for the build status
[09:28:52.368] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:52.368] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:161:0) after 1m0s
[09:29:52.595] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:161:0)
[09:29:52.595] Timer tick, asking Buildbucket for the build status
[09:29:52.668] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:52.668] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:162:0) after 1m0s
[09:30:52.677] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:162:0)
[09:30:52.677] Timer tick, asking Buildbucket for the build status
[09:30:52.749] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:52.749] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:163:0) after 1m0s
[09:31:52.984] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:163:0)
[09:31:52.984] Timer tick, asking Buildbucket for the build status
[09:31:53.424] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:53.424] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:164:0) after 1m0s
[09:32:53.495] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:164:0)
[09:32:53.495] Timer tick, asking Buildbucket for the build status
[09:32:53.585] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:53.585] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:165:0) after 1m0s
[09:33:53.690] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:165:0)
[09:33:53.690] Timer tick, asking Buildbucket for the build status
[09:33:53.762] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:53.762] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:166:0) after 1m0s
[09:34:53.987] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:166:0)
[09:34:53.987] Timer tick, asking Buildbucket for the build status
[09:34:54.219] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:54.219] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:167:0) after 1m0s
[09:35:54.331] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:167:0)
[09:35:54.331] Timer tick, asking Buildbucket for the build status
[09:35:54.410] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:54.410] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:168:0) after 1m0s
[09:36:54.474] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:168:0)
[09:36:54.474] Timer tick, asking Buildbucket for the build status
[09:36:54.552] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:54.552] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:169:0) after 1m0s
[09:37:54.618] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:169:0)
[09:37:54.618] Timer tick, asking Buildbucket for the build status
[09:37:54.912] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:54.912] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:170:0) after 1m0s
[09:38:54.925] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:170:0)
[09:38:54.925] Timer tick, asking Buildbucket for the build status
[09:38:55.015] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:55.015] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:171:0) after 1m0s
[09:39:55.049] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:171:0)
[09:39:55.049] Timer tick, asking Buildbucket for the build status
[09:39:55.125] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:55.125] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:172:0) after 1m0s
[09:40:55.185] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:172:0)
[09:40:55.185] Timer tick, asking Buildbucket for the build status
[09:40:55.340] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:55.340] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:173:0) after 1m0s
[09:41:55.430] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:173:0)
[09:41:55.430] Timer tick, asking Buildbucket for the build status
[09:41:55.813] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:55.813] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:174:0) after 1m0s
[09:42:55.865] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:174:0)
[09:42:55.865] Timer tick, asking Buildbucket for the build status
[09:42:55.951] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:55.951] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:175:0) after 1m0s
[09:43:56.010] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:175:0)
[09:43:56.010] Timer tick, asking Buildbucket for the build status
[09:43:56.144] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:56.145] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:176:0) after 1m0s
[09:44:56.168] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:176:0)
[09:44:56.168] Timer tick, asking Buildbucket for the build status
[09:44:56.388] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:56.388] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:177:0) after 1m0s
[09:45:56.441] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:177:0)
[09:45:56.441] Timer tick, asking Buildbucket for the build status
[09:45:56.549] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:56.549] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:178:0) after 1m0s
[09:46:56.676] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:178:0)
[09:46:56.676] Timer tick, asking Buildbucket for the build status
[09:46:57.045] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:57.045] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:179:0) after 1m0s
[09:47:57.073] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:179:0)
[09:47:57.073] Timer tick, asking Buildbucket for the build status
[09:47:57.477] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:57.477] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:180:0) after 1m0s
[09:48:57.595] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:180:0)
[09:48:57.595] Timer tick, asking Buildbucket for the build status
[09:48:57.954] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:57.954] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:181:0) after 1m0s
[09:49:58.108] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:181:0)
[09:49:58.108] Timer tick, asking Buildbucket for the build status
[09:49:58.182] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:58.182] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:182:0) after 1m0s
[09:50:58.191] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:182:0)
[09:50:58.191] Timer tick, asking Buildbucket for the build status
[09:50:58.283] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:58.283] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:183:0) after 1m0s
[09:51:58.324] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:183:0)
[09:51:58.324] Timer tick, asking Buildbucket for the build status
[09:51:58.645] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:58.645] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:184:0) after 1m0s
[09:52:58.791] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:184:0)
[09:52:58.791] Timer tick, asking Buildbucket for the build status
[09:52:59.083] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:59.083] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:185:0) after 1m0s
[09:53:59.152] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:185:0)
[09:53:59.152] Timer tick, asking Buildbucket for the build status
[09:53:59.226] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:59.226] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:186:0) after 1m0s
[09:54:59.279] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:186:0)
[09:54:59.279] Timer tick, asking Buildbucket for the build status
[09:54:59.389] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:59.389] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:187:0) after 1m0s
[09:55:59.462] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:187:0)
[09:55:59.462] Timer tick, asking Buildbucket for the build status
[09:55:59.717] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:59.717] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:188:0) after 1m0s
[09:56:59.729] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:188:0)
[09:56:59.729] Timer tick, asking Buildbucket for the build status
[09:56:59.970] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:59.971] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:189:0) after 1m0s
[09:58:00.002] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:189:0)
[09:58:00.002] Timer tick, asking Buildbucket for the build status
[09:58:00.150] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:00.150] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:190:0) after 1m0s
[09:59:00.181] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:190:0)
[09:59:00.181] Timer tick, asking Buildbucket for the build status
[09:59:00.263] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:00.263] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:191:0) after 1m0s
[10:00:00.314] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:191:0)
[10:00:00.314] Timer tick, asking Buildbucket for the build status
[10:00:00.399] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:00.399] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:192:0) after 1m0s
[10:01:00.446] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:192:0)
[10:01:00.446] Timer tick, asking Buildbucket for the build status
[10:01:00.527] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:00.527] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:193:0) after 1m0s
[10:02:00.581] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:193:0)
[10:02:00.581] Timer tick, asking Buildbucket for the build status
[10:02:00.917] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:00.917] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:194:0) after 1m0s
[10:03:00.936] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:194:0)
[10:03:00.937] Timer tick, asking Buildbucket for the build status
[10:03:01.093] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:01.093] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:195:0) after 1m0s
[10:04:01.135] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:195:0)
[10:04:01.135] Timer tick, asking Buildbucket for the build status
[10:04:01.208] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:01.208] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:196:0) after 1m0s
[10:05:01.252] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:196:0)
[10:05:01.252] Timer tick, asking Buildbucket for the build status
[10:05:01.344] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:01.344] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:197:0) after 1m0s
[10:06:01.448] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:197:0)
[10:06:01.448] Timer tick, asking Buildbucket for the build status
[10:06:01.550] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:01.550] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:198:0) after 1m0s
[10:07:01.593] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:198:0)
[10:07:01.593] Timer tick, asking Buildbucket for the build status
[10:07:01.750] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:01.750] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:199:0) after 1m0s
[10:08:01.767] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:199:0)
[10:08:01.767] Timer tick, asking Buildbucket for the build status
[10:08:01.849] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:01.849] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:200:0) after 1m0s
[10:09:01.933] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:200:0)
[10:09:01.933] Timer tick, asking Buildbucket for the build status
[10:09:02.002] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:02.002] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:201:0) after 1m0s
[10:10:02.321] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:201:0)
[10:10:02.321] Timer tick, asking Buildbucket for the build status
[10:10:02.422] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:02.422] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:202:0) after 1m0s
[10:11:02.725] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:202:0)
[10:11:02.725] Timer tick, asking Buildbucket for the build status
[10:11:02.836] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:02.836] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:203:0) after 1m0s
[10:12:03.143] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:203:0)
[10:12:03.143] Timer tick, asking Buildbucket for the build status
[10:12:03.230] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:03.230] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:204:0) after 1m0s
[10:13:03.329] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:204:0)
[10:13:03.329] Timer tick, asking Buildbucket for the build status
[10:13:03.521] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:03.521] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:205:0) after 1m0s
[10:14:03.556] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:205:0)
[10:14:03.556] Timer tick, asking Buildbucket for the build status
[10:14:03.649] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:03.649] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:206:0) after 1m0s
[10:15:03.807] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:206:0)
[10:15:03.807] Timer tick, asking Buildbucket for the build status
[10:15:03.916] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:03.916] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:207:0) after 1m0s
[10:16:04.182] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:207:0)
[10:16:04.182] Timer tick, asking Buildbucket for the build status
[10:16:04.298] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:04.298] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:208:0) after 1m0s
[10:17:04.524] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:208:0)
[10:17:04.524] Timer tick, asking Buildbucket for the build status
[10:17:04.763] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:04.763] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:209:0) after 1m0s
[10:18:04.892] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:209:0)
[10:18:04.892] Timer tick, asking Buildbucket for the build status
[10:18:05.053] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:05.053] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:210:0) after 1m0s
[10:19:05.309] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:210:0)
[10:19:05.309] Timer tick, asking Buildbucket for the build status
[10:19:05.423] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:05.423] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:211:0) after 1m0s
[10:20:05.542] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:211:0)
[10:20:05.542] Timer tick, asking Buildbucket for the build status
[10:20:05.779] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:05.779] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:212:0) after 1m0s
[10:21:06.270] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:212:0)
[10:21:06.270] Timer tick, asking Buildbucket for the build status
[10:21:06.573] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:06.573] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:213:0) after 1m0s
[10:22:06.745] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:213:0)
[10:22:06.745] Timer tick, asking Buildbucket for the build status
[10:22:07.015] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:07.015] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:214:0) after 1m0s
[10:23:07.062] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:214:0)
[10:23:07.063] Timer tick, asking Buildbucket for the build status
[10:23:07.139] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:07.139] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:215:0) after 1m0s
[10:24:07.237] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:215:0)
[10:24:07.237] Timer tick, asking Buildbucket for the build status
[10:24:07.304] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:07.304] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:216:0) after 1m0s
[10:25:07.352] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:216:0)
[10:25:07.353] Timer tick, asking Buildbucket for the build status
[10:25:07.546] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:07.547] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:217:0) after 1m0s
[10:26:07.609] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:217:0)
[10:26:07.609] Timer tick, asking Buildbucket for the build status
[10:26:07.895] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:07.895] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:218:0) after 1m0s
[10:27:08.078] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:218:0)
[10:27:08.078] Timer tick, asking Buildbucket for the build status
[10:27:08.167] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:08.167] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:219:0) after 1m0s
[10:28:08.269] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:219:0)
[10:28:08.269] Timer tick, asking Buildbucket for the build status
[10:28:08.643] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:08.643] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:220:0) after 1m0s
[10:29:08.788] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:220:0)
[10:29:08.788] Timer tick, asking Buildbucket for the build status
[10:29:08.975] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:08.975] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:221:0) after 1m0s
[10:30:09.033] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:221:0)
[10:30:09.033] Timer tick, asking Buildbucket for the build status
[10:30:09.112] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:09.112] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:222:0) after 1m0s
[10:31:09.100] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:222:0)
[10:31:09.100] Timer tick, asking Buildbucket for the build status
[10:31:09.172] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:09.172] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:223:0) after 1m0s
[10:32:09.217] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:223:0)
[10:32:09.217] Timer tick, asking Buildbucket for the build status
[10:32:09.612] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:09.612] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:224:0) after 1m0s
[10:33:09.658] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:224:0)
[10:33:09.658] Timer tick, asking Buildbucket for the build status
[10:33:10.304] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:10.304] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:225:0) after 1m0s
[10:34:10.362] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:225:0)
[10:34:10.362] Timer tick, asking Buildbucket for the build status
[10:34:10.460] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:10.460] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:226:0) after 1m0s
[10:35:10.518] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:226:0)
[10:35:10.518] Timer tick, asking Buildbucket for the build status
[10:35:10.815] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:10.815] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:227:0) after 1m0s
[10:36:11.141] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:227:0)
[10:36:11.141] Timer tick, asking Buildbucket for the build status
[10:36:11.216] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:11.216] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:228:0) after 1m0s
[10:37:11.402] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:228:0)
[10:37:11.402] Timer tick, asking Buildbucket for the build status
[10:37:11.469] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:11.469] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:229:0) after 1m0s
[10:38:11.555] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:229:0)
[10:38:11.555] Timer tick, asking Buildbucket for the build status
[10:38:11.627] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:11.627] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:230:0) after 1m0s
[10:39:11.727] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:230:0)
[10:39:11.727] Timer tick, asking Buildbucket for the build status
[10:39:11.793] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:11.793] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:231:0) after 1m0s
[10:40:11.895] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:231:0)
[10:40:11.895] Timer tick, asking Buildbucket for the build status
[10:40:11.964] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:11.964] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:232:0) after 1m0s
[10:41:12.083] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:232:0)
[10:41:12.083] Timer tick, asking Buildbucket for the build status
[10:41:12.164] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:12.164] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:233:0) after 1m0s
[10:42:12.286] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:233:0)
[10:42:12.286] Timer tick, asking Buildbucket for the build status
[10:42:12.360] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:12.360] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:234:0) after 1m0s
[10:43:12.464] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:234:0)
[10:43:12.464] Timer tick, asking Buildbucket for the build status
[10:43:12.553] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:12.553] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:235:0) after 1m0s
[10:44:12.574] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:235:0)
[10:44:12.574] Timer tick, asking Buildbucket for the build status
[10:44:12.770] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:12.770] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:236:0) after 1m0s
[10:45:12.793] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:236:0)
[10:45:12.793] Timer tick, asking Buildbucket for the build status
[10:45:12.947] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:12.947] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:237:0) after 1m0s
[10:46:12.994] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:237:0)
[10:46:12.994] Timer tick, asking Buildbucket for the build status
[10:46:13.066] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:13.066] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:238:0) after 1m0s
[10:47:13.870] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:238:0)
[10:47:13.870] Timer tick, asking Buildbucket for the build status
[10:47:13.953] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:13.953] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:239:0) after 1m0s
[10:48:14.141] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:239:0)
[10:48:14.141] Timer tick, asking Buildbucket for the build status
[10:48:14.214] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:14.214] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:240:0) after 1m0s
[10:49:14.339] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:240:0)
[10:49:14.339] Timer tick, asking Buildbucket for the build status
[10:49:14.495] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:14.495] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:241:0) after 1m0s
[10:50:14.570] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:241:0)
[10:50:14.570] Timer tick, asking Buildbucket for the build status
[10:50:14.853] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:14.853] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:242:0) after 1m0s
[10:51:14.899] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:242:0)
[10:51:14.899] Timer tick, asking Buildbucket for the build status
[10:51:15.004] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:15.004] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:243:0) after 1m0s
[10:52:15.042] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:243:0)
[10:52:15.042] Timer tick, asking Buildbucket for the build status
[10:52:15.486] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:15.486] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:244:0) after 1m0s
[10:53:15.591] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:244:0)
[10:53:15.592] Timer tick, asking Buildbucket for the build status
[10:53:15.685] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:15.685] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:245:0) after 1m0s
[10:54:15.747] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:245:0)
[10:54:15.747] Timer tick, asking Buildbucket for the build status
[10:54:15.836] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:15.836] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:246:0) after 1m0s
[10:55:15.855] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:246:0)
[10:55:15.855] Timer tick, asking Buildbucket for the build status
[10:55:15.923] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:15.923] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:247:0) after 1m0s
[10:56:15.967] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:247:0)
[10:56:15.967] Timer tick, asking Buildbucket for the build status
[10:56:16.319] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:16.319] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:248:0) after 1m0s
[10:57:16.332] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:248:0)
[10:57:16.332] Timer tick, asking Buildbucket for the build status
[10:57:16.403] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:16.403] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:249:0) after 1m0s
[10:58:16.462] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:249:0)
[10:58:16.462] Timer tick, asking Buildbucket for the build status
[10:58:16.550] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:16.550] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:250:0) after 1m0s
[10:59:16.617] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:250:0)
[10:59:16.617] Timer tick, asking Buildbucket for the build status
[10:59:16.745] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:16.745] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:251:0) after 1m0s
[11:00:16.862] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:251:0)
[11:00:16.862] Timer tick, asking Buildbucket for the build status
[11:00:17.277] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:17.277] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:252:0) after 1m0s
[11:01:17.336] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:252:0)
[11:01:17.336] Timer tick, asking Buildbucket for the build status
[11:01:17.417] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:17.417] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:253:0) after 1m0s
[11:02:17.407] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:253:0)
[11:02:17.407] Timer tick, asking Buildbucket for the build status
[11:02:17.491] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:17.491] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:254:0) after 1m0s
[11:03:17.554] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:254:0)
[11:03:17.554] Timer tick, asking Buildbucket for the build status
[11:03:17.681] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:17.681] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:255:0) after 1m0s
[11:04:17.706] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:255:0)
[11:04:17.706] Timer tick, asking Buildbucket for the build status
[11:04:17.992] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:17.992] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:256:0) after 1m0s
[11:05:18.037] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:256:0)
[11:05:18.037] Timer tick, asking Buildbucket for the build status
[11:05:18.329] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:18.329] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:257:0) after 1m0s
[11:06:18.392] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:257:0)
[11:06:18.392] Timer tick, asking Buildbucket for the build status
[11:06:18.501] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:18.501] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:258:0) after 1m0s
[11:07:18.512] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:258:0)
[11:07:18.512] Timer tick, asking Buildbucket for the build status
[11:07:18.583] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:18.583] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:259:0) after 1m0s
[11:08:18.679] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:259:0)
[11:08:18.679] Timer tick, asking Buildbucket for the build status
[11:08:18.948] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:18.948] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:260:0) after 1m0s
[11:09:18.992] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:260:0)
[11:09:18.992] Timer tick, asking Buildbucket for the build status
[11:09:19.076] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:19.076] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:261:0) after 1m0s
[11:10:19.177] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:261:0)
[11:10:19.177] Timer tick, asking Buildbucket for the build status
[11:10:19.243] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:19.243] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:262:0) after 1m0s
[11:11:19.279] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:262:0)
[11:11:19.279] Timer tick, asking Buildbucket for the build status
[11:11:19.365] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:19.365] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:263:0) after 1m0s
[11:12:19.406] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:263:0)
[11:12:19.406] Timer tick, asking Buildbucket for the build status
[11:12:19.529] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:19.529] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:264:0) after 1m0s
[11:13:19.554] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:264:0)
[11:13:19.554] Timer tick, asking Buildbucket for the build status
[11:13:19.814] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:19.814] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:265:0) after 1m0s
[11:14:19.865] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:265:0)
[11:14:19.865] Timer tick, asking Buildbucket for the build status
[11:14:19.946] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:19.946] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:266:0) after 1m0s
[11:15:19.973] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:266:0)
[11:15:19.973] Timer tick, asking Buildbucket for the build status
[11:15:20.179] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:20.179] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:267:0) after 1m0s
[11:16:20.227] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:267:0)
[11:16:20.227] Timer tick, asking Buildbucket for the build status
[11:16:20.499] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:20.499] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:268:0) after 1m0s
[11:17:20.566] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:268:0)
[11:17:20.566] Timer tick, asking Buildbucket for the build status
[11:17:20.735] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:20.735] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:269:0) after 1m0s
[11:18:20.763] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:269:0)
[11:18:20.763] Timer tick, asking Buildbucket for the build status
[11:18:20.882] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:20.883] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:270:0) after 1m0s
[11:19:20.911] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:270:0)
[11:19:20.911] Timer tick, asking Buildbucket for the build status
[11:19:21.150] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:21.150] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:271:0) after 1m0s
[11:20:21.194] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:271:0)
[11:20:21.194] Timer tick, asking Buildbucket for the build status
[11:20:21.309] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:21.309] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:272:0) after 1m0s
[11:21:21.359] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:272:0)
[11:21:21.359] Timer tick, asking Buildbucket for the build status
[11:21:21.929] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:21.929] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:273:0) after 1m0s
[11:22:21.934] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:273:0)
[11:22:21.934] Timer tick, asking Buildbucket for the build status
[11:22:22.014] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:22.014] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:274:0) after 1m0s
[11:23:22.048] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:274:0)
[11:23:22.048] Timer tick, asking Buildbucket for the build status
[11:23:22.170] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:22.170] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:275:0) after 1m0s
[11:24:22.220] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:275:0)
[11:24:22.220] Timer tick, asking Buildbucket for the build status
[11:24:22.307] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:22.307] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:276:0) after 1m0s
[11:25:22.388] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:276:0)
[11:25:22.388] Timer tick, asking Buildbucket for the build status
[11:25:22.457] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:22.457] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:277:0) after 1m0s
[11:26:22.497] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:277:0)
[11:26:22.497] Timer tick, asking Buildbucket for the build status
[11:26:22.565] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:22.565] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:278:0) after 1m0s
[11:27:22.596] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:278:0)
[11:27:22.596] Timer tick, asking Buildbucket for the build status
[11:27:23.069] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:23.069] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:279:0) after 1m0s
[11:28:23.155] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:279:0)
[11:28:23.155] Timer tick, asking Buildbucket for the build status
[11:28:23.229] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:23.229] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:280:0) after 1m0s
[11:29:23.310] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:280:0)
[11:29:23.310] Timer tick, asking Buildbucket for the build status
[11:29:23.433] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:23.433] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:281:0) after 1m0s
[11:30:23.529] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:281:0)
[11:30:23.529] Timer tick, asking Buildbucket for the build status
[11:30:23.679] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:23.679] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:282:0) after 1m0s
[11:31:23.837] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:282:0)
[11:31:23.837] Timer tick, asking Buildbucket for the build status
[11:31:23.916] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:23.916] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:283:0) after 1m0s
[11:32:23.930] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:283:0)
[11:32:23.930] Timer tick, asking Buildbucket for the build status
[11:32:24.006] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:24.006] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:284:0) after 1m0s
[11:33:24.095] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:284:0)
[11:33:24.095] Timer tick, asking Buildbucket for the build status
[11:33:24.195] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:24.195] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:285:0) after 1m0s
[11:34:24.300] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:285:0)
[11:34:24.300] Timer tick, asking Buildbucket for the build status
[11:34:24.446] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:24.446] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:286:0) after 1m0s
[11:35:24.622] Handling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:286:0)
[11:35:24.622] Timer tick, asking Buildbucket for the build status
[11:35:24.707] Build 8854344783670575584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:24.707] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9019774845650187792:287:0) after 1m0s
[11:35:43.050] Received PubSub notification, asking Buildbucket for the build status
[11:35:43.138] Build 8854344783670575584: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:35:43.138] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614252940917952",
"created_by": "project:chromium",
"created_ts": "1614235813415105",
"id": "8854344783670575584",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d42ce26c376c7667f3247739dea92e34f27f8c90\"}}",
"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\": \"d42ce26c376c7667f3247739dea92e34f27f8c90\", \"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-4-n02m\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 1655, \"got_angle_revision\": \"9b1c569b14e90765cdd7c07e449400e88f1d6c45\", \"got_dawn_revision\": \"5eb496b863da5b40dc5c9a713c8ca1e413811f35\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"d42ce26c376c7667f3247739dea92e34f27f8c90\", \"got_revision_cp\": \"refs/heads/master@{#857563}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"349abccec8f7ebd1259de11965d58790a76b0ba4\", \"got_v8_revision\": \"bd0108b4c88e0d6f2350cb79b5f363fbd02f3eb7\", \"got_v8_revision_cp\": \"refs/heads/9.0.257@{#1}\", \"got_webrtc_revision\": \"cd0373f013b5c9672c05e79a48bb1e9fb5f50fa4\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33333}\", \"mirrored_builders\": [\"tryserver.chromium:win-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d42ce26c376c7667f3247739dea92e34f27f8c90\"}, \"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-4-n02m\"], \"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\": [\"5712-339372b\"], \"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": "1614235847005792",
"status": "COMPLETED",
"status_changed_ts": "1614252941757862",
"tags": [
"build_address:luci.chromium.ci/win-official/1655",
"builder:win-official",
"buildset:commit/git/d42ce26c376c7667f3247739dea92e34f27f8c90",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d42ce26c376c7667f3247739dea92e34f27f8c90",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019774845650187792",
"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/8854344783670575584/+/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:51f0c5b45cc1ca10",
"user_agent:luci-scheduler"
],
"updated_ts": "1614252941791319",
"url": "https://ci.chromium.org/b/8854344783670575584",
"utcnow_ts": "1614252943130762"
}
}
[11:35:43.138] Invocation finished in 4h45m30.993175186s with status SUCCEEDED