[19:14:07.503] New invocation is queued and will start shortly
[19:14:09.574] Starting the invocation (attempt 1)
[19:14:09.616] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:14:09.617] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:14:09.617] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9033045796162263872",
"parameters_json": "{\"builder_name\":\"win32-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"5b85e230f8028f804df4d434afc13f2f64929e3f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win32-official",
"scheduler_invocation_id:9033045796162263872",
"scheduler_job_id:chromium/win32-official",
"user_agent:luci-scheduler",
"buildset:commit/git/5b85e230f8028f804df4d434afc13f2f64929e3f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5b85e230f8028f804df4d434afc13f2f64929e3f",
"gitiles_ref:refs/heads/master"
]
}
[19:14:11.312] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1601579650524265",
"id": "8867615732330222368",
"parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5b85e230f8028f804df4d434afc13f2f64929e3f\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1601579651067808",
"tags": [
"build_address:luci.chromium.ci/win32-official/648",
"builder:win32-official",
"buildset:commit/git/5b85e230f8028f804df4d434afc13f2f64929e3f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5b85e230f8028f804df4d434afc13f2f64929e3f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9033045796162263872",
"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/8867615732330222368/+/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": "1601579651068052",
"url": "https://ci.chromium.org/b/8867615732330222368",
"utcnow_ts": "1601579651293980"
}
}
[19:14:11.312] Task URL: https://ci.chromium.org/b/8867615732330222368
[19:14:11.312] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:2:0) after 1m0s
[19:14:44.369] Received PubSub notification, asking Buildbucket for the build status
[19:14:44.593] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:11.366] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:2:0)
[19:15:11.366] Timer tick, asking Buildbucket for the build status
[19:15:11.516] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:11.516] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:4:0) after 1m0s
[19:16:11.689] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:4:0)
[19:16:11.689] Timer tick, asking Buildbucket for the build status
[19:16:11.894] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:11.894] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:5:0) after 1m0s
[19:17:12.029] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:5:0)
[19:17:12.029] Timer tick, asking Buildbucket for the build status
[19:17:12.248] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:12.248] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:6:0) after 1m0s
[19:18:12.287] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:6:0)
[19:18:12.287] Timer tick, asking Buildbucket for the build status
[19:18:12.369] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:12.369] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:7:0) after 1m0s
[19:19:12.413] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:7:0)
[19:19:12.413] Timer tick, asking Buildbucket for the build status
[19:19:12.742] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:12.742] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:8:0) after 1m0s
[19:20:12.809] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:8:0)
[19:20:12.809] Timer tick, asking Buildbucket for the build status
[19:20:12.960] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:12.960] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:9:0) after 1m0s
[19:21:13.097] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:9:0)
[19:21:13.097] Timer tick, asking Buildbucket for the build status
[19:21:13.547] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:13.547] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:10:0) after 1m0s
[19:22:13.621] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:10:0)
[19:22:13.621] Timer tick, asking Buildbucket for the build status
[19:22:13.724] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:13.724] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:11:0) after 1m0s
[19:23:13.903] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:11:0)
[19:23:13.903] Timer tick, asking Buildbucket for the build status
[19:23:14.051] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:14.051] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:12:0) after 1m0s
[19:24:14.087] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:12:0)
[19:24:14.087] Timer tick, asking Buildbucket for the build status
[19:24:14.654] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:14.655] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:13:0) after 1m0s
[19:25:14.775] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:13:0)
[19:25:14.775] Timer tick, asking Buildbucket for the build status
[19:25:14.946] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:14.946] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:14:0) after 1m0s
[19:26:15.163] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:14:0)
[19:26:15.163] Timer tick, asking Buildbucket for the build status
[19:26:15.237] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:15.237] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:15:0) after 1m0s
[19:27:15.371] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:15:0)
[19:27:15.371] Timer tick, asking Buildbucket for the build status
[19:27:15.459] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:15.459] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:16:0) after 1m0s
[19:28:15.531] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:16:0)
[19:28:15.531] Timer tick, asking Buildbucket for the build status
[19:28:15.717] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:15.717] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:17:0) after 1m0s
[19:29:15.767] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:17:0)
[19:29:15.767] Timer tick, asking Buildbucket for the build status
[19:29:15.923] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:15.923] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:18:0) after 1m0s
[19:30:16.015] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:18:0)
[19:30:16.015] Timer tick, asking Buildbucket for the build status
[19:30:16.082] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:16.082] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:19:0) after 1m0s
[19:31:16.180] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:19:0)
[19:31:16.180] Timer tick, asking Buildbucket for the build status
[19:31:16.259] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:16.259] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:20:0) after 1m0s
[19:32:16.285] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:20:0)
[19:32:16.285] Timer tick, asking Buildbucket for the build status
[19:32:16.383] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:16.383] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:21:0) after 1m0s
[19:33:16.421] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:21:0)
[19:33:16.421] Timer tick, asking Buildbucket for the build status
[19:33:16.647] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:16.647] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:22:0) after 1m0s
[19:34:16.725] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:22:0)
[19:34:16.726] Timer tick, asking Buildbucket for the build status
[19:34:16.923] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:16.923] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:23:0) after 1m0s
[19:35:16.994] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:23:0)
[19:35:16.994] Timer tick, asking Buildbucket for the build status
[19:35:17.362] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:17.362] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:24:0) after 1m0s
[19:36:17.439] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:24:0)
[19:36:17.439] Timer tick, asking Buildbucket for the build status
[19:36:17.532] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:17.532] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:25:0) after 1m0s
[19:37:17.775] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:25:0)
[19:37:17.775] Timer tick, asking Buildbucket for the build status
[19:37:18.033] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:18.033] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:26:0) after 1m0s
[19:38:18.290] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:26:0)
[19:38:18.290] Timer tick, asking Buildbucket for the build status
[19:38:18.620] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:18.620] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:27:0) after 1m0s
[19:39:18.657] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:27:0)
[19:39:18.657] Timer tick, asking Buildbucket for the build status
[19:39:19.092] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:19.092] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:28:0) after 1m0s
[19:40:19.182] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:28:0)
[19:40:19.182] Timer tick, asking Buildbucket for the build status
[19:40:20.968] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:20.968] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:29:0) after 1m0s
[19:41:21.065] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:29:0)
[19:41:21.065] Timer tick, asking Buildbucket for the build status
[19:41:21.137] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:21.137] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:30:0) after 1m0s
[19:42:21.187] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:30:0)
[19:42:21.187] Timer tick, asking Buildbucket for the build status
[19:42:21.274] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:21.274] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:31:0) after 1m0s
[19:43:21.329] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:31:0)
[19:43:21.329] Timer tick, asking Buildbucket for the build status
[19:43:23.164] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:23.164] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:32:0) after 1m0s
[19:44:23.264] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:32:0)
[19:44:23.264] Timer tick, asking Buildbucket for the build status
[19:44:23.421] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:23.421] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:33:0) after 1m0s
[19:45:23.463] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:33:0)
[19:45:23.463] Timer tick, asking Buildbucket for the build status
[19:45:23.636] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:23.636] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:34:0) after 1m0s
[19:46:23.676] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:34:0)
[19:46:23.676] Timer tick, asking Buildbucket for the build status
[19:46:23.799] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:23.799] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:35:0) after 1m0s
[19:47:23.901] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:35:0)
[19:47:23.901] Timer tick, asking Buildbucket for the build status
[19:47:24.071] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:24.071] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:36:0) after 1m0s
[19:48:24.167] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:36:0)
[19:48:24.167] Timer tick, asking Buildbucket for the build status
[19:48:24.576] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:24.576] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:37:0) after 1m0s
[19:49:24.627] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:37:0)
[19:49:24.627] Timer tick, asking Buildbucket for the build status
[19:49:25.008] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:25.008] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:38:0) after 1m0s
[19:50:25.057] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:38:0)
[19:50:25.057] Timer tick, asking Buildbucket for the build status
[19:50:25.177] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:25.177] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:39:0) after 1m0s
[19:51:25.202] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:39:0)
[19:51:25.202] Timer tick, asking Buildbucket for the build status
[19:51:25.284] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:25.284] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:40:0) after 1m0s
[19:52:25.297] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:40:0)
[19:52:25.297] Timer tick, asking Buildbucket for the build status
[19:52:25.356] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:25.356] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:41:0) after 1m0s
[19:53:25.460] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:41:0)
[19:53:25.460] Timer tick, asking Buildbucket for the build status
[19:53:25.577] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:25.577] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:42:0) after 1m0s
[19:54:25.693] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:42:0)
[19:54:25.693] Timer tick, asking Buildbucket for the build status
[19:54:40.339] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:40.339] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:43:0) after 1m0s
[19:55:42.114] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:43:0)
[19:55:42.114] Timer tick, asking Buildbucket for the build status
[19:55:43.103] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:43.103] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:44:0) after 1m0s
[19:56:43.136] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:44:0)
[19:56:43.136] Timer tick, asking Buildbucket for the build status
[19:56:43.310] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:43.310] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:45:0) after 1m0s
[19:57:43.443] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:45:0)
[19:57:43.443] Timer tick, asking Buildbucket for the build status
[19:57:44.638] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:44.638] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:46:0) after 1m0s
[19:58:44.682] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:46:0)
[19:58:44.682] Timer tick, asking Buildbucket for the build status
[19:58:45.797] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:45.797] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:47:0) after 1m0s
[19:59:45.930] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:47:0)
[19:59:45.930] Timer tick, asking Buildbucket for the build status
[19:59:46.306] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:46.306] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:48:0) after 1m0s
[20:00:46.482] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:48:0)
[20:00:46.482] Timer tick, asking Buildbucket for the build status
[20:00:47.053] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:47.053] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:49:0) after 1m0s
[20:01:47.343] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:49:0)
[20:01:47.343] Timer tick, asking Buildbucket for the build status
[20:01:47.735] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:47.735] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:50:0) after 1m0s
[20:02:47.848] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:50:0)
[20:02:47.848] Timer tick, asking Buildbucket for the build status
[20:02:48.166] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:48.166] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:51:0) after 1m0s
[20:03:48.243] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:51:0)
[20:03:48.243] Timer tick, asking Buildbucket for the build status
[20:03:48.467] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:48.467] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:52:0) after 1m0s
[20:04:48.505] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:52:0)
[20:04:48.505] Timer tick, asking Buildbucket for the build status
[20:04:49.195] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:49.195] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:53:0) after 1m0s
[20:05:49.275] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:53:0)
[20:05:49.275] Timer tick, asking Buildbucket for the build status
[20:05:49.372] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:49.372] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:54:0) after 1m0s
[20:06:49.516] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:54:0)
[20:06:49.516] Timer tick, asking Buildbucket for the build status
[20:06:49.889] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:49.890] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:55:0) after 1m0s
[20:07:49.941] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:55:0)
[20:07:49.941] Timer tick, asking Buildbucket for the build status
[20:07:50.052] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:50.052] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:56:0) after 1m0s
[20:08:50.182] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:56:0)
[20:08:50.182] Timer tick, asking Buildbucket for the build status
[20:08:50.988] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:50.988] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:57:0) after 1m0s
[20:09:51.052] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:57:0)
[20:09:51.052] Timer tick, asking Buildbucket for the build status
[20:09:52.437] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:52.437] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:58:0) after 1m0s
[20:10:52.477] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:58:0)
[20:10:52.477] Timer tick, asking Buildbucket for the build status
[20:10:52.657] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:52.657] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:59:0) after 1m0s
[20:11:52.737] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:59:0)
[20:11:52.737] Timer tick, asking Buildbucket for the build status
[20:11:52.824] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:52.824] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:60:0) after 1m0s
[20:12:52.875] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:60:0)
[20:12:52.875] Timer tick, asking Buildbucket for the build status
[20:12:53.084] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:53.084] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:61:0) after 1m0s
[20:13:53.140] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:61:0)
[20:13:53.140] Timer tick, asking Buildbucket for the build status
[20:13:53.199] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:53.199] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:62:0) after 1m0s
[20:14:53.223] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:62:0)
[20:14:53.223] Timer tick, asking Buildbucket for the build status
[20:14:53.466] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:53.466] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:63:0) after 1m0s
[20:15:53.562] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:63:0)
[20:15:53.562] Timer tick, asking Buildbucket for the build status
[20:15:54.596] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:54.596] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:64:0) after 1m0s
[20:16:54.714] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:64:0)
[20:16:54.714] Timer tick, asking Buildbucket for the build status
[20:16:57.756] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:57.756] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:65:0) after 1m0s
[20:17:57.881] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:65:0)
[20:17:57.881] Timer tick, asking Buildbucket for the build status
[20:17:57.949] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:57.949] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:66:0) after 1m0s
[20:18:58.010] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:66:0)
[20:18:58.010] Timer tick, asking Buildbucket for the build status
[20:18:58.186] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:58.186] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:67:0) after 1m0s
[20:19:58.252] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:67:0)
[20:19:58.252] Timer tick, asking Buildbucket for the build status
[20:19:58.484] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:58.484] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:68:0) after 1m0s
[20:20:58.511] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:68:0)
[20:20:58.511] Timer tick, asking Buildbucket for the build status
[20:20:58.625] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:58.625] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:69:0) after 1m0s
[20:21:58.692] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:69:0)
[20:21:58.692] Timer tick, asking Buildbucket for the build status
[20:21:58.815] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:58.815] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:70:0) after 1m0s
[20:22:58.869] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:70:0)
[20:22:58.869] Timer tick, asking Buildbucket for the build status
[20:22:58.972] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:58.972] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:71:0) after 1m0s
[20:23:59.035] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:71:0)
[20:23:59.035] Timer tick, asking Buildbucket for the build status
[20:23:59.110] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:59.110] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:72:0) after 1m0s
[20:24:59.138] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:72:0)
[20:24:59.138] Timer tick, asking Buildbucket for the build status
[20:24:59.446] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:59.446] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:73:0) after 1m0s
[20:25:59.521] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:73:0)
[20:25:59.521] Timer tick, asking Buildbucket for the build status
[20:25:59.588] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:59.588] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:74:0) after 1m0s
[20:26:59.616] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:74:0)
[20:26:59.616] Timer tick, asking Buildbucket for the build status
[20:26:59.745] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:59.745] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:75:0) after 1m0s
[20:27:59.772] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:75:0)
[20:27:59.772] Timer tick, asking Buildbucket for the build status
[20:27:59.836] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:59.836] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:76:0) after 1m0s
[20:28:59.829] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:76:0)
[20:28:59.829] Timer tick, asking Buildbucket for the build status
[20:28:59.998] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:59.998] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:77:0) after 1m0s
[20:29:59.991] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:77:0)
[20:29:59.991] Timer tick, asking Buildbucket for the build status
[20:30:00.345] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:00.345] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:78:0) after 1m0s
[20:31:01.452] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:78:0)
[20:31:01.452] Timer tick, asking Buildbucket for the build status
[20:31:01.535] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:01.535] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:79:0) after 1m0s
[20:32:02.564] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:79:0)
[20:32:02.564] Timer tick, asking Buildbucket for the build status
[20:32:02.828] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:02.828] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:80:0) after 1m0s
[20:33:03.028] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:80:0)
[20:33:03.028] Timer tick, asking Buildbucket for the build status
[20:33:03.246] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:03.246] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:81:0) after 1m0s
[20:34:03.276] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:81:0)
[20:34:03.276] Timer tick, asking Buildbucket for the build status
[20:34:03.462] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:03.462] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:82:0) after 1m0s
[20:35:03.464] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:82:0)
[20:35:03.464] Timer tick, asking Buildbucket for the build status
[20:35:03.840] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:03.840] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:83:0) after 1m0s
[20:36:03.896] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:83:0)
[20:36:03.896] Timer tick, asking Buildbucket for the build status
[20:36:03.963] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:03.963] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:84:0) after 1m0s
[20:37:04.020] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:84:0)
[20:37:04.020] Timer tick, asking Buildbucket for the build status
[20:37:04.415] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:04.415] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:85:0) after 1m0s
[20:38:04.400] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:85:0)
[20:38:04.400] Timer tick, asking Buildbucket for the build status
[20:38:04.474] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:04.474] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:86:0) after 1m0s
[20:39:04.503] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:86:0)
[20:39:04.503] Timer tick, asking Buildbucket for the build status
[20:39:05.002] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:05.002] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:87:0) after 1m0s
[20:40:05.099] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:87:0)
[20:40:05.099] Timer tick, asking Buildbucket for the build status
[20:40:05.536] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:05.536] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:88:0) after 1m0s
[20:41:05.581] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:88:0)
[20:41:05.581] Timer tick, asking Buildbucket for the build status
[20:41:05.950] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:05.950] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:89:0) after 1m0s
[20:42:05.972] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:89:0)
[20:42:05.972] Timer tick, asking Buildbucket for the build status
[20:42:06.209] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:06.209] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:90:0) after 1m0s
[20:43:06.234] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:90:0)
[20:43:06.234] Timer tick, asking Buildbucket for the build status
[20:43:06.518] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:06.518] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:91:0) after 1m0s
[20:44:06.562] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:91:0)
[20:44:06.562] Timer tick, asking Buildbucket for the build status
[20:44:06.775] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:06.776] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:92:0) after 1m0s
[20:45:06.804] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:92:0)
[20:45:06.804] Timer tick, asking Buildbucket for the build status
[20:45:06.936] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:06.936] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:93:0) after 1m0s
[20:46:07.084] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:93:0)
[20:46:07.084] Timer tick, asking Buildbucket for the build status
[20:46:07.202] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:07.202] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:94:0) after 1m0s
[20:47:07.255] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:94:0)
[20:47:07.255] Timer tick, asking Buildbucket for the build status
[20:47:07.339] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:07.339] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:95:0) after 1m0s
[20:48:07.345] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:95:0)
[20:48:07.345] Timer tick, asking Buildbucket for the build status
[20:48:07.482] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:07.482] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:96:0) after 1m0s
[20:49:07.733] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:96:0)
[20:49:07.733] Timer tick, asking Buildbucket for the build status
[20:49:07.821] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:07.821] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:97:0) after 1m0s
[20:50:07.972] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:97:0)
[20:50:07.972] Timer tick, asking Buildbucket for the build status
[20:50:08.114] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:08.114] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:98:0) after 1m0s
[20:51:08.368] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:98:0)
[20:51:08.368] Timer tick, asking Buildbucket for the build status
[20:51:08.432] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:08.432] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:99:0) after 1m0s
[20:52:08.562] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:99:0)
[20:52:08.562] Timer tick, asking Buildbucket for the build status
[20:52:08.647] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:08.647] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:100:0) after 1m0s
[20:53:08.889] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:100:0)
[20:53:08.889] Timer tick, asking Buildbucket for the build status
[20:53:08.988] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:08.988] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:101:0) after 1m0s
[20:54:09.036] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:101:0)
[20:54:09.036] Timer tick, asking Buildbucket for the build status
[20:54:09.146] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:09.146] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:102:0) after 1m0s
[20:55:09.221] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:102:0)
[20:55:09.221] Timer tick, asking Buildbucket for the build status
[20:55:09.464] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:09.464] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:103:0) after 1m0s
[20:56:09.505] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:103:0)
[20:56:09.505] Timer tick, asking Buildbucket for the build status
[20:56:09.628] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:09.628] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:104:0) after 1m0s
[20:57:09.619] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:104:0)
[20:57:09.619] Timer tick, asking Buildbucket for the build status
[20:57:09.697] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:09.697] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:105:0) after 1m0s
[20:58:09.822] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:105:0)
[20:58:09.822] Timer tick, asking Buildbucket for the build status
[20:58:09.934] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:09.934] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:106:0) after 1m0s
[20:59:09.965] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:106:0)
[20:59:09.965] Timer tick, asking Buildbucket for the build status
[20:59:10.246] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:10.246] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:107:0) after 1m0s
[21:00:10.355] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:107:0)
[21:00:10.355] Timer tick, asking Buildbucket for the build status
[21:00:10.609] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:10.609] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:108:0) after 1m0s
[21:01:10.614] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:108:0)
[21:01:10.614] Timer tick, asking Buildbucket for the build status
[21:01:10.754] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:10.754] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:109:0) after 1m0s
[21:02:10.780] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:109:0)
[21:02:10.780] Timer tick, asking Buildbucket for the build status
[21:02:10.928] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:10.928] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:110:0) after 1m0s
[21:03:10.999] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:110:0)
[21:03:10.999] Timer tick, asking Buildbucket for the build status
[21:03:11.253] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:11.253] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:111:0) after 1m0s
[21:04:11.372] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:111:0)
[21:04:11.372] Timer tick, asking Buildbucket for the build status
[21:04:11.542] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:11.542] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:112:0) after 1m0s
[21:05:11.581] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:112:0)
[21:05:11.581] Timer tick, asking Buildbucket for the build status
[21:05:11.804] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:11.804] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:113:0) after 1m0s
[21:06:11.856] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:113:0)
[21:06:11.856] Timer tick, asking Buildbucket for the build status
[21:06:13.447] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:13.447] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:114:0) after 1m0s
[21:07:13.558] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:114:0)
[21:07:13.558] Timer tick, asking Buildbucket for the build status
[21:07:15.039] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:15.039] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:115:0) after 1m0s
[21:08:15.081] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:115:0)
[21:08:15.081] Timer tick, asking Buildbucket for the build status
[21:08:15.189] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:15.189] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:116:0) after 1m0s
[21:09:15.302] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:116:0)
[21:09:15.302] Timer tick, asking Buildbucket for the build status
[21:09:15.493] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:15.493] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:117:0) after 1m0s
[21:10:15.622] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:117:0)
[21:10:15.622] Timer tick, asking Buildbucket for the build status
[21:10:15.755] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:15.755] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:118:0) after 1m0s
[21:11:15.882] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:118:0)
[21:11:15.882] Timer tick, asking Buildbucket for the build status
[21:11:15.943] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:15.943] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:119:0) after 1m0s
[21:12:15.994] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:119:0)
[21:12:15.994] Timer tick, asking Buildbucket for the build status
[21:12:16.322] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:16.323] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:120:0) after 1m0s
[21:13:16.348] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:120:0)
[21:13:16.348] Timer tick, asking Buildbucket for the build status
[21:13:16.505] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:16.505] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:121:0) after 1m0s
[21:14:16.512] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:121:0)
[21:14:16.512] Timer tick, asking Buildbucket for the build status
[21:14:16.566] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:16.566] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:122:0) after 1m0s
[21:15:16.597] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:122:0)
[21:15:16.597] Timer tick, asking Buildbucket for the build status
[21:15:16.762] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:16.762] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:123:0) after 1m0s
[21:16:16.842] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:123:0)
[21:16:16.842] Timer tick, asking Buildbucket for the build status
[21:16:17.040] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:17.040] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:124:0) after 1m0s
[21:17:17.373] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:124:0)
[21:17:17.373] Timer tick, asking Buildbucket for the build status
[21:17:17.506] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:17.506] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:125:0) after 1m0s
[21:18:17.752] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:125:0)
[21:18:17.752] Timer tick, asking Buildbucket for the build status
[21:18:18.292] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:18.292] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:126:0) after 1m0s
[21:19:18.326] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:126:0)
[21:19:18.326] Timer tick, asking Buildbucket for the build status
[21:19:18.391] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:18.391] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:127:0) after 1m0s
[21:20:18.414] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:127:0)
[21:20:18.414] Timer tick, asking Buildbucket for the build status
[21:20:18.694] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:18.694] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:128:0) after 1m0s
[21:21:18.758] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:128:0)
[21:21:18.758] Timer tick, asking Buildbucket for the build status
[21:21:19.107] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:19.107] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:129:0) after 1m0s
[21:22:19.156] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:129:0)
[21:22:19.156] Timer tick, asking Buildbucket for the build status
[21:22:19.235] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:19.235] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:130:0) after 1m0s
[21:23:19.310] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:130:0)
[21:23:19.310] Timer tick, asking Buildbucket for the build status
[21:23:19.388] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:19.388] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:131:0) after 1m0s
[21:24:19.425] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:131:0)
[21:24:19.425] Timer tick, asking Buildbucket for the build status
[21:24:19.653] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:19.653] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:132:0) after 1m0s
[21:25:19.666] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:132:0)
[21:25:19.666] Timer tick, asking Buildbucket for the build status
[21:25:19.795] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:19.795] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:133:0) after 1m0s
[21:26:19.857] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:133:0)
[21:26:19.857] Timer tick, asking Buildbucket for the build status
[21:26:20.041] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:20.041] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:134:0) after 1m0s
[21:27:20.119] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:134:0)
[21:27:20.119] Timer tick, asking Buildbucket for the build status
[21:27:20.369] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:20.369] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:135:0) after 1m0s
[21:28:20.365] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:135:0)
[21:28:20.365] Timer tick, asking Buildbucket for the build status
[21:28:20.469] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:20.469] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:136:0) after 1m0s
[21:29:20.495] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:136:0)
[21:29:20.495] Timer tick, asking Buildbucket for the build status
[21:29:20.640] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:20.640] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:137:0) after 1m0s
[21:30:20.708] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:137:0)
[21:30:20.708] Timer tick, asking Buildbucket for the build status
[21:30:21.107] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:21.107] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:138:0) after 1m0s
[21:31:21.132] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:138:0)
[21:31:21.132] Timer tick, asking Buildbucket for the build status
[21:31:23.458] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:23.458] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:139:0) after 1m0s
[21:32:23.453] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:139:0)
[21:32:23.453] Timer tick, asking Buildbucket for the build status
[21:32:23.538] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:23.538] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:140:0) after 1m0s
[21:33:23.575] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:140:0)
[21:33:23.575] Timer tick, asking Buildbucket for the build status
[21:33:23.650] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:23.650] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:141:0) after 1m0s
[21:34:23.728] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:141:0)
[21:34:23.728] Timer tick, asking Buildbucket for the build status
[21:34:23.812] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:23.812] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:142:0) after 1m0s
[21:35:23.843] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:142:0)
[21:35:23.843] Timer tick, asking Buildbucket for the build status
[21:35:24.239] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:24.239] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:143:0) after 1m0s
[21:36:24.325] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:143:0)
[21:36:24.325] Timer tick, asking Buildbucket for the build status
[21:36:24.411] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:24.411] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:144:0) after 1m0s
[21:37:24.455] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:144:0)
[21:37:24.455] Timer tick, asking Buildbucket for the build status
[21:37:24.650] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:24.650] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:145:0) after 1m0s
[21:38:24.754] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:145:0)
[21:38:24.755] Timer tick, asking Buildbucket for the build status
[21:38:24.838] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:24.838] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:146:0) after 1m0s
[21:39:24.878] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:146:0)
[21:39:24.878] Timer tick, asking Buildbucket for the build status
[21:39:24.980] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:24.980] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:147:0) after 1m0s
[21:40:25.016] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:147:0)
[21:40:25.016] Timer tick, asking Buildbucket for the build status
[21:40:25.199] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:25.199] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:148:0) after 1m0s
[21:41:25.189] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:148:0)
[21:41:25.189] Timer tick, asking Buildbucket for the build status
[21:41:27.287] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:27.288] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:149:0) after 1m0s
[21:42:27.316] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:149:0)
[21:42:27.316] Timer tick, asking Buildbucket for the build status
[21:42:27.386] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:27.386] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:150:0) after 1m0s
[21:43:27.447] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:150:0)
[21:43:27.447] Timer tick, asking Buildbucket for the build status
[21:43:27.536] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:27.536] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:151:0) after 1m0s
[21:44:27.734] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:151:0)
[21:44:27.734] Timer tick, asking Buildbucket for the build status
[21:44:27.956] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:27.956] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:152:0) after 1m0s
[21:45:28.114] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:152:0)
[21:45:28.114] Timer tick, asking Buildbucket for the build status
[21:45:28.272] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:28.272] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:153:0) after 1m0s
[21:46:28.342] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:153:0)
[21:46:28.342] Timer tick, asking Buildbucket for the build status
[21:46:28.595] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:28.595] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:154:0) after 1m0s
[21:47:28.666] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:154:0)
[21:47:28.666] Timer tick, asking Buildbucket for the build status
[21:47:28.793] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:28.793] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:155:0) after 1m0s
[21:48:28.809] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:155:0)
[21:48:28.809] Timer tick, asking Buildbucket for the build status
[21:48:28.993] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:28.993] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:156:0) after 1m0s
[21:49:29.040] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:156:0)
[21:49:29.040] Timer tick, asking Buildbucket for the build status
[21:49:29.211] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:29.211] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:157:0) after 1m0s
[21:50:29.262] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:157:0)
[21:50:29.262] Timer tick, asking Buildbucket for the build status
[21:50:29.543] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:29.543] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:158:0) after 1m0s
[21:51:29.623] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:158:0)
[21:51:29.623] Timer tick, asking Buildbucket for the build status
[21:51:29.779] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:29.779] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:159:0) after 1m0s
[21:52:29.842] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:159:0)
[21:52:29.842] Timer tick, asking Buildbucket for the build status
[21:52:30.000] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:30.000] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:160:0) after 1m0s
[21:53:30.060] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:160:0)
[21:53:30.060] Timer tick, asking Buildbucket for the build status
[21:53:30.160] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:30.160] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:161:0) after 1m0s
[21:54:30.181] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:161:0)
[21:54:30.181] Timer tick, asking Buildbucket for the build status
[21:54:30.537] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:30.537] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:162:0) after 1m0s
[21:55:30.552] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:162:0)
[21:55:30.552] Timer tick, asking Buildbucket for the build status
[21:55:30.750] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:30.750] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:163:0) after 1m0s
[21:56:30.770] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:163:0)
[21:56:30.770] Timer tick, asking Buildbucket for the build status
[21:56:31.013] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:31.013] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:164:0) after 1m0s
[21:57:31.065] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:164:0)
[21:57:31.065] Timer tick, asking Buildbucket for the build status
[21:57:31.150] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:31.150] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:165:0) after 1m0s
[21:58:31.200] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:165:0)
[21:58:31.200] Timer tick, asking Buildbucket for the build status
[21:58:31.345] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:31.345] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:166:0) after 1m0s
[21:59:31.399] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:166:0)
[21:59:31.399] Timer tick, asking Buildbucket for the build status
[21:59:31.536] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:31.536] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:167:0) after 1m0s
[22:00:31.595] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:167:0)
[22:00:31.595] Timer tick, asking Buildbucket for the build status
[22:00:31.763] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:31.763] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:168:0) after 1m0s
[22:01:31.802] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:168:0)
[22:01:31.802] Timer tick, asking Buildbucket for the build status
[22:01:31.890] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:31.890] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:169:0) after 1m0s
[22:02:31.917] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:169:0)
[22:02:31.917] Timer tick, asking Buildbucket for the build status
[22:02:32.154] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:32.154] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:170:0) after 1m0s
[22:03:32.175] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:170:0)
[22:03:32.175] Timer tick, asking Buildbucket for the build status
[22:03:32.383] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:32.383] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:171:0) after 1m0s
[22:04:32.424] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:171:0)
[22:04:32.424] Timer tick, asking Buildbucket for the build status
[22:04:32.482] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:32.483] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:172:0) after 1m0s
[22:05:32.529] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:172:0)
[22:05:32.530] Timer tick, asking Buildbucket for the build status
[22:05:33.128] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:33.128] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:173:0) after 1m0s
[22:06:33.216] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:173:0)
[22:06:33.216] Timer tick, asking Buildbucket for the build status
[22:06:34.728] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:34.728] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:174:0) after 1m0s
[22:07:34.784] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:174:0)
[22:07:34.784] Timer tick, asking Buildbucket for the build status
[22:07:34.871] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:34.871] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:175:0) after 1m0s
[22:08:35.097] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:175:0)
[22:08:35.097] Timer tick, asking Buildbucket for the build status
[22:08:35.176] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:35.176] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:176:0) after 1m0s
[22:09:35.346] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:176:0)
[22:09:35.346] Timer tick, asking Buildbucket for the build status
[22:09:35.492] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:35.492] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:177:0) after 1m0s
[22:10:35.550] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:177:0)
[22:10:35.550] Timer tick, asking Buildbucket for the build status
[22:10:35.630] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:35.630] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:178:0) after 1m0s
[22:11:35.680] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:178:0)
[22:11:35.680] Timer tick, asking Buildbucket for the build status
[22:11:35.752] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:35.752] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:179:0) after 1m0s
[22:12:35.817] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:179:0)
[22:12:35.817] Timer tick, asking Buildbucket for the build status
[22:12:36.775] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:36.775] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:180:0) after 1m0s
[22:13:36.867] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:180:0)
[22:13:36.867] Timer tick, asking Buildbucket for the build status
[22:13:36.984] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:36.984] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:181:0) after 1m0s
[22:14:37.086] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:181:0)
[22:14:37.086] Timer tick, asking Buildbucket for the build status
[22:14:37.309] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:37.309] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:182:0) after 1m0s
[22:15:37.359] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:182:0)
[22:15:37.360] Timer tick, asking Buildbucket for the build status
[22:15:37.433] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:37.433] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:183:0) after 1m0s
[22:16:37.553] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:183:0)
[22:16:37.553] Timer tick, asking Buildbucket for the build status
[22:16:37.751] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:37.751] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:184:0) after 1m0s
[22:17:37.840] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:184:0)
[22:17:37.840] Timer tick, asking Buildbucket for the build status
[22:17:37.905] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:37.905] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:185:0) after 1m0s
[22:18:37.957] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:185:0)
[22:18:37.957] Timer tick, asking Buildbucket for the build status
[22:18:38.521] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:38.521] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:186:0) after 1m0s
[22:19:38.589] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:186:0)
[22:19:38.589] Timer tick, asking Buildbucket for the build status
[22:19:38.716] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:38.716] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:187:0) after 1m0s
[22:20:38.761] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:187:0)
[22:20:38.761] Timer tick, asking Buildbucket for the build status
[22:20:38.904] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:38.904] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:188:0) after 1m0s
[22:21:38.901] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:188:0)
[22:21:38.901] Timer tick, asking Buildbucket for the build status
[22:21:39.236] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:39.236] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:189:0) after 1m0s
[22:22:39.268] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:189:0)
[22:22:39.268] Timer tick, asking Buildbucket for the build status
[22:22:39.452] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:39.452] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:190:0) after 1m0s
[22:23:39.484] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:190:0)
[22:23:39.484] Timer tick, asking Buildbucket for the build status
[22:23:39.571] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:39.571] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:191:0) after 1m0s
[22:24:39.631] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:191:0)
[22:24:39.631] Timer tick, asking Buildbucket for the build status
[22:24:39.997] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:39.998] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:192:0) after 1m0s
[22:25:40.033] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:192:0)
[22:25:40.033] Timer tick, asking Buildbucket for the build status
[22:25:40.220] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:40.220] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:193:0) after 1m0s
[22:26:40.207] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:193:0)
[22:26:40.207] Timer tick, asking Buildbucket for the build status
[22:26:40.528] Build 8867615732330222368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:40.528] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9033045796162263872:194:0) after 1m0s
[22:27:26.451] Received PubSub notification, asking Buildbucket for the build status
[22:27:26.567] Build 8867615732330222368: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:27:26.567] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1601591244917973",
"created_by": "project:chromium",
"created_ts": "1601579650524265",
"id": "8867615732330222368",
"parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5b85e230f8028f804df4d434afc13f2f64929e3f\"}}",
"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\": \"5b85e230f8028f804df4d434afc13f2f64929e3f\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"win-dbg-9-lze2\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win32-official\", \"buildnumber\": 648, \"got_angle_revision\": \"64eb64a034cb725baf3dea089f3badbbab77a0be\", \"got_dawn_revision\": \"da5828c06b4c7cbe428283a1516a4fb73d5836be\", \"got_nacl_revision\": \"69a0d6e8affc94187af10e0673592d1b238c6eb0\", \"got_revision\": \"5b85e230f8028f804df4d434afc13f2f64929e3f\", \"got_revision_cp\": \"refs/heads/master@{#812846}\", \"got_swarming_client_revision\": \"44c13d73156581ea09b9389001e58c23a4b8d70a\", \"got_swiftshader_revision\": \"02818d1fdd05410fa9d3ffa6f9ce313a63d03dcf\", \"got_v8_revision\": \"0d81cd72688512abcbe1601015baee390c484a6a\", \"got_v8_revision_cp\": \"refs/heads/8.7.220@{#1}\", \"got_webrtc_revision\": \"75b9ab6751f3f49bbdd0a260fcbcbc8135dd567a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32272}\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5b85e230f8028f804df4d434afc13f2f64929e3f\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_f6b49936a2965b3cdad8f63ce13313d0c4b82119a9acfffbfe199e91c26d0c88_v2\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-9-lze2\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5564-e41b668\"], \"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": "1601579683568206",
"status": "COMPLETED",
"status_changed_ts": "1601591245928561",
"tags": [
"build_address:luci.chromium.ci/win32-official/648",
"builder:win32-official",
"buildset:commit/git/5b85e230f8028f804df4d434afc13f2f64929e3f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5b85e230f8028f804df4d434afc13f2f64929e3f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9033045796162263872",
"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/8867615732330222368/+/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:4efe679a20448c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1601591245979054",
"url": "https://ci.chromium.org/b/8867615732330222368",
"utcnow_ts": "1601591246558501"
}
}
[22:27:26.567] Invocation finished in 3h13m19.081106326s with status SUCCEEDED