[06:38:44.798] New invocation is queued and will start shortly
[06:38:45.928] Starting the invocation (attempt 1)
[06:38:46.004] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:38:46.004] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:38:46.005] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9026479741918056368",
"parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d54c6c3a98c9b924333932bb982d00c4222e76f7\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-official",
"scheduler_invocation_id:9026479741918056368",
"scheduler_job_id:chromium/win-official",
"user_agent:luci-scheduler",
"buildset:commit/git/d54c6c3a98c9b924333932bb982d00c4222e76f7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d54c6c3a98c9b924333932bb982d00c4222e76f7",
"gitiles_ref:refs/heads/master"
]
}
[06:38:46.628] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1607841526126672",
"id": "8861049679859478032",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d54c6c3a98c9b924333932bb982d00c4222e76f7\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1607841526485704",
"tags": [
"build_address:luci.chromium.ci/win-official/1161",
"builder:win-official",
"buildset:commit/git/d54c6c3a98c9b924333932bb982d00c4222e76f7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d54c6c3a98c9b924333932bb982d00c4222e76f7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026479741918056368",
"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/8861049679859478032/+/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": "1607841526485818",
"url": "https://ci.chromium.org/b/8861049679859478032",
"utcnow_ts": "1607841526617645"
}
}
[06:38:46.628] Task URL: https://ci.chromium.org/b/8861049679859478032
[06:38:46.628] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:2:0) after 1m0s
[06:39:32.872] Received PubSub notification, asking Buildbucket for the build status
[06:39:32.941] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:46.678] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:2:0)
[06:39:46.678] Timer tick, asking Buildbucket for the build status
[06:39:46.744] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:46.744] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:4:0) after 1m0s
[06:40:46.766] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:4:0)
[06:40:46.766] Timer tick, asking Buildbucket for the build status
[06:40:46.844] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:46.844] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:5:0) after 1m0s
[06:41:46.936] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:5:0)
[06:41:46.936] Timer tick, asking Buildbucket for the build status
[06:41:47.039] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:47.039] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:6:0) after 1m0s
[06:42:47.119] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:6:0)
[06:42:47.119] Timer tick, asking Buildbucket for the build status
[06:42:47.186] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:47.186] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:7:0) after 1m0s
[06:43:47.204] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:7:0)
[06:43:47.204] Timer tick, asking Buildbucket for the build status
[06:43:47.277] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:47.277] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:8:0) after 1m0s
[06:44:47.309] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:8:0)
[06:44:47.309] Timer tick, asking Buildbucket for the build status
[06:44:47.401] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:47.401] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:9:0) after 1m0s
[06:45:47.478] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:9:0)
[06:45:47.478] Timer tick, asking Buildbucket for the build status
[06:45:49.522] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:49.522] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:10:0) after 1m0s
[06:46:49.530] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:10:0)
[06:46:49.530] Timer tick, asking Buildbucket for the build status
[06:46:49.600] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:49.600] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:11:0) after 1m0s
[06:47:49.631] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:11:0)
[06:47:49.631] Timer tick, asking Buildbucket for the build status
[06:47:49.687] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:49.687] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:12:0) after 1m0s
[06:48:49.667] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:12:0)
[06:48:49.667] Timer tick, asking Buildbucket for the build status
[06:48:50.044] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:50.044] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:13:0) after 1m0s
[06:49:50.060] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:13:0)
[06:49:50.060] Timer tick, asking Buildbucket for the build status
[06:49:50.124] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:50.124] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:14:0) after 1m0s
[06:50:50.145] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:14:0)
[06:50:50.145] Timer tick, asking Buildbucket for the build status
[06:50:50.249] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:50.249] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:15:0) after 1m0s
[06:51:50.265] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:15:0)
[06:51:50.265] Timer tick, asking Buildbucket for the build status
[06:51:50.328] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:50.328] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:16:0) after 1m0s
[06:52:50.345] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:16:0)
[06:52:50.345] Timer tick, asking Buildbucket for the build status
[06:52:50.402] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:50.402] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:17:0) after 1m0s
[06:53:50.423] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:17:0)
[06:53:50.423] Timer tick, asking Buildbucket for the build status
[06:53:50.526] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:50.526] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:18:0) after 1m0s
[06:54:50.544] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:18:0)
[06:54:50.544] Timer tick, asking Buildbucket for the build status
[06:54:50.604] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:50.604] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:19:0) after 1m0s
[06:55:50.622] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:19:0)
[06:55:50.622] Timer tick, asking Buildbucket for the build status
[06:55:50.684] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:50.684] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:20:0) after 1m0s
[06:56:50.709] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:20:0)
[06:56:50.709] Timer tick, asking Buildbucket for the build status
[06:56:50.765] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:50.765] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:21:0) after 1m0s
[06:57:50.782] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:21:0)
[06:57:50.783] Timer tick, asking Buildbucket for the build status
[06:57:52.015] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:52.015] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:22:0) after 1m0s
[06:58:52.084] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:22:0)
[06:58:52.084] Timer tick, asking Buildbucket for the build status
[06:58:52.284] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:52.284] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:23:0) after 1m0s
[06:59:52.304] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:23:0)
[06:59:52.304] Timer tick, asking Buildbucket for the build status
[06:59:52.395] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:52.395] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:24:0) after 1m0s
[07:00:52.461] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:24:0)
[07:00:52.461] Timer tick, asking Buildbucket for the build status
[07:00:52.564] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:52.564] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:25:0) after 1m0s
[07:01:52.592] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:25:0)
[07:01:52.592] Timer tick, asking Buildbucket for the build status
[07:01:52.801] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:52.801] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:26:0) after 1m0s
[07:02:52.837] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:26:0)
[07:02:52.837] Timer tick, asking Buildbucket for the build status
[07:02:52.892] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:52.892] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:27:0) after 1m0s
[07:03:53.007] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:27:0)
[07:03:53.007] Timer tick, asking Buildbucket for the build status
[07:03:53.214] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:53.214] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:28:0) after 1m0s
[07:04:53.282] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:28:0)
[07:04:53.282] Timer tick, asking Buildbucket for the build status
[07:04:53.352] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:53.352] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:29:0) after 1m0s
[07:05:53.487] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:29:0)
[07:05:53.487] Timer tick, asking Buildbucket for the build status
[07:05:53.551] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:53.551] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:30:0) after 1m0s
[07:06:53.623] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:30:0)
[07:06:53.623] Timer tick, asking Buildbucket for the build status
[07:06:53.681] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:53.681] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:31:0) after 1m0s
[07:07:53.698] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:31:0)
[07:07:53.698] Timer tick, asking Buildbucket for the build status
[07:07:54.051] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:54.051] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:32:0) after 1m0s
[07:08:54.063] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:32:0)
[07:08:54.063] Timer tick, asking Buildbucket for the build status
[07:08:54.171] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:54.171] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:33:0) after 1m0s
[07:09:54.192] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:33:0)
[07:09:54.192] Timer tick, asking Buildbucket for the build status
[07:09:54.252] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:54.252] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:34:0) after 1m0s
[07:10:54.373] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:34:0)
[07:10:54.373] Timer tick, asking Buildbucket for the build status
[07:10:54.457] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:54.457] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:35:0) after 1m0s
[07:11:54.735] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:35:0)
[07:11:54.735] Timer tick, asking Buildbucket for the build status
[07:11:54.827] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:54.827] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:36:0) after 1m0s
[07:12:54.911] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:36:0)
[07:12:54.911] Timer tick, asking Buildbucket for the build status
[07:12:55.017] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:55.017] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:37:0) after 1m0s
[07:13:55.382] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:37:0)
[07:13:55.382] Timer tick, asking Buildbucket for the build status
[07:13:55.646] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:55.646] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:38:0) after 1m0s
[07:14:56.059] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:38:0)
[07:14:56.059] Timer tick, asking Buildbucket for the build status
[07:14:56.158] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:56.158] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:39:0) after 1m0s
[07:15:56.329] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:39:0)
[07:15:56.329] Timer tick, asking Buildbucket for the build status
[07:15:56.389] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:56.389] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:40:0) after 1m0s
[07:16:56.593] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:40:0)
[07:16:56.593] Timer tick, asking Buildbucket for the build status
[07:16:56.649] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:56.649] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:41:0) after 1m0s
[07:17:56.756] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:41:0)
[07:17:56.756] Timer tick, asking Buildbucket for the build status
[07:17:56.819] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:56.819] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:42:0) after 1m0s
[07:18:56.817] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:42:0)
[07:18:56.817] Timer tick, asking Buildbucket for the build status
[07:18:56.913] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:56.913] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:43:0) after 1m0s
[07:19:57.004] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:43:0)
[07:19:57.004] Timer tick, asking Buildbucket for the build status
[07:19:57.069] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:57.069] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:44:0) after 1m0s
[07:20:57.173] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:44:0)
[07:20:57.173] Timer tick, asking Buildbucket for the build status
[07:20:57.444] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:57.444] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:45:0) after 1m0s
[07:21:57.472] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:45:0)
[07:21:57.472] Timer tick, asking Buildbucket for the build status
[07:21:57.533] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:57.533] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:46:0) after 1m0s
[07:22:57.576] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:46:0)
[07:22:57.576] Timer tick, asking Buildbucket for the build status
[07:22:57.649] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:57.649] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:47:0) after 1m0s
[07:23:57.679] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:47:0)
[07:23:57.679] Timer tick, asking Buildbucket for the build status
[07:23:57.814] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:57.814] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:48:0) after 1m0s
[07:24:57.840] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:48:0)
[07:24:57.840] Timer tick, asking Buildbucket for the build status
[07:24:58.002] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:58.002] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:49:0) after 1m0s
[07:25:58.060] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:49:0)
[07:25:58.060] Timer tick, asking Buildbucket for the build status
[07:25:58.146] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:58.146] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:50:0) after 1m0s
[07:26:58.177] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:50:0)
[07:26:58.177] Timer tick, asking Buildbucket for the build status
[07:26:58.330] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:58.330] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:51:0) after 1m0s
[07:27:58.415] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:51:0)
[07:27:58.415] Timer tick, asking Buildbucket for the build status
[07:27:58.477] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:58.477] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:52:0) after 1m0s
[07:28:58.500] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:52:0)
[07:28:58.500] Timer tick, asking Buildbucket for the build status
[07:28:58.607] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:58.607] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:53:0) after 1m0s
[07:29:58.637] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:53:0)
[07:29:58.637] Timer tick, asking Buildbucket for the build status
[07:29:58.697] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:58.697] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:54:0) after 1m0s
[07:30:58.716] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:54:0)
[07:30:58.716] Timer tick, asking Buildbucket for the build status
[07:30:58.778] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:58.778] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:55:0) after 1m0s
[07:31:58.806] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:55:0)
[07:31:58.806] Timer tick, asking Buildbucket for the build status
[07:31:58.878] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:58.878] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:56:0) after 1m0s
[07:32:58.897] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:56:0)
[07:32:58.897] Timer tick, asking Buildbucket for the build status
[07:32:58.962] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:58.962] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:57:0) after 1m0s
[07:33:58.965] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:57:0)
[07:33:58.965] Timer tick, asking Buildbucket for the build status
[07:33:59.068] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:59.068] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:58:0) after 1m0s
[07:34:59.088] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:58:0)
[07:34:59.088] Timer tick, asking Buildbucket for the build status
[07:34:59.167] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:59.167] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:59:0) after 1m0s
[07:35:59.219] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:59:0)
[07:35:59.219] Timer tick, asking Buildbucket for the build status
[07:35:59.280] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:59.280] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:60:0) after 1m0s
[07:36:59.273] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:60:0)
[07:36:59.273] Timer tick, asking Buildbucket for the build status
[07:36:59.341] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:59.341] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:61:0) after 1m0s
[07:37:59.396] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:61:0)
[07:37:59.396] Timer tick, asking Buildbucket for the build status
[07:37:59.461] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:59.461] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:62:0) after 1m0s
[07:38:59.474] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:62:0)
[07:38:59.474] Timer tick, asking Buildbucket for the build status
[07:38:59.573] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:59.573] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:63:0) after 1m0s
[07:39:59.615] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:63:0)
[07:39:59.615] Timer tick, asking Buildbucket for the build status
[07:39:59.681] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:59.681] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:64:0) after 1m0s
[07:40:59.667] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:64:0)
[07:40:59.667] Timer tick, asking Buildbucket for the build status
[07:40:59.725] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:59.725] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:65:0) after 1m0s
[07:41:59.743] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:65:0)
[07:41:59.743] Timer tick, asking Buildbucket for the build status
[07:41:59.823] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:59.823] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:66:0) after 1m0s
[07:42:59.841] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:66:0)
[07:42:59.841] Timer tick, asking Buildbucket for the build status
[07:42:59.899] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:59.899] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:67:0) after 1m0s
[07:43:59.919] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:67:0)
[07:43:59.919] Timer tick, asking Buildbucket for the build status
[07:44:00.114] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:00.114] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:68:0) after 1m0s
[07:45:00.167] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:68:0)
[07:45:00.167] Timer tick, asking Buildbucket for the build status
[07:45:00.235] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:00.235] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:69:0) after 1m0s
[07:46:00.294] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:69:0)
[07:46:00.294] Timer tick, asking Buildbucket for the build status
[07:46:00.354] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:00.354] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:70:0) after 1m0s
[07:47:00.426] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:70:0)
[07:47:00.426] Timer tick, asking Buildbucket for the build status
[07:47:00.834] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:00.834] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:71:0) after 1m0s
[07:48:01.075] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:71:0)
[07:48:01.075] Timer tick, asking Buildbucket for the build status
[07:48:01.208] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:01.208] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:72:0) after 1m0s
[07:49:01.237] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:72:0)
[07:49:01.237] Timer tick, asking Buildbucket for the build status
[07:49:01.343] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:01.343] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:73:0) after 1m0s
[07:50:01.412] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:73:0)
[07:50:01.412] Timer tick, asking Buildbucket for the build status
[07:50:01.484] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:01.484] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:74:0) after 1m0s
[07:51:01.508] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:74:0)
[07:51:01.508] Timer tick, asking Buildbucket for the build status
[07:51:01.576] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:01.576] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:75:0) after 1m0s
[07:52:01.595] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:75:0)
[07:52:01.595] Timer tick, asking Buildbucket for the build status
[07:52:01.662] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:01.662] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:76:0) after 1m0s
[07:53:01.716] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:76:0)
[07:53:01.716] Timer tick, asking Buildbucket for the build status
[07:53:01.828] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:01.828] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:77:0) after 1m0s
[07:54:01.929] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:77:0)
[07:54:01.929] Timer tick, asking Buildbucket for the build status
[07:54:02.116] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:02.116] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:78:0) after 1m0s
[07:55:02.138] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:78:0)
[07:55:02.138] Timer tick, asking Buildbucket for the build status
[07:55:02.210] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:02.210] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:79:0) after 1m0s
[07:56:02.233] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:79:0)
[07:56:02.233] Timer tick, asking Buildbucket for the build status
[07:56:02.293] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:02.293] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:80:0) after 1m0s
[07:57:02.292] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:80:0)
[07:57:02.292] Timer tick, asking Buildbucket for the build status
[07:57:02.418] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:02.418] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:81:0) after 1m0s
[07:58:02.399] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:81:0)
[07:58:02.399] Timer tick, asking Buildbucket for the build status
[07:58:02.460] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:02.460] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:82:0) after 1m0s
[07:59:02.481] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:82:0)
[07:59:02.481] Timer tick, asking Buildbucket for the build status
[07:59:02.632] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:02.632] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:83:0) after 1m0s
[08:00:02.709] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:83:0)
[08:00:02.709] Timer tick, asking Buildbucket for the build status
[08:00:02.829] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:02.829] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:84:0) after 1m0s
[08:01:02.848] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:84:0)
[08:01:02.848] Timer tick, asking Buildbucket for the build status
[08:01:02.934] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:02.934] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:85:0) after 1m0s
[08:02:03.039] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:85:0)
[08:02:03.039] Timer tick, asking Buildbucket for the build status
[08:02:03.113] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:03.113] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:86:0) after 1m0s
[08:03:03.132] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:86:0)
[08:03:03.132] Timer tick, asking Buildbucket for the build status
[08:03:03.313] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:03.313] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:87:0) after 1m0s
[08:04:03.365] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:87:0)
[08:04:03.365] Timer tick, asking Buildbucket for the build status
[08:04:03.906] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:03.906] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:88:0) after 1m0s
[08:05:03.937] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:88:0)
[08:05:03.937] Timer tick, asking Buildbucket for the build status
[08:05:04.146] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:04.146] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:89:0) after 1m0s
[08:06:04.144] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:89:0)
[08:06:04.144] Timer tick, asking Buildbucket for the build status
[08:06:04.206] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:04.206] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:90:0) after 1m0s
[08:07:04.347] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:90:0)
[08:07:04.347] Timer tick, asking Buildbucket for the build status
[08:07:04.413] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:04.413] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:91:0) after 1m0s
[08:08:04.475] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:91:0)
[08:08:04.475] Timer tick, asking Buildbucket for the build status
[08:08:04.546] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:04.546] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:92:0) after 1m0s
[08:09:04.676] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:92:0)
[08:09:04.676] Timer tick, asking Buildbucket for the build status
[08:09:05.011] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:05.011] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:93:0) after 1m0s
[08:10:05.135] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:93:0)
[08:10:05.135] Timer tick, asking Buildbucket for the build status
[08:10:05.335] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:05.335] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:94:0) after 1m0s
[08:11:05.594] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:94:0)
[08:11:05.594] Timer tick, asking Buildbucket for the build status
[08:11:05.729] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:05.729] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:95:0) after 1m0s
[08:12:05.774] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:95:0)
[08:12:05.774] Timer tick, asking Buildbucket for the build status
[08:12:06.205] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:06.205] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:96:0) after 1m0s
[08:13:06.306] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:96:0)
[08:13:06.306] Timer tick, asking Buildbucket for the build status
[08:13:06.519] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:06.519] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:97:0) after 1m0s
[08:14:06.731] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:97:0)
[08:14:06.731] Timer tick, asking Buildbucket for the build status
[08:14:06.826] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:06.826] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:98:0) after 1m0s
[08:15:06.881] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:98:0)
[08:15:06.881] Timer tick, asking Buildbucket for the build status
[08:15:06.946] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:06.946] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:99:0) after 1m0s
[08:16:07.015] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:99:0)
[08:16:07.015] Timer tick, asking Buildbucket for the build status
[08:16:07.079] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:07.079] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:100:0) after 1m0s
[08:17:07.085] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:100:0)
[08:17:07.085] Timer tick, asking Buildbucket for the build status
[08:17:07.387] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:07.387] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:101:0) after 1m0s
[08:18:07.452] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:101:0)
[08:18:07.452] Timer tick, asking Buildbucket for the build status
[08:18:07.524] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:07.524] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:102:0) after 1m0s
[08:19:07.602] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:102:0)
[08:19:07.602] Timer tick, asking Buildbucket for the build status
[08:19:07.905] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:07.905] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:103:0) after 1m0s
[08:20:07.972] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:103:0)
[08:20:07.972] Timer tick, asking Buildbucket for the build status
[08:20:08.038] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:08.038] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:104:0) after 1m0s
[08:21:08.057] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:104:0)
[08:21:08.057] Timer tick, asking Buildbucket for the build status
[08:21:08.117] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:08.117] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:105:0) after 1m0s
[08:22:08.142] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:105:0)
[08:22:08.142] Timer tick, asking Buildbucket for the build status
[08:22:08.196] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:08.196] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:106:0) after 1m0s
[08:23:08.221] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:106:0)
[08:23:08.221] Timer tick, asking Buildbucket for the build status
[08:23:08.272] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:08.272] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:107:0) after 1m0s
[08:24:08.358] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:107:0)
[08:24:08.358] Timer tick, asking Buildbucket for the build status
[08:24:08.456] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:08.456] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:108:0) after 1m0s
[08:25:08.493] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:108:0)
[08:25:08.493] Timer tick, asking Buildbucket for the build status
[08:25:08.553] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:08.553] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:109:0) after 1m0s
[08:26:08.554] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:109:0)
[08:26:08.554] Timer tick, asking Buildbucket for the build status
[08:26:08.904] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:08.904] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:110:0) after 1m0s
[08:27:08.952] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:110:0)
[08:27:08.952] Timer tick, asking Buildbucket for the build status
[08:27:09.098] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:09.098] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:111:0) after 1m0s
[08:28:09.150] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:111:0)
[08:28:09.150] Timer tick, asking Buildbucket for the build status
[08:28:09.215] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:09.215] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:112:0) after 1m0s
[08:29:09.204] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:112:0)
[08:29:09.204] Timer tick, asking Buildbucket for the build status
[08:29:09.307] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:09.307] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:113:0) after 1m0s
[08:30:09.533] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:113:0)
[08:30:09.533] Timer tick, asking Buildbucket for the build status
[08:30:09.600] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:09.600] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:114:0) after 1m0s
[08:31:09.828] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:114:0)
[08:31:09.828] Timer tick, asking Buildbucket for the build status
[08:31:09.908] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:09.908] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:115:0) after 1m0s
[08:32:10.108] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:115:0)
[08:32:10.108] Timer tick, asking Buildbucket for the build status
[08:32:10.167] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:10.167] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:116:0) after 1m0s
[08:33:10.333] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:116:0)
[08:33:10.333] Timer tick, asking Buildbucket for the build status
[08:33:10.385] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:10.385] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:117:0) after 1m0s
[08:34:10.536] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:117:0)
[08:34:10.536] Timer tick, asking Buildbucket for the build status
[08:34:10.649] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:10.649] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:118:0) after 1m0s
[08:35:10.671] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:118:0)
[08:35:10.671] Timer tick, asking Buildbucket for the build status
[08:35:10.731] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:10.731] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:119:0) after 1m0s
[08:36:10.762] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:119:0)
[08:36:10.762] Timer tick, asking Buildbucket for the build status
[08:36:10.820] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:10.820] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:120:0) after 1m0s
[08:37:10.892] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:120:0)
[08:37:10.892] Timer tick, asking Buildbucket for the build status
[08:37:10.961] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:10.961] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:121:0) after 1m0s
[08:38:10.995] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:121:0)
[08:38:10.995] Timer tick, asking Buildbucket for the build status
[08:38:11.142] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:11.142] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:122:0) after 1m0s
[08:39:11.175] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:122:0)
[08:39:11.175] Timer tick, asking Buildbucket for the build status
[08:39:11.264] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:11.264] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:123:0) after 1m0s
[08:40:11.283] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:123:0)
[08:40:11.283] Timer tick, asking Buildbucket for the build status
[08:40:11.345] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:11.345] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:124:0) after 1m0s
[08:41:11.403] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:124:0)
[08:41:11.403] Timer tick, asking Buildbucket for the build status
[08:41:11.466] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:11.466] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:125:0) after 1m0s
[08:42:11.599] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:125:0)
[08:42:11.599] Timer tick, asking Buildbucket for the build status
[08:42:12.425] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:12.425] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:126:0) after 1m0s
[08:43:12.495] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:126:0)
[08:43:12.495] Timer tick, asking Buildbucket for the build status
[08:43:12.567] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:12.567] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:127:0) after 1m0s
[08:44:12.626] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:127:0)
[08:44:12.626] Timer tick, asking Buildbucket for the build status
[08:44:13.040] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:13.040] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:128:0) after 1m0s
[08:45:13.064] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:128:0)
[08:45:13.064] Timer tick, asking Buildbucket for the build status
[08:45:13.132] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:13.132] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:129:0) after 1m0s
[08:46:13.217] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:129:0)
[08:46:13.217] Timer tick, asking Buildbucket for the build status
[08:46:13.268] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:13.268] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:130:0) after 1m0s
[08:47:13.319] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:130:0)
[08:47:13.319] Timer tick, asking Buildbucket for the build status
[08:47:13.417] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:13.417] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:131:0) after 1m0s
[08:48:13.476] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:131:0)
[08:48:13.476] Timer tick, asking Buildbucket for the build status
[08:48:13.533] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:13.533] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:132:0) after 1m0s
[08:49:13.511] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:132:0)
[08:49:13.511] Timer tick, asking Buildbucket for the build status
[08:49:13.815] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:13.815] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:133:0) after 1m0s
[08:50:13.892] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:133:0)
[08:50:13.892] Timer tick, asking Buildbucket for the build status
[08:50:14.135] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:14.135] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:134:0) after 1m0s
[08:51:14.248] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:134:0)
[08:51:14.248] Timer tick, asking Buildbucket for the build status
[08:51:14.309] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:14.309] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:135:0) after 1m0s
[08:52:14.431] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:135:0)
[08:52:14.431] Timer tick, asking Buildbucket for the build status
[08:52:14.520] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:14.520] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:136:0) after 1m0s
[08:53:14.654] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:136:0)
[08:53:14.654] Timer tick, asking Buildbucket for the build status
[08:53:14.818] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:14.818] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:137:0) after 1m0s
[08:54:14.921] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:137:0)
[08:54:14.921] Timer tick, asking Buildbucket for the build status
[08:54:14.987] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:14.987] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:138:0) after 1m0s
[08:55:15.129] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:138:0)
[08:55:15.129] Timer tick, asking Buildbucket for the build status
[08:55:15.230] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:15.230] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:139:0) after 1m0s
[08:56:15.426] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:139:0)
[08:56:15.426] Timer tick, asking Buildbucket for the build status
[08:56:15.552] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:15.552] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:140:0) after 1m0s
[08:57:15.604] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:140:0)
[08:57:15.604] Timer tick, asking Buildbucket for the build status
[08:57:15.655] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:15.656] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:141:0) after 1m0s
[08:58:15.761] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:141:0)
[08:58:15.761] Timer tick, asking Buildbucket for the build status
[08:58:16.018] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:16.018] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:142:0) after 1m0s
[08:59:16.085] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:142:0)
[08:59:16.085] Timer tick, asking Buildbucket for the build status
[08:59:16.152] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:16.152] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:143:0) after 1m0s
[09:00:16.187] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:143:0)
[09:00:16.187] Timer tick, asking Buildbucket for the build status
[09:00:16.359] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:16.359] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:144:0) after 1m0s
[09:01:16.431] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:144:0)
[09:01:16.431] Timer tick, asking Buildbucket for the build status
[09:01:16.517] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:16.517] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:145:0) after 1m0s
[09:02:16.665] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:145:0)
[09:02:16.665] Timer tick, asking Buildbucket for the build status
[09:02:16.911] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:16.911] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:146:0) after 1m0s
[09:03:17.047] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:146:0)
[09:03:17.047] Timer tick, asking Buildbucket for the build status
[09:03:17.435] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:17.435] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:147:0) after 1m0s
[09:04:17.554] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:147:0)
[09:04:17.554] Timer tick, asking Buildbucket for the build status
[09:04:17.606] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:17.606] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:148:0) after 1m0s
[09:05:17.759] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:148:0)
[09:05:17.759] Timer tick, asking Buildbucket for the build status
[09:05:17.865] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:17.865] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:149:0) after 1m0s
[09:06:17.986] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:149:0)
[09:06:17.986] Timer tick, asking Buildbucket for the build status
[09:06:18.104] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:18.104] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:150:0) after 1m0s
[09:07:18.172] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:150:0)
[09:07:18.172] Timer tick, asking Buildbucket for the build status
[09:07:18.234] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:18.234] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:151:0) after 1m0s
[09:08:18.293] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:151:0)
[09:08:18.293] Timer tick, asking Buildbucket for the build status
[09:08:18.609] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:18.609] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:152:0) after 1m0s
[09:09:18.658] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:152:0)
[09:09:18.658] Timer tick, asking Buildbucket for the build status
[09:09:18.740] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:18.740] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:153:0) after 1m0s
[09:10:18.981] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:153:0)
[09:10:18.981] Timer tick, asking Buildbucket for the build status
[09:10:19.044] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:19.044] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:154:0) after 1m0s
[09:11:19.208] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:154:0)
[09:11:19.208] Timer tick, asking Buildbucket for the build status
[09:11:19.291] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:19.291] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:155:0) after 1m0s
[09:12:19.654] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:155:0)
[09:12:19.654] Timer tick, asking Buildbucket for the build status
[09:12:19.747] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:19.747] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:156:0) after 1m0s
[09:13:19.901] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:156:0)
[09:13:19.901] Timer tick, asking Buildbucket for the build status
[09:13:19.998] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:19.998] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:157:0) after 1m0s
[09:14:20.389] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:157:0)
[09:14:20.389] Timer tick, asking Buildbucket for the build status
[09:14:20.467] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:20.467] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:158:0) after 1m0s
[09:15:20.870] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:158:0)
[09:15:20.870] Timer tick, asking Buildbucket for the build status
[09:15:20.926] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:20.926] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:159:0) after 1m0s
[09:16:21.079] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:159:0)
[09:16:21.079] Timer tick, asking Buildbucket for the build status
[09:16:21.231] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:21.231] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:160:0) after 1m0s
[09:17:21.299] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:160:0)
[09:17:21.299] Timer tick, asking Buildbucket for the build status
[09:17:21.360] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:21.360] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:161:0) after 1m0s
[09:18:21.479] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:161:0)
[09:18:21.479] Timer tick, asking Buildbucket for the build status
[09:18:21.923] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:21.923] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:162:0) after 1m0s
[09:19:22.133] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:162:0)
[09:19:22.133] Timer tick, asking Buildbucket for the build status
[09:19:22.898] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:22.898] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:163:0) after 1m0s
[09:20:22.979] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:163:0)
[09:20:22.979] Timer tick, asking Buildbucket for the build status
[09:20:23.040] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:23.040] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:164:0) after 1m0s
[09:21:23.233] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:164:0)
[09:21:23.233] Timer tick, asking Buildbucket for the build status
[09:21:23.426] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:23.426] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:165:0) after 1m0s
[09:22:23.537] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:165:0)
[09:22:23.537] Timer tick, asking Buildbucket for the build status
[09:22:23.630] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:23.630] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:166:0) after 1m0s
[09:23:23.691] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:166:0)
[09:23:23.691] Timer tick, asking Buildbucket for the build status
[09:23:23.752] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:23.752] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:167:0) after 1m0s
[09:24:24.093] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:167:0)
[09:24:24.093] Timer tick, asking Buildbucket for the build status
[09:24:24.153] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:24.154] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:168:0) after 1m0s
[09:25:24.378] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:168:0)
[09:25:24.378] Timer tick, asking Buildbucket for the build status
[09:25:24.442] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:24.442] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:169:0) after 1m0s
[09:26:24.643] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:169:0)
[09:26:24.643] Timer tick, asking Buildbucket for the build status
[09:26:24.901] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:24.901] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:170:0) after 1m0s
[09:27:24.972] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:170:0)
[09:27:24.972] Timer tick, asking Buildbucket for the build status
[09:27:25.104] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:25.104] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:171:0) after 1m0s
[09:28:25.217] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:171:0)
[09:28:25.217] Timer tick, asking Buildbucket for the build status
[09:28:25.279] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:25.279] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:172:0) after 1m0s
[09:29:25.309] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:172:0)
[09:29:25.309] Timer tick, asking Buildbucket for the build status
[09:29:25.508] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:25.508] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:173:0) after 1m0s
[09:30:25.585] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:173:0)
[09:30:25.585] Timer tick, asking Buildbucket for the build status
[09:30:25.635] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:25.635] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:174:0) after 1m0s
[09:31:25.730] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:174:0)
[09:31:25.730] Timer tick, asking Buildbucket for the build status
[09:31:25.785] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:25.785] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:175:0) after 1m0s
[09:32:25.936] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:175:0)
[09:32:25.936] Timer tick, asking Buildbucket for the build status
[09:32:26.062] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:26.062] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:176:0) after 1m0s
[09:33:26.140] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:176:0)
[09:33:26.140] Timer tick, asking Buildbucket for the build status
[09:33:26.203] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:26.203] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:177:0) after 1m0s
[09:34:26.263] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:177:0)
[09:34:26.263] Timer tick, asking Buildbucket for the build status
[09:34:26.508] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:26.508] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:178:0) after 1m0s
[09:35:26.532] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:178:0)
[09:35:26.532] Timer tick, asking Buildbucket for the build status
[09:35:26.727] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:26.727] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:179:0) after 1m0s
[09:36:26.733] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:179:0)
[09:36:26.733] Timer tick, asking Buildbucket for the build status
[09:36:27.117] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:27.117] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:180:0) after 1m0s
[09:37:27.313] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:180:0)
[09:37:27.313] Timer tick, asking Buildbucket for the build status
[09:37:27.407] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:27.407] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:181:0) after 1m0s
[09:38:27.437] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:181:0)
[09:38:27.437] Timer tick, asking Buildbucket for the build status
[09:38:27.550] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:27.550] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:182:0) after 1m0s
[09:39:27.568] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:182:0)
[09:39:27.568] Timer tick, asking Buildbucket for the build status
[09:39:27.630] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:27.630] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:183:0) after 1m0s
[09:40:27.656] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:183:0)
[09:40:27.656] Timer tick, asking Buildbucket for the build status
[09:40:27.941] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:27.941] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:184:0) after 1m0s
[09:41:27.997] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:184:0)
[09:41:27.997] Timer tick, asking Buildbucket for the build status
[09:41:28.306] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:28.306] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:185:0) after 1m0s
[09:42:28.422] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:185:0)
[09:42:28.422] Timer tick, asking Buildbucket for the build status
[09:42:28.546] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:28.546] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:186:0) after 1m0s
[09:43:28.603] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:186:0)
[09:43:28.603] Timer tick, asking Buildbucket for the build status
[09:43:28.702] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:28.702] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:187:0) after 1m0s
[09:44:28.786] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:187:0)
[09:44:28.786] Timer tick, asking Buildbucket for the build status
[09:44:28.930] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:28.930] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:188:0) after 1m0s
[09:45:29.038] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:188:0)
[09:45:29.038] Timer tick, asking Buildbucket for the build status
[09:45:29.105] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:29.105] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:189:0) after 1m0s
[09:46:29.136] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:189:0)
[09:46:29.136] Timer tick, asking Buildbucket for the build status
[09:46:29.445] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:29.445] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:190:0) after 1m0s
[09:47:29.450] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:190:0)
[09:47:29.450] Timer tick, asking Buildbucket for the build status
[09:47:29.841] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:29.841] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:191:0) after 1m0s
[09:48:29.930] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:191:0)
[09:48:29.930] Timer tick, asking Buildbucket for the build status
[09:48:30.210] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:30.210] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:192:0) after 1m0s
[09:49:30.242] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:192:0)
[09:49:30.242] Timer tick, asking Buildbucket for the build status
[09:49:30.317] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:30.317] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:193:0) after 1m0s
[09:50:30.342] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:193:0)
[09:50:30.342] Timer tick, asking Buildbucket for the build status
[09:50:30.399] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:30.399] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:194:0) after 1m0s
[09:51:30.423] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:194:0)
[09:51:30.423] Timer tick, asking Buildbucket for the build status
[09:51:30.635] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:30.635] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:195:0) after 1m0s
[09:52:30.660] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:195:0)
[09:52:30.660] Timer tick, asking Buildbucket for the build status
[09:52:30.979] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:30.979] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:196:0) after 1m0s
[09:53:31.112] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:196:0)
[09:53:31.112] Timer tick, asking Buildbucket for the build status
[09:53:31.321] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:31.321] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:197:0) after 1m0s
[09:54:31.511] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:197:0)
[09:54:31.511] Timer tick, asking Buildbucket for the build status
[09:54:31.575] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:31.575] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:198:0) after 1m0s
[09:55:31.703] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:198:0)
[09:55:31.703] Timer tick, asking Buildbucket for the build status
[09:55:31.754] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:31.754] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:199:0) after 1m0s
[09:56:31.838] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:199:0)
[09:56:31.838] Timer tick, asking Buildbucket for the build status
[09:56:31.895] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:31.895] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:200:0) after 1m0s
[09:57:31.970] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:200:0)
[09:57:31.970] Timer tick, asking Buildbucket for the build status
[09:57:32.025] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:32.025] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:201:0) after 1m0s
[09:58:32.053] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:201:0)
[09:58:32.053] Timer tick, asking Buildbucket for the build status
[09:58:32.155] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:32.156] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:202:0) after 1m0s
[09:59:32.259] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:202:0)
[09:59:32.259] Timer tick, asking Buildbucket for the build status
[09:59:32.326] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:32.326] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:203:0) after 1m0s
[10:00:32.420] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:203:0)
[10:00:32.420] Timer tick, asking Buildbucket for the build status
[10:00:32.517] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:32.517] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:204:0) after 1m0s
[10:01:32.671] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:204:0)
[10:01:32.671] Timer tick, asking Buildbucket for the build status
[10:01:32.944] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:32.944] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:205:0) after 1m0s
[10:02:32.996] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:205:0)
[10:02:32.996] Timer tick, asking Buildbucket for the build status
[10:02:33.150] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:33.150] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:206:0) after 1m0s
[10:03:33.289] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:206:0)
[10:03:33.289] Timer tick, asking Buildbucket for the build status
[10:03:33.384] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:33.384] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:207:0) after 1m0s
[10:04:33.504] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:207:0)
[10:04:33.504] Timer tick, asking Buildbucket for the build status
[10:04:33.628] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:33.628] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:208:0) after 1m0s
[10:05:33.668] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:208:0)
[10:05:33.668] Timer tick, asking Buildbucket for the build status
[10:05:33.733] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:33.733] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:209:0) after 1m0s
[10:06:33.802] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:209:0)
[10:06:33.802] Timer tick, asking Buildbucket for the build status
[10:06:33.865] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:33.865] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:210:0) after 1m0s
[10:07:33.940] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:210:0)
[10:07:33.940] Timer tick, asking Buildbucket for the build status
[10:07:33.994] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:33.994] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:211:0) after 1m0s
[10:08:34.029] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:211:0)
[10:08:34.029] Timer tick, asking Buildbucket for the build status
[10:08:34.133] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:34.133] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:212:0) after 1m0s
[10:09:34.179] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:212:0)
[10:09:34.179] Timer tick, asking Buildbucket for the build status
[10:09:34.311] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:34.311] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:213:0) after 1m0s
[10:10:34.335] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:213:0)
[10:10:34.335] Timer tick, asking Buildbucket for the build status
[10:10:34.416] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:34.416] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:214:0) after 1m0s
[10:11:34.546] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:214:0)
[10:11:34.546] Timer tick, asking Buildbucket for the build status
[10:11:34.607] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:34.607] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:215:0) after 1m0s
[10:12:34.685] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:215:0)
[10:12:34.685] Timer tick, asking Buildbucket for the build status
[10:12:34.837] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:34.837] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:216:0) after 1m0s
[10:13:34.824] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:216:0)
[10:13:34.824] Timer tick, asking Buildbucket for the build status
[10:13:34.883] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:34.883] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:217:0) after 1m0s
[10:14:34.978] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:217:0)
[10:14:34.979] Timer tick, asking Buildbucket for the build status
[10:14:35.072] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:35.072] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:218:0) after 1m0s
[10:15:35.237] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:218:0)
[10:15:35.237] Timer tick, asking Buildbucket for the build status
[10:15:35.448] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:35.448] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:219:0) after 1m0s
[10:16:35.629] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:219:0)
[10:16:35.629] Timer tick, asking Buildbucket for the build status
[10:16:35.687] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:35.687] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:220:0) after 1m0s
[10:17:35.765] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:220:0)
[10:17:35.765] Timer tick, asking Buildbucket for the build status
[10:17:35.819] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:35.819] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:221:0) after 1m0s
[10:18:35.919] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:221:0)
[10:18:35.919] Timer tick, asking Buildbucket for the build status
[10:18:35.980] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:35.980] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:222:0) after 1m0s
[10:19:36.012] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:222:0)
[10:19:36.012] Timer tick, asking Buildbucket for the build status
[10:19:36.104] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:36.104] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:223:0) after 1m0s
[10:20:36.140] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:223:0)
[10:20:36.140] Timer tick, asking Buildbucket for the build status
[10:20:36.203] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:36.203] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:224:0) after 1m0s
[10:21:36.316] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:224:0)
[10:21:36.316] Timer tick, asking Buildbucket for the build status
[10:21:36.507] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:36.507] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:225:0) after 1m0s
[10:22:36.585] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:225:0)
[10:22:36.585] Timer tick, asking Buildbucket for the build status
[10:22:36.649] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:36.649] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:226:0) after 1m0s
[10:23:36.688] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:226:0)
[10:23:36.688] Timer tick, asking Buildbucket for the build status
[10:23:36.845] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:36.845] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:227:0) after 1m0s
[10:24:36.827] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:227:0)
[10:24:36.827] Timer tick, asking Buildbucket for the build status
[10:24:37.212] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:37.212] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:228:0) after 1m0s
[10:25:37.214] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:228:0)
[10:25:37.214] Timer tick, asking Buildbucket for the build status
[10:25:37.634] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:37.634] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:229:0) after 1m0s
[10:26:37.797] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:229:0)
[10:26:37.797] Timer tick, asking Buildbucket for the build status
[10:26:37.855] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:37.855] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:230:0) after 1m0s
[10:27:37.882] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:230:0)
[10:27:37.882] Timer tick, asking Buildbucket for the build status
[10:27:38.043] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:38.043] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:231:0) after 1m0s
[10:28:38.086] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:231:0)
[10:28:38.086] Timer tick, asking Buildbucket for the build status
[10:28:38.155] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:38.155] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:232:0) after 1m0s
[10:29:38.189] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:232:0)
[10:29:38.189] Timer tick, asking Buildbucket for the build status
[10:29:38.729] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:38.729] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:233:0) after 1m0s
[10:30:38.857] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:233:0)
[10:30:38.857] Timer tick, asking Buildbucket for the build status
[10:30:38.920] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:38.920] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:234:0) after 1m0s
[10:31:38.938] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:234:0)
[10:31:38.938] Timer tick, asking Buildbucket for the build status
[10:31:38.989] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:38.989] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:235:0) after 1m0s
[10:32:39.013] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:235:0)
[10:32:39.013] Timer tick, asking Buildbucket for the build status
[10:32:39.501] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:39.501] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:236:0) after 1m0s
[10:33:41.139] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:236:0)
[10:33:41.139] Timer tick, asking Buildbucket for the build status
[10:33:41.198] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:41.198] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:237:0) after 1m0s
[10:34:41.527] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:237:0)
[10:34:41.527] Timer tick, asking Buildbucket for the build status
[10:34:41.591] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:41.591] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:238:0) after 1m0s
[10:35:41.848] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:238:0)
[10:35:41.848] Timer tick, asking Buildbucket for the build status
[10:35:42.609] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:42.609] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:239:0) after 1m0s
[10:36:42.618] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:239:0)
[10:36:42.618] Timer tick, asking Buildbucket for the build status
[10:36:43.005] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:43.005] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:240:0) after 1m0s
[10:37:43.082] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:240:0)
[10:37:43.082] Timer tick, asking Buildbucket for the build status
[10:37:43.142] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:43.142] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:241:0) after 1m0s
[10:38:43.239] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:241:0)
[10:38:43.239] Timer tick, asking Buildbucket for the build status
[10:38:43.347] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:43.347] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:242:0) after 1m0s
[10:39:43.690] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:242:0)
[10:39:43.691] Timer tick, asking Buildbucket for the build status
[10:39:43.743] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:43.743] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:243:0) after 1m0s
[10:40:43.857] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:243:0)
[10:40:43.857] Timer tick, asking Buildbucket for the build status
[10:40:44.135] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:44.135] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:244:0) after 1m0s
[10:41:44.371] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:244:0)
[10:41:44.371] Timer tick, asking Buildbucket for the build status
[10:41:44.730] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:44.730] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:245:0) after 1m0s
[10:42:44.854] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:245:0)
[10:42:44.854] Timer tick, asking Buildbucket for the build status
[10:42:44.920] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:44.920] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:246:0) after 1m0s
[10:43:45.132] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:246:0)
[10:43:45.132] Timer tick, asking Buildbucket for the build status
[10:43:45.289] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:45.289] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:247:0) after 1m0s
[10:44:45.460] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:247:0)
[10:44:45.460] Timer tick, asking Buildbucket for the build status
[10:44:45.534] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:45.534] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:248:0) after 1m0s
[10:45:45.676] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:248:0)
[10:45:45.676] Timer tick, asking Buildbucket for the build status
[10:45:45.777] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:45.777] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:249:0) after 1m0s
[10:46:45.817] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:249:0)
[10:46:45.817] Timer tick, asking Buildbucket for the build status
[10:46:45.902] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:45.902] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:250:0) after 1m0s
[10:47:45.989] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:250:0)
[10:47:45.989] Timer tick, asking Buildbucket for the build status
[10:47:46.301] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:46.301] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:251:0) after 1m0s
[10:48:46.329] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:251:0)
[10:48:46.329] Timer tick, asking Buildbucket for the build status
[10:48:46.468] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:46.468] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:252:0) after 1m0s
[10:49:46.548] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:252:0)
[10:49:46.548] Timer tick, asking Buildbucket for the build status
[10:49:46.616] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:46.616] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:253:0) after 1m0s
[10:50:46.743] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:253:0)
[10:50:46.743] Timer tick, asking Buildbucket for the build status
[10:50:46.802] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:46.802] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:254:0) after 1m0s
[10:51:46.946] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:254:0)
[10:51:46.946] Timer tick, asking Buildbucket for the build status
[10:51:47.045] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:47.045] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:255:0) after 1m0s
[10:52:47.082] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:255:0)
[10:52:47.082] Timer tick, asking Buildbucket for the build status
[10:52:47.301] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:47.301] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:256:0) after 1m0s
[10:53:47.521] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:256:0)
[10:53:47.521] Timer tick, asking Buildbucket for the build status
[10:53:47.583] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:47.583] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:257:0) after 1m0s
[10:54:47.615] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:257:0)
[10:54:47.615] Timer tick, asking Buildbucket for the build status
[10:54:47.848] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:47.848] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:258:0) after 1m0s
[10:55:47.892] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:258:0)
[10:55:47.892] Timer tick, asking Buildbucket for the build status
[10:55:47.950] Build 8861049679859478032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:47.950] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026479741918056368:259:0) after 1m0s
[10:56:27.223] Received PubSub notification, asking Buildbucket for the build status
[10:56:27.286] Build 8861049679859478032: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:56:27.286] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1607856985792271",
"created_by": "project:chromium",
"created_ts": "1607841526126672",
"id": "8861049679859478032",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d54c6c3a98c9b924333932bb982d00c4222e76f7\"}}",
"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\": \"d54c6c3a98c9b924333932bb982d00c4222e76f7\", \"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-2-zd44\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 1161, \"got_angle_revision\": \"4fb29e83e02c5152ebc60733eb5351ea98c7097d\", \"got_dawn_revision\": \"fb6c21547e6c5bc2053c15169769397e6584c9d2\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"d54c6c3a98c9b924333932bb982d00c4222e76f7\", \"got_revision_cp\": \"refs/heads/master@{#836466}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"c16dc7107fd329b815c700b002d1ba40372b16dc\", \"got_v8_revision\": \"e7e9e702c110a535bb2daa6cd60db7b7d62d8665\", \"got_v8_revision_cp\": \"refs/heads/8.9.143@{#1}\", \"got_webrtc_revision\": \"d7808f1c464a07c8f1e2f97ec7ee92fda998d590\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32804}\", \"mirrored_builders\": [\"tryserver.chromium:win-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d54c6c3a98c9b924333932bb982d00c4222e76f7\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_9b3ebe5fd1c5be87380c40d216747346a59b28cf26de183f0e8e2b32e944d3c8_v2\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-2-zd44\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"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\": [\"5657-0417a3f\"], \"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": "1607841563010315",
"status": "COMPLETED",
"status_changed_ts": "1607856986979435",
"tags": [
"build_address:luci.chromium.ci/win-official/1161",
"builder:win-official",
"buildset:commit/git/d54c6c3a98c9b924333932bb982d00c4222e76f7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d54c6c3a98c9b924333932bb982d00c4222e76f7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026479741918056368",
"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/8861049679859478032/+/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:5073a43bee39e010",
"user_agent:luci-scheduler"
],
"updated_ts": "1607856986995575",
"url": "https://ci.chromium.org/b/8861049679859478032",
"utcnow_ts": "1607856987279685"
}
}
[10:56:27.286] Invocation finished in 4h17m42.506992181s with status SUCCEEDED