[05:50:26.611] New invocation is queued and will start shortly
[05:50:27.711] Starting the invocation (attempt 1)
[05:50:27.748] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:50:27.748] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:50:27.748] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021590544699283920",
"parameters_json": "{\"builder_name\":\"win32-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"e637d705322bc4a97c1af33afff352e4e36b452d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win32-official",
"scheduler_invocation_id:9021590544699283920",
"scheduler_job_id:chromium/win32-official",
"user_agent:luci-scheduler",
"buildset:commit/git/e637d705322bc4a97c1af33afff352e4e36b452d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e637d705322bc4a97c1af33afff352e4e36b452d",
"gitiles_ref:refs/heads/master"
]
}
[05:50:28.292] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612504227830105",
"id": "8856160482757444848",
"parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e637d705322bc4a97c1af33afff352e4e36b452d\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612504228180050",
"tags": [
"build_address:luci.chromium.ci/win32-official/1489",
"builder:win32-official",
"buildset:commit/git/e637d705322bc4a97c1af33afff352e4e36b452d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e637d705322bc4a97c1af33afff352e4e36b452d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021590544699283920",
"scheduler_job_id:chromium/win32-official",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8856160482757444848/+/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": "1612504228180163",
"url": "https://ci.chromium.org/b/8856160482757444848",
"utcnow_ts": "1612504228283976"
}
}
[05:50:28.292] Task URL: https://ci.chromium.org/b/8856160482757444848
[05:50:28.292] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:2:0) after 1m0s
[05:50:31.971] Received PubSub notification, asking Buildbucket for the build status
[05:50:32.075] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:28.327] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:2:0)
[05:51:28.327] Timer tick, asking Buildbucket for the build status
[05:51:28.411] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:28.411] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:4:0) after 1m0s
[05:52:28.500] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:4:0)
[05:52:28.500] Timer tick, asking Buildbucket for the build status
[05:52:28.656] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:28.656] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:5:0) after 1m0s
[05:53:28.812] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:5:0)
[05:53:28.812] Timer tick, asking Buildbucket for the build status
[05:53:28.894] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:28.894] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:6:0) after 1m0s
[05:54:28.952] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:6:0)
[05:54:28.952] Timer tick, asking Buildbucket for the build status
[05:54:29.019] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:29.020] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:7:0) after 1m0s
[05:55:29.089] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:7:0)
[05:55:29.089] Timer tick, asking Buildbucket for the build status
[05:55:29.334] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:29.334] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:8:0) after 1m0s
[05:56:29.349] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:8:0)
[05:56:29.349] Timer tick, asking Buildbucket for the build status
[05:56:29.664] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:29.664] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:9:0) after 1m0s
[05:57:29.725] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:9:0)
[05:57:29.725] Timer tick, asking Buildbucket for the build status
[05:57:29.859] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:29.859] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:10:0) after 1m0s
[05:58:29.889] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:10:0)
[05:58:29.889] Timer tick, asking Buildbucket for the build status
[05:58:29.955] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:29.955] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:11:0) after 1m0s
[05:59:29.977] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:11:0)
[05:59:29.977] Timer tick, asking Buildbucket for the build status
[05:59:30.110] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:30.110] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:12:0) after 1m0s
[06:00:30.134] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:12:0)
[06:00:30.134] Timer tick, asking Buildbucket for the build status
[06:00:30.293] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:30.293] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:13:0) after 1m0s
[06:01:36.932] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:13:0)
[06:01:36.932] Timer tick, asking Buildbucket for the build status
[06:01:37.020] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:37.020] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:14:0) after 1m0s
[06:02:37.172] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:14:0)
[06:02:37.172] Timer tick, asking Buildbucket for the build status
[06:02:37.407] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:37.407] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:15:0) after 1m0s
[06:03:37.429] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:15:0)
[06:03:37.429] Timer tick, asking Buildbucket for the build status
[06:03:37.530] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:37.530] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:16:0) after 1m0s
[06:04:37.555] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:16:0)
[06:04:37.555] Timer tick, asking Buildbucket for the build status
[06:04:37.658] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:37.658] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:17:0) after 1m0s
[06:05:37.705] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:17:0)
[06:05:37.706] Timer tick, asking Buildbucket for the build status
[06:05:37.806] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:37.806] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:18:0) after 1m0s
[06:06:37.824] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:18:0)
[06:06:37.824] Timer tick, asking Buildbucket for the build status
[06:06:37.892] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:37.892] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:19:0) after 1m0s
[06:07:37.911] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:19:0)
[06:07:37.911] Timer tick, asking Buildbucket for the build status
[06:07:37.959] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:37.959] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:20:0) after 1m0s
[06:08:38.024] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:20:0)
[06:08:38.024] Timer tick, asking Buildbucket for the build status
[06:08:38.076] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:38.076] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:21:0) after 1m0s
[06:09:38.136] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:21:0)
[06:09:38.136] Timer tick, asking Buildbucket for the build status
[06:09:38.192] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:38.192] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:22:0) after 1m0s
[06:10:38.225] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:22:0)
[06:10:38.225] Timer tick, asking Buildbucket for the build status
[06:10:38.426] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:38.426] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:23:0) after 1m0s
[06:11:38.428] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:23:0)
[06:11:38.428] Timer tick, asking Buildbucket for the build status
[06:11:38.487] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:38.487] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:24:0) after 1m0s
[06:12:38.508] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:24:0)
[06:12:38.508] Timer tick, asking Buildbucket for the build status
[06:12:38.906] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:38.906] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:25:0) after 1m0s
[06:13:38.944] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:25:0)
[06:13:38.944] Timer tick, asking Buildbucket for the build status
[06:13:39.159] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:39.159] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:26:0) after 1m0s
[06:14:39.187] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:26:0)
[06:14:39.187] Timer tick, asking Buildbucket for the build status
[06:14:39.314] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:39.314] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:27:0) after 1m0s
[06:15:39.918] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:27:0)
[06:15:39.918] Timer tick, asking Buildbucket for the build status
[06:15:40.054] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:40.054] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:28:0) after 1m0s
[06:16:40.071] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:28:0)
[06:16:40.071] Timer tick, asking Buildbucket for the build status
[06:16:40.211] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:40.211] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:29:0) after 1m0s
[06:17:40.242] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:29:0)
[06:17:40.242] Timer tick, asking Buildbucket for the build status
[06:17:40.432] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:40.432] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:30:0) after 1m0s
[06:18:40.454] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:30:0)
[06:18:40.454] Timer tick, asking Buildbucket for the build status
[06:18:40.526] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:40.526] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:31:0) after 1m0s
[06:19:40.535] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:31:0)
[06:19:40.535] Timer tick, asking Buildbucket for the build status
[06:19:40.621] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:40.621] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:32:0) after 1m0s
[06:20:40.615] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:32:0)
[06:20:40.615] Timer tick, asking Buildbucket for the build status
[06:20:40.847] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:40.847] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:33:0) after 1m0s
[06:21:40.881] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:33:0)
[06:21:40.881] Timer tick, asking Buildbucket for the build status
[06:21:40.939] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:40.940] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:34:0) after 1m0s
[06:22:40.935] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:34:0)
[06:22:40.935] Timer tick, asking Buildbucket for the build status
[06:22:40.996] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:40.996] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:35:0) after 1m0s
[06:23:41.031] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:35:0)
[06:23:41.031] Timer tick, asking Buildbucket for the build status
[06:23:41.297] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:41.297] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:36:0) after 1m0s
[06:24:41.375] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:36:0)
[06:24:41.375] Timer tick, asking Buildbucket for the build status
[06:24:41.443] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:41.443] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:37:0) after 1m0s
[06:25:41.485] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:37:0)
[06:25:41.485] Timer tick, asking Buildbucket for the build status
[06:25:41.580] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:41.580] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:38:0) after 1m0s
[06:26:41.650] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:38:0)
[06:26:41.650] Timer tick, asking Buildbucket for the build status
[06:26:41.758] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:41.758] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:39:0) after 1m0s
[06:27:41.860] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:39:0)
[06:27:41.860] Timer tick, asking Buildbucket for the build status
[06:27:41.976] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:41.976] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:40:0) after 1m0s
[06:28:42.035] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:40:0)
[06:28:42.035] Timer tick, asking Buildbucket for the build status
[06:28:42.134] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:42.134] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:41:0) after 1m0s
[06:29:42.285] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:41:0)
[06:29:42.285] Timer tick, asking Buildbucket for the build status
[06:29:42.373] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:42.373] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:42:0) after 1m0s
[06:30:42.602] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:42:0)
[06:30:42.602] Timer tick, asking Buildbucket for the build status
[06:30:42.907] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:42.907] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:43:0) after 1m0s
[06:31:42.961] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:43:0)
[06:31:42.961] Timer tick, asking Buildbucket for the build status
[06:31:43.325] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:43.325] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:44:0) after 1m0s
[06:32:43.422] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:44:0)
[06:32:43.422] Timer tick, asking Buildbucket for the build status
[06:32:43.477] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:43.477] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:45:0) after 1m0s
[06:33:44.010] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:45:0)
[06:33:44.010] Timer tick, asking Buildbucket for the build status
[06:33:44.304] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:44.304] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:46:0) after 1m0s
[06:34:44.381] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:46:0)
[06:34:44.381] Timer tick, asking Buildbucket for the build status
[06:34:44.490] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:44.490] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:47:0) after 1m0s
[06:35:44.688] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:47:0)
[06:35:44.688] Timer tick, asking Buildbucket for the build status
[06:35:44.919] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:44.919] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:48:0) after 1m0s
[06:36:45.002] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:48:0)
[06:36:45.002] Timer tick, asking Buildbucket for the build status
[06:36:45.112] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:45.112] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:49:0) after 1m0s
[06:37:45.223] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:49:0)
[06:37:45.223] Timer tick, asking Buildbucket for the build status
[06:37:45.291] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:45.291] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:50:0) after 1m0s
[06:38:45.396] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:50:0)
[06:38:45.396] Timer tick, asking Buildbucket for the build status
[06:38:45.510] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:45.510] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:51:0) after 1m0s
[06:39:45.603] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:51:0)
[06:39:45.603] Timer tick, asking Buildbucket for the build status
[06:39:45.656] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:45.656] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:52:0) after 1m0s
[06:40:45.727] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:52:0)
[06:40:45.727] Timer tick, asking Buildbucket for the build status
[06:40:46.008] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:46.008] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:53:0) after 1m0s
[06:41:46.028] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:53:0)
[06:41:46.028] Timer tick, asking Buildbucket for the build status
[06:41:46.083] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:46.083] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:54:0) after 1m0s
[06:42:46.108] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:54:0)
[06:42:46.108] Timer tick, asking Buildbucket for the build status
[06:42:46.254] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:46.254] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:55:0) after 1m0s
[06:43:46.289] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:55:0)
[06:43:46.289] Timer tick, asking Buildbucket for the build status
[06:43:46.536] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:46.536] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:56:0) after 1m0s
[06:44:46.645] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:56:0)
[06:44:46.645] Timer tick, asking Buildbucket for the build status
[06:44:47.139] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:47.139] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:57:0) after 1m0s
[06:45:47.172] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:57:0)
[06:45:47.172] Timer tick, asking Buildbucket for the build status
[06:45:47.296] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:47.296] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:58:0) after 1m0s
[06:46:47.367] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:58:0)
[06:46:47.367] Timer tick, asking Buildbucket for the build status
[06:46:47.458] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:47.458] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:59:0) after 1m0s
[06:47:47.515] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:59:0)
[06:47:47.515] Timer tick, asking Buildbucket for the build status
[06:47:47.575] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:47.575] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:60:0) after 1m0s
[06:48:47.614] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:60:0)
[06:48:47.614] Timer tick, asking Buildbucket for the build status
[06:48:47.802] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:47.802] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:61:0) after 1m0s
[06:49:47.884] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:61:0)
[06:49:47.884] Timer tick, asking Buildbucket for the build status
[06:49:48.113] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:48.113] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:62:0) after 1m0s
[06:50:48.150] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:62:0)
[06:50:48.150] Timer tick, asking Buildbucket for the build status
[06:50:48.404] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:48.404] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:63:0) after 1m0s
[06:51:48.426] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:63:0)
[06:51:48.426] Timer tick, asking Buildbucket for the build status
[06:51:48.488] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:48.488] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:64:0) after 1m0s
[06:52:48.513] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:64:0)
[06:52:48.513] Timer tick, asking Buildbucket for the build status
[06:52:48.744] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:48.744] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:65:0) after 1m0s
[06:53:48.828] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:65:0)
[06:53:48.828] Timer tick, asking Buildbucket for the build status
[06:53:48.895] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:48.895] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:66:0) after 1m0s
[06:54:48.901] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:66:0)
[06:54:48.901] Timer tick, asking Buildbucket for the build status
[06:54:49.108] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:49.108] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:67:0) after 1m0s
[06:55:49.202] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:67:0)
[06:55:49.202] Timer tick, asking Buildbucket for the build status
[06:55:49.717] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:49.718] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:68:0) after 1m0s
[06:56:49.752] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:68:0)
[06:56:49.752] Timer tick, asking Buildbucket for the build status
[06:56:49.813] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:49.813] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:69:0) after 1m0s
[06:57:49.822] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:69:0)
[06:57:49.822] Timer tick, asking Buildbucket for the build status
[06:57:49.901] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:49.901] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:70:0) after 1m0s
[06:58:49.971] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:70:0)
[06:58:49.971] Timer tick, asking Buildbucket for the build status
[06:58:50.032] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:50.032] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:71:0) after 1m0s
[06:59:50.131] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:71:0)
[06:59:50.131] Timer tick, asking Buildbucket for the build status
[06:59:50.187] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:50.187] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:72:0) after 1m0s
[07:00:50.298] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:72:0)
[07:00:50.298] Timer tick, asking Buildbucket for the build status
[07:00:50.424] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:50.424] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:73:0) after 1m0s
[07:01:50.444] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:73:0)
[07:01:50.444] Timer tick, asking Buildbucket for the build status
[07:01:50.539] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:50.539] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:74:0) after 1m0s
[07:02:50.584] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:74:0)
[07:02:50.584] Timer tick, asking Buildbucket for the build status
[07:02:50.659] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:50.659] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:75:0) after 1m0s
[07:03:50.709] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:75:0)
[07:03:50.709] Timer tick, asking Buildbucket for the build status
[07:03:50.825] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:50.825] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:76:0) after 1m0s
[07:04:50.856] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:76:0)
[07:04:50.856] Timer tick, asking Buildbucket for the build status
[07:04:50.982] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:50.982] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:77:0) after 1m0s
[07:05:51.004] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:77:0)
[07:05:51.004] Timer tick, asking Buildbucket for the build status
[07:05:51.111] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:51.111] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:78:0) after 1m0s
[07:06:51.142] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:78:0)
[07:06:51.142] Timer tick, asking Buildbucket for the build status
[07:06:51.500] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:51.500] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:79:0) after 1m0s
[07:07:51.546] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:79:0)
[07:07:51.546] Timer tick, asking Buildbucket for the build status
[07:07:51.626] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:51.626] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:80:0) after 1m0s
[07:08:51.610] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:80:0)
[07:08:51.610] Timer tick, asking Buildbucket for the build status
[07:08:51.666] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:51.666] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:81:0) after 1m0s
[07:09:51.665] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:81:0)
[07:09:51.665] Timer tick, asking Buildbucket for the build status
[07:09:51.742] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:51.742] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:82:0) after 1m0s
[07:10:51.764] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:82:0)
[07:10:51.764] Timer tick, asking Buildbucket for the build status
[07:10:52.225] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:52.225] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:83:0) after 1m0s
[07:11:52.276] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:83:0)
[07:11:52.276] Timer tick, asking Buildbucket for the build status
[07:11:52.339] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:52.340] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:84:0) after 1m0s
[07:12:52.324] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:84:0)
[07:12:52.324] Timer tick, asking Buildbucket for the build status
[07:12:52.441] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:52.441] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:85:0) after 1m0s
[07:13:52.435] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:85:0)
[07:13:52.435] Timer tick, asking Buildbucket for the build status
[07:13:52.652] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:52.652] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:86:0) after 1m0s
[07:14:52.651] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:86:0)
[07:14:52.651] Timer tick, asking Buildbucket for the build status
[07:14:52.745] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:52.745] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:87:0) after 1m0s
[07:15:52.767] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:87:0)
[07:15:52.767] Timer tick, asking Buildbucket for the build status
[07:15:53.048] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:53.048] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:88:0) after 1m0s
[07:16:53.118] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:88:0)
[07:16:53.118] Timer tick, asking Buildbucket for the build status
[07:16:53.395] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:53.395] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:89:0) after 1m0s
[07:17:53.447] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:89:0)
[07:17:53.447] Timer tick, asking Buildbucket for the build status
[07:17:53.645] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:53.645] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:90:0) after 1m0s
[07:18:53.673] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:90:0)
[07:18:53.673] Timer tick, asking Buildbucket for the build status
[07:18:53.834] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:53.834] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:91:0) after 1m0s
[07:19:53.849] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:91:0)
[07:19:53.849] Timer tick, asking Buildbucket for the build status
[07:19:53.900] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:53.900] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:92:0) after 1m0s
[07:20:53.923] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:92:0)
[07:20:53.923] Timer tick, asking Buildbucket for the build status
[07:20:54.024] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:54.024] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:93:0) after 1m0s
[07:21:54.121] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:93:0)
[07:21:54.121] Timer tick, asking Buildbucket for the build status
[07:21:54.181] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:54.181] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:94:0) after 1m0s
[07:22:54.295] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:94:0)
[07:22:54.295] Timer tick, asking Buildbucket for the build status
[07:22:54.435] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:54.435] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:95:0) after 1m0s
[07:23:54.428] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:95:0)
[07:23:54.428] Timer tick, asking Buildbucket for the build status
[07:23:54.701] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:54.701] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:96:0) after 1m0s
[07:24:54.718] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:96:0)
[07:24:54.718] Timer tick, asking Buildbucket for the build status
[07:24:54.784] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:54.784] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:97:0) after 1m0s
[07:25:54.836] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:97:0)
[07:25:54.836] Timer tick, asking Buildbucket for the build status
[07:25:55.108] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:55.108] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:98:0) after 1m0s
[07:26:55.460] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:98:0)
[07:26:55.460] Timer tick, asking Buildbucket for the build status
[07:26:55.702] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:55.702] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:99:0) after 1m0s
[07:27:55.749] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:99:0)
[07:27:55.749] Timer tick, asking Buildbucket for the build status
[07:27:55.803] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:55.803] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:100:0) after 1m0s
[07:28:55.816] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:100:0)
[07:28:55.816] Timer tick, asking Buildbucket for the build status
[07:28:55.939] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:55.939] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:101:0) after 1m0s
[07:29:56.013] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:101:0)
[07:29:56.013] Timer tick, asking Buildbucket for the build status
[07:29:56.072] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:56.072] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:102:0) after 1m0s
[07:30:56.074] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:102:0)
[07:30:56.074] Timer tick, asking Buildbucket for the build status
[07:30:56.201] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:56.201] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:103:0) after 1m0s
[07:31:56.231] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:103:0)
[07:31:56.231] Timer tick, asking Buildbucket for the build status
[07:31:56.550] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:56.550] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:104:0) after 1m0s
[07:32:56.574] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:104:0)
[07:32:56.574] Timer tick, asking Buildbucket for the build status
[07:32:56.696] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:56.696] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:105:0) after 1m0s
[07:33:56.790] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:105:0)
[07:33:56.790] Timer tick, asking Buildbucket for the build status
[07:33:56.844] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:56.844] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:106:0) after 1m0s
[07:34:56.893] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:106:0)
[07:34:56.893] Timer tick, asking Buildbucket for the build status
[07:34:56.944] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:56.944] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:107:0) after 1m0s
[07:35:57.053] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:107:0)
[07:35:57.053] Timer tick, asking Buildbucket for the build status
[07:35:57.168] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:57.168] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:108:0) after 1m0s
[07:36:57.193] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:108:0)
[07:36:57.193] Timer tick, asking Buildbucket for the build status
[07:36:57.266] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:57.266] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:109:0) after 1m0s
[07:37:57.348] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:109:0)
[07:37:57.348] Timer tick, asking Buildbucket for the build status
[07:37:57.434] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:57.434] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:110:0) after 1m0s
[07:38:57.431] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:110:0)
[07:38:57.431] Timer tick, asking Buildbucket for the build status
[07:38:57.491] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:57.491] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:111:0) after 1m0s
[07:39:57.501] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:111:0)
[07:39:57.501] Timer tick, asking Buildbucket for the build status
[07:39:58.070] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:58.070] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:112:0) after 1m0s
[07:40:58.098] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:112:0)
[07:40:58.098] Timer tick, asking Buildbucket for the build status
[07:40:58.698] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:58.698] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:113:0) after 1m0s
[07:41:58.726] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:113:0)
[07:41:58.726] Timer tick, asking Buildbucket for the build status
[07:41:58.783] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:58.783] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:114:0) after 1m0s
[07:42:58.879] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:114:0)
[07:42:58.879] Timer tick, asking Buildbucket for the build status
[07:42:58.943] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:58.943] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:115:0) after 1m0s
[07:43:58.916] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:115:0)
[07:43:58.916] Timer tick, asking Buildbucket for the build status
[07:43:58.985] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:58.985] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:116:0) after 1m0s
[07:44:59.044] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:116:0)
[07:44:59.044] Timer tick, asking Buildbucket for the build status
[07:44:59.214] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:59.214] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:117:0) after 1m0s
[07:45:59.285] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:117:0)
[07:45:59.285] Timer tick, asking Buildbucket for the build status
[07:45:59.463] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:59.463] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:118:0) after 1m0s
[07:46:59.485] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:118:0)
[07:46:59.485] Timer tick, asking Buildbucket for the build status
[07:46:59.536] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:59.536] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:119:0) after 1m0s
[07:47:59.529] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:119:0)
[07:47:59.529] Timer tick, asking Buildbucket for the build status
[07:47:59.605] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:59.605] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:120:0) after 1m0s
[07:48:59.628] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:120:0)
[07:48:59.628] Timer tick, asking Buildbucket for the build status
[07:49:00.147] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:00.147] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:121:0) after 1m0s
[07:50:00.182] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:121:0)
[07:50:00.182] Timer tick, asking Buildbucket for the build status
[07:50:00.307] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:00.307] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:122:0) after 1m0s
[07:51:00.341] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:122:0)
[07:51:00.341] Timer tick, asking Buildbucket for the build status
[07:51:00.598] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:00.598] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:123:0) after 1m0s
[07:52:00.598] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:123:0)
[07:52:00.598] Timer tick, asking Buildbucket for the build status
[07:52:00.700] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:00.700] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:124:0) after 1m0s
[07:53:00.763] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:124:0)
[07:53:00.763] Timer tick, asking Buildbucket for the build status
[07:53:01.051] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:01.051] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:125:0) after 1m0s
[07:54:01.076] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:125:0)
[07:54:01.076] Timer tick, asking Buildbucket for the build status
[07:54:01.140] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:01.140] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:126:0) after 1m0s
[07:55:01.293] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:126:0)
[07:55:01.293] Timer tick, asking Buildbucket for the build status
[07:55:01.419] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:01.419] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:127:0) after 1m0s
[07:56:01.475] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:127:0)
[07:56:01.475] Timer tick, asking Buildbucket for the build status
[07:56:02.776] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:02.776] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:128:0) after 1m0s
[07:57:02.818] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:128:0)
[07:57:02.818] Timer tick, asking Buildbucket for the build status
[07:57:02.936] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:02.936] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:129:0) after 1m0s
[07:58:02.978] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:129:0)
[07:58:02.978] Timer tick, asking Buildbucket for the build status
[07:58:03.135] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:03.135] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:130:0) after 1m0s
[07:59:03.259] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:130:0)
[07:59:03.259] Timer tick, asking Buildbucket for the build status
[07:59:03.443] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:03.443] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:131:0) after 1m0s
[08:00:03.502] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:131:0)
[08:00:03.502] Timer tick, asking Buildbucket for the build status
[08:00:03.782] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:03.782] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:132:0) after 1m0s
[08:01:03.893] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:132:0)
[08:01:03.893] Timer tick, asking Buildbucket for the build status
[08:01:04.009] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:04.009] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:133:0) after 1m0s
[08:02:04.152] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:133:0)
[08:02:04.153] Timer tick, asking Buildbucket for the build status
[08:02:04.251] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:04.251] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:134:0) after 1m0s
[08:03:04.320] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:134:0)
[08:03:04.320] Timer tick, asking Buildbucket for the build status
[08:03:04.401] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:04.401] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:135:0) after 1m0s
[08:04:04.477] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:135:0)
[08:04:04.477] Timer tick, asking Buildbucket for the build status
[08:04:05.368] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:05.368] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:136:0) after 1m0s
[08:05:05.420] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:136:0)
[08:05:05.420] Timer tick, asking Buildbucket for the build status
[08:05:05.538] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:05.538] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:137:0) after 1m0s
[08:06:05.637] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:137:0)
[08:06:05.637] Timer tick, asking Buildbucket for the build status
[08:06:05.742] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:05.742] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:138:0) after 1m0s
[08:07:05.782] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:138:0)
[08:07:05.782] Timer tick, asking Buildbucket for the build status
[08:07:05.843] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:05.843] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:139:0) after 1m0s
[08:08:05.943] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:139:0)
[08:08:05.943] Timer tick, asking Buildbucket for the build status
[08:08:06.004] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:06.004] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:140:0) after 1m0s
[08:09:06.097] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:140:0)
[08:09:06.097] Timer tick, asking Buildbucket for the build status
[08:09:06.158] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:06.158] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:141:0) after 1m0s
[08:10:06.232] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:141:0)
[08:10:06.232] Timer tick, asking Buildbucket for the build status
[08:10:06.289] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:06.289] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:142:0) after 1m0s
[08:11:06.368] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:142:0)
[08:11:06.368] Timer tick, asking Buildbucket for the build status
[08:11:07.027] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:07.027] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:143:0) after 1m0s
[08:12:07.090] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:143:0)
[08:12:07.090] Timer tick, asking Buildbucket for the build status
[08:12:07.158] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:07.158] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:144:0) after 1m0s
[08:13:07.176] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:144:0)
[08:13:07.176] Timer tick, asking Buildbucket for the build status
[08:13:07.231] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:07.231] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:145:0) after 1m0s
[08:14:07.312] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:145:0)
[08:14:07.312] Timer tick, asking Buildbucket for the build status
[08:14:07.559] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:07.559] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:146:0) after 1m0s
[08:15:07.637] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:146:0)
[08:15:07.638] Timer tick, asking Buildbucket for the build status
[08:15:07.733] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:07.733] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:147:0) after 1m0s
[08:16:07.762] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:147:0)
[08:16:07.762] Timer tick, asking Buildbucket for the build status
[08:16:07.908] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:07.908] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:148:0) after 1m0s
[08:17:08.036] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:148:0)
[08:17:08.036] Timer tick, asking Buildbucket for the build status
[08:17:08.118] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:08.118] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:149:0) after 1m0s
[08:18:08.149] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:149:0)
[08:18:08.149] Timer tick, asking Buildbucket for the build status
[08:18:08.225] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:08.225] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:150:0) after 1m0s
[08:19:08.250] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:150:0)
[08:19:08.250] Timer tick, asking Buildbucket for the build status
[08:19:08.440] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:08.440] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:151:0) after 1m0s
[08:20:08.535] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:151:0)
[08:20:08.535] Timer tick, asking Buildbucket for the build status
[08:20:08.644] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:08.644] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:152:0) after 1m0s
[08:21:08.676] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:152:0)
[08:21:08.676] Timer tick, asking Buildbucket for the build status
[08:21:08.784] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:08.784] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:153:0) after 1m0s
[08:22:08.862] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:153:0)
[08:22:08.862] Timer tick, asking Buildbucket for the build status
[08:22:08.924] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:08.924] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:154:0) after 1m0s
[08:23:08.953] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:154:0)
[08:23:08.953] Timer tick, asking Buildbucket for the build status
[08:23:09.138] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:09.138] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:155:0) after 1m0s
[08:24:09.200] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:155:0)
[08:24:09.200] Timer tick, asking Buildbucket for the build status
[08:24:09.269] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:09.269] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:156:0) after 1m0s
[08:25:09.292] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:156:0)
[08:25:09.292] Timer tick, asking Buildbucket for the build status
[08:25:10.281] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:10.281] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:157:0) after 1m0s
[08:26:10.370] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:157:0)
[08:26:10.370] Timer tick, asking Buildbucket for the build status
[08:26:10.465] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:10.465] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:158:0) after 1m0s
[08:27:10.534] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:158:0)
[08:27:10.534] Timer tick, asking Buildbucket for the build status
[08:27:10.718] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:10.718] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:159:0) after 1m0s
[08:28:10.742] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:159:0)
[08:28:10.742] Timer tick, asking Buildbucket for the build status
[08:28:10.812] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:10.812] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:160:0) after 1m0s
[08:29:10.850] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:160:0)
[08:29:10.850] Timer tick, asking Buildbucket for the build status
[08:29:10.920] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:10.920] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:161:0) after 1m0s
[08:30:10.979] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:161:0)
[08:30:10.979] Timer tick, asking Buildbucket for the build status
[08:30:11.053] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:11.053] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:162:0) after 1m0s
[08:31:11.091] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:162:0)
[08:31:11.091] Timer tick, asking Buildbucket for the build status
[08:31:11.216] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:11.216] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:163:0) after 1m0s
[08:32:11.239] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:163:0)
[08:32:11.239] Timer tick, asking Buildbucket for the build status
[08:32:11.603] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:11.603] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:164:0) after 1m0s
[08:33:11.628] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:164:0)
[08:33:11.628] Timer tick, asking Buildbucket for the build status
[08:33:11.904] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:11.904] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:165:0) after 1m0s
[08:34:11.976] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:165:0)
[08:34:11.976] Timer tick, asking Buildbucket for the build status
[08:34:12.561] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:12.561] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:166:0) after 1m0s
[08:35:12.626] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:166:0)
[08:35:12.626] Timer tick, asking Buildbucket for the build status
[08:35:12.723] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:12.723] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:167:0) after 1m0s
[08:36:12.746] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:167:0)
[08:36:12.746] Timer tick, asking Buildbucket for the build status
[08:36:12.894] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:12.894] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:168:0) after 1m0s
[08:37:12.970] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:168:0)
[08:37:12.970] Timer tick, asking Buildbucket for the build status
[08:37:13.200] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:13.200] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:169:0) after 1m0s
[08:38:13.361] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:169:0)
[08:38:13.361] Timer tick, asking Buildbucket for the build status
[08:38:13.429] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:13.429] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:170:0) after 1m0s
[08:39:13.465] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:170:0)
[08:39:13.465] Timer tick, asking Buildbucket for the build status
[08:39:13.523] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:13.523] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:171:0) after 1m0s
[08:40:13.531] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:171:0)
[08:40:13.531] Timer tick, asking Buildbucket for the build status
[08:40:13.604] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:13.604] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:172:0) after 1m0s
[08:41:13.619] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:172:0)
[08:41:13.619] Timer tick, asking Buildbucket for the build status
[08:41:13.709] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:13.709] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:173:0) after 1m0s
[08:42:13.791] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:173:0)
[08:42:13.791] Timer tick, asking Buildbucket for the build status
[08:42:13.901] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:13.901] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:174:0) after 1m0s
[08:43:13.983] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:174:0)
[08:43:13.983] Timer tick, asking Buildbucket for the build status
[08:43:14.046] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:14.046] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:175:0) after 1m0s
[08:44:14.081] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:175:0)
[08:44:14.081] Timer tick, asking Buildbucket for the build status
[08:44:14.296] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:14.296] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:176:0) after 1m0s
[08:45:14.401] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:176:0)
[08:45:14.401] Timer tick, asking Buildbucket for the build status
[08:45:14.484] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:14.484] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:177:0) after 1m0s
[08:46:14.578] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:177:0)
[08:46:14.578] Timer tick, asking Buildbucket for the build status
[08:46:14.666] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:14.666] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:178:0) after 1m0s
[08:47:14.708] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:178:0)
[08:47:14.708] Timer tick, asking Buildbucket for the build status
[08:47:14.758] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:14.758] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:179:0) after 1m0s
[08:48:14.758] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:179:0)
[08:48:14.758] Timer tick, asking Buildbucket for the build status
[08:48:15.000] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:15.000] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:180:0) after 1m0s
[08:49:15.073] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:180:0)
[08:49:15.073] Timer tick, asking Buildbucket for the build status
[08:49:15.148] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:15.148] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:181:0) after 1m0s
[08:50:15.168] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:181:0)
[08:50:15.168] Timer tick, asking Buildbucket for the build status
[08:50:15.242] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:15.242] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:182:0) after 1m0s
[08:51:15.343] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:182:0)
[08:51:15.343] Timer tick, asking Buildbucket for the build status
[08:51:15.663] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:15.663] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:183:0) after 1m0s
[08:52:15.660] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:183:0)
[08:52:15.660] Timer tick, asking Buildbucket for the build status
[08:52:15.713] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:15.713] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:184:0) after 1m0s
[08:53:15.855] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:184:0)
[08:53:15.855] Timer tick, asking Buildbucket for the build status
[08:53:15.917] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:15.917] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:185:0) after 1m0s
[08:54:15.975] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:185:0)
[08:54:15.975] Timer tick, asking Buildbucket for the build status
[08:54:16.025] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:16.025] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:186:0) after 1m0s
[08:55:16.160] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:186:0)
[08:55:16.160] Timer tick, asking Buildbucket for the build status
[08:55:16.252] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:16.252] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:187:0) after 1m0s
[08:56:16.359] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:187:0)
[08:56:16.359] Timer tick, asking Buildbucket for the build status
[08:56:16.504] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:16.504] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:188:0) after 1m0s
[08:57:16.663] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:188:0)
[08:57:16.663] Timer tick, asking Buildbucket for the build status
[08:57:16.940] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:16.940] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:189:0) after 1m0s
[08:58:17.004] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:189:0)
[08:58:17.004] Timer tick, asking Buildbucket for the build status
[08:58:17.321] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:17.321] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:190:0) after 1m0s
[08:59:17.361] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:190:0)
[08:59:17.361] Timer tick, asking Buildbucket for the build status
[08:59:17.418] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:17.418] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:191:0) after 1m0s
[09:00:17.452] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:191:0)
[09:00:17.452] Timer tick, asking Buildbucket for the build status
[09:00:17.548] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:17.548] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:192:0) after 1m0s
[09:01:17.964] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:192:0)
[09:01:17.964] Timer tick, asking Buildbucket for the build status
[09:01:18.069] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:18.069] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:193:0) after 1m0s
[09:02:18.094] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:193:0)
[09:02:18.094] Timer tick, asking Buildbucket for the build status
[09:02:18.161] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:18.161] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:194:0) after 1m0s
[09:03:18.244] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:194:0)
[09:03:18.244] Timer tick, asking Buildbucket for the build status
[09:03:18.330] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:18.330] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:195:0) after 1m0s
[09:04:18.352] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:195:0)
[09:04:18.352] Timer tick, asking Buildbucket for the build status
[09:04:18.408] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:18.408] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:196:0) after 1m0s
[09:05:18.707] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:196:0)
[09:05:18.707] Timer tick, asking Buildbucket for the build status
[09:05:18.767] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:18.767] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:197:0) after 1m0s
[09:06:18.890] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:197:0)
[09:06:18.890] Timer tick, asking Buildbucket for the build status
[09:06:22.856] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:22.856] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:198:0) after 1m0s
[09:07:22.938] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:198:0)
[09:07:22.938] Timer tick, asking Buildbucket for the build status
[09:07:23.004] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:23.004] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:199:0) after 1m0s
[09:08:23.201] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:199:0)
[09:08:23.201] Timer tick, asking Buildbucket for the build status
[09:08:23.303] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:23.303] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:200:0) after 1m0s
[09:09:23.353] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:200:0)
[09:09:23.353] Timer tick, asking Buildbucket for the build status
[09:09:23.422] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:23.422] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:201:0) after 1m0s
[09:10:23.459] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:201:0)
[09:10:23.459] Timer tick, asking Buildbucket for the build status
[09:10:23.523] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:23.523] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:202:0) after 1m0s
[09:11:23.553] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:202:0)
[09:11:23.553] Timer tick, asking Buildbucket for the build status
[09:11:23.701] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:23.701] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:203:0) after 1m0s
[09:12:23.791] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:203:0)
[09:12:23.791] Timer tick, asking Buildbucket for the build status
[09:12:23.854] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:23.854] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:204:0) after 1m0s
[09:13:23.846] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:204:0)
[09:13:23.846] Timer tick, asking Buildbucket for the build status
[09:13:23.949] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:23.949] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:205:0) after 1m0s
[09:14:23.952] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:205:0)
[09:14:23.952] Timer tick, asking Buildbucket for the build status
[09:14:24.010] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:24.010] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:206:0) after 1m0s
[09:15:24.068] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:206:0)
[09:15:24.068] Timer tick, asking Buildbucket for the build status
[09:15:24.141] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:24.141] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:207:0) after 1m0s
[09:16:24.228] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:207:0)
[09:16:24.228] Timer tick, asking Buildbucket for the build status
[09:16:24.626] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:24.626] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:208:0) after 1m0s
[09:17:24.698] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:208:0)
[09:17:24.698] Timer tick, asking Buildbucket for the build status
[09:17:24.788] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:24.788] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:209:0) after 1m0s
[09:18:24.926] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:209:0)
[09:18:24.926] Timer tick, asking Buildbucket for the build status
[09:18:24.993] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:24.993] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:210:0) after 1m0s
[09:19:25.061] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:210:0)
[09:19:25.061] Timer tick, asking Buildbucket for the build status
[09:19:25.248] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:25.248] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:211:0) after 1m0s
[09:20:25.312] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:211:0)
[09:20:25.312] Timer tick, asking Buildbucket for the build status
[09:20:25.378] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:25.378] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:212:0) after 1m0s
[09:21:25.475] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:212:0)
[09:21:25.475] Timer tick, asking Buildbucket for the build status
[09:21:25.887] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:25.887] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:213:0) after 1m0s
[09:22:25.957] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:213:0)
[09:22:25.957] Timer tick, asking Buildbucket for the build status
[09:22:26.491] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:26.491] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:214:0) after 1m0s
[09:23:26.566] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:214:0)
[09:23:26.566] Timer tick, asking Buildbucket for the build status
[09:23:26.688] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:26.688] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:215:0) after 1m0s
[09:24:26.793] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:215:0)
[09:24:26.793] Timer tick, asking Buildbucket for the build status
[09:24:26.985] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:26.985] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:216:0) after 1m0s
[09:25:27.031] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:216:0)
[09:25:27.031] Timer tick, asking Buildbucket for the build status
[09:25:27.114] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:27.114] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:217:0) after 1m0s
[09:26:27.213] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:217:0)
[09:26:27.213] Timer tick, asking Buildbucket for the build status
[09:26:27.411] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:27.411] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:218:0) after 1m0s
[09:27:27.456] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:218:0)
[09:27:27.456] Timer tick, asking Buildbucket for the build status
[09:27:27.508] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:27.508] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:219:0) after 1m0s
[09:28:27.508] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:219:0)
[09:28:27.508] Timer tick, asking Buildbucket for the build status
[09:28:27.579] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:27.579] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:220:0) after 1m0s
[09:29:27.628] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:220:0)
[09:29:27.628] Timer tick, asking Buildbucket for the build status
[09:29:27.812] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:27.812] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:221:0) after 1m0s
[09:30:27.864] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:221:0)
[09:30:27.864] Timer tick, asking Buildbucket for the build status
[09:30:28.216] Build 8856160482757444848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:28.216] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021590544699283920:222:0) after 1m0s
[09:31:06.387] Received PubSub notification, asking Buildbucket for the build status
[09:31:06.458] Build 8856160482757444848: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:31:06.458] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612517465336186",
"created_by": "project:chromium",
"created_ts": "1612504227830105",
"id": "8856160482757444848",
"parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e637d705322bc4a97c1af33afff352e4e36b452d\"}}",
"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\": \"e637d705322bc4a97c1af33afff352e4e36b452d\", \"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-ksg6\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win32-official\", \"buildnumber\": 1489, \"got_angle_revision\": \"ad985fcdd806a26343b9b5f8408e551b515493e5\", \"got_dawn_revision\": \"4846281d3680e1e34ffeebe556ca25c285bc1151\", \"got_nacl_revision\": \"952e81813a66902714b68f34b51073c5d1ba6c94\", \"got_revision\": \"e637d705322bc4a97c1af33afff352e4e36b452d\", \"got_revision_cp\": \"refs/heads/master@{#850991}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"14dcbed947ce755af1fcbfb3ba8e643b4e769860\", \"got_v8_revision\": \"3d9850164408ec1c4b4ea60c4515b85853853794\", \"got_v8_revision_cp\": \"refs/heads/9.0.134@{#1}\", \"got_webrtc_revision\": \"1d71fd9c61db8f1dcf30b5d0625e514b91200926\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33155}\", \"mirrored_builders\": [\"tryserver.chromium:win32-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e637d705322bc4a97c1af33afff352e4e36b452d\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_524f8de60e2e268c779ae418ab45c03e275f35b08b0301b32216fe5285dcafcd_v2\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-2-ksg6\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5676-c76598c\"], \"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": "1612504231304724",
"status": "COMPLETED",
"status_changed_ts": "1612517465885652",
"tags": [
"build_address:luci.chromium.ci/win32-official/1489",
"builder:win32-official",
"buildset:commit/git/e637d705322bc4a97c1af33afff352e4e36b452d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e637d705322bc4a97c1af33afff352e4e36b452d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021590544699283920",
"scheduler_job_id:chromium/win32-official",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8856160482757444848/+/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:51898f6a32226510",
"user_agent:luci-scheduler"
],
"updated_ts": "1612517465908785",
"url": "https://ci.chromium.org/b/8856160482757444848",
"utcnow_ts": "1612517466449563"
}
}
[09:31:06.458] Invocation finished in 3h40m39.863837025s with status SUCCEEDED