[19:13:11.093] New invocation is queued and will start shortly
[19:13:12.346] Starting the invocation (attempt 1)
[19:13:12.402] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:13:12.402] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:13:12.402] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9035673167340860000",
"parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"a270ae9a2998a3f3031e8e2af3fe69a5a33852ce\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-official",
"scheduler_invocation_id:9035673167340860000",
"scheduler_job_id:chromium/win-official",
"user_agent:luci-scheduler",
"buildset:commit/git/a270ae9a2998a3f3031e8e2af3fe69a5a33852ce",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a270ae9a2998a3f3031e8e2af3fe69a5a33852ce",
"gitiles_ref:refs/heads/master"
]
}
[19:13:13.387] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1599073992538008",
"id": "8870243105159107376",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a270ae9a2998a3f3031e8e2af3fe69a5a33852ce\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1599073993179010",
"tags": [
"build_address:luci.chromium.ci/win-official/490",
"builder:win-official",
"buildset:commit/git/a270ae9a2998a3f3031e8e2af3fe69a5a33852ce",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a270ae9a2998a3f3031e8e2af3fe69a5a33852ce",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9035673167340860000",
"scheduler_job_id:chromium/win-official",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8870243105159107376/+/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": "1599073993179164",
"url": "https://ci.chromium.org/b/8870243105159107376",
"utcnow_ts": "1599073993371819"
}
}
[19:13:13.387] Task URL: https://ci.chromium.org/b/8870243105159107376
[19:13:13.387] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:2:0) after 1m0s
[19:13:54.282] Received PubSub notification, asking Buildbucket for the build status
[19:13:54.364] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:13.479] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:2:0)
[19:14:13.479] Timer tick, asking Buildbucket for the build status
[19:14:13.758] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:13.759] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:4:0) after 1m0s
[19:15:13.843] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:4:0)
[19:15:13.843] Timer tick, asking Buildbucket for the build status
[19:15:13.962] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:13.962] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:5:0) after 1m0s
[19:16:14.076] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:5:0)
[19:16:14.076] Timer tick, asking Buildbucket for the build status
[19:16:14.168] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:14.168] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:6:0) after 1m0s
[19:17:14.315] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:6:0)
[19:17:14.315] Timer tick, asking Buildbucket for the build status
[19:17:14.800] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:14.800] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:7:0) after 1m0s
[19:18:14.847] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:7:0)
[19:18:14.847] Timer tick, asking Buildbucket for the build status
[19:18:14.966] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:14.966] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:8:0) after 1m0s
[19:19:15.308] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:8:0)
[19:19:15.308] Timer tick, asking Buildbucket for the build status
[19:19:15.470] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:15.470] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:9:0) after 1m0s
[19:20:15.491] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:9:0)
[19:20:15.491] Timer tick, asking Buildbucket for the build status
[19:20:15.792] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:15.792] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:10:0) after 1m0s
[19:21:15.863] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:10:0)
[19:21:15.863] Timer tick, asking Buildbucket for the build status
[19:21:15.948] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:15.948] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:11:0) after 1m0s
[19:22:16.069] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:11:0)
[19:22:16.069] Timer tick, asking Buildbucket for the build status
[19:22:16.235] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:16.235] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:12:0) after 1m0s
[19:23:16.352] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:12:0)
[19:23:16.352] Timer tick, asking Buildbucket for the build status
[19:23:16.729] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:16.729] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:13:0) after 1m0s
[19:24:16.822] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:13:0)
[19:24:16.822] Timer tick, asking Buildbucket for the build status
[19:24:17.023] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:17.023] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:14:0) after 1m0s
[19:25:17.163] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:14:0)
[19:25:17.163] Timer tick, asking Buildbucket for the build status
[19:25:17.351] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:17.351] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:15:0) after 1m0s
[19:26:18.061] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:15:0)
[19:26:18.061] Timer tick, asking Buildbucket for the build status
[19:26:18.256] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:18.256] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:16:0) after 1m0s
[19:27:18.453] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:16:0)
[19:27:18.453] Timer tick, asking Buildbucket for the build status
[19:27:18.655] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:18.655] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:17:0) after 1m0s
[19:28:18.716] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:17:0)
[19:28:18.716] Timer tick, asking Buildbucket for the build status
[19:28:18.882] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:18.882] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:18:0) after 1m0s
[19:29:18.955] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:18:0)
[19:29:18.955] Timer tick, asking Buildbucket for the build status
[19:29:19.369] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:19.369] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:19:0) after 1m0s
[19:30:19.486] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:19:0)
[19:30:19.486] Timer tick, asking Buildbucket for the build status
[19:30:19.734] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:19.734] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:20:0) after 1m0s
[19:31:19.866] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:20:0)
[19:31:19.867] Timer tick, asking Buildbucket for the build status
[19:31:19.965] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:19.965] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:21:0) after 1m0s
[19:32:20.007] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:21:0)
[19:32:20.007] Timer tick, asking Buildbucket for the build status
[19:32:20.229] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:20.229] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:22:0) after 1m0s
[19:33:20.359] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:22:0)
[19:33:20.359] Timer tick, asking Buildbucket for the build status
[19:33:20.487] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:20.487] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:23:0) after 1m0s
[19:34:20.837] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:23:0)
[19:34:20.837] Timer tick, asking Buildbucket for the build status
[19:34:20.981] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:20.981] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:24:0) after 1m0s
[19:35:21.245] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:24:0)
[19:35:21.245] Timer tick, asking Buildbucket for the build status
[19:35:21.323] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:21.323] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:25:0) after 1m0s
[19:36:21.464] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:25:0)
[19:36:21.464] Timer tick, asking Buildbucket for the build status
[19:36:21.534] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:21.534] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:26:0) after 1m0s
[19:37:21.559] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:26:0)
[19:37:21.559] Timer tick, asking Buildbucket for the build status
[19:37:21.706] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:21.706] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:27:0) after 1m0s
[19:38:21.861] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:27:0)
[19:38:21.861] Timer tick, asking Buildbucket for the build status
[19:38:22.062] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:22.062] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:28:0) after 1m0s
[19:39:22.444] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:28:0)
[19:39:22.444] Timer tick, asking Buildbucket for the build status
[19:39:22.526] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:22.526] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:29:0) after 1m0s
[19:40:22.702] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:29:0)
[19:40:22.702] Timer tick, asking Buildbucket for the build status
[19:40:22.821] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:22.821] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:30:0) after 1m0s
[19:41:22.851] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:30:0)
[19:41:22.851] Timer tick, asking Buildbucket for the build status
[19:41:22.960] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:22.960] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:31:0) after 1m0s
[19:42:23.042] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:31:0)
[19:42:23.042] Timer tick, asking Buildbucket for the build status
[19:42:23.139] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:23.139] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:32:0) after 1m0s
[19:43:23.194] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:32:0)
[19:43:23.194] Timer tick, asking Buildbucket for the build status
[19:43:23.382] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:23.382] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:33:0) after 1m0s
[19:44:23.574] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:33:0)
[19:44:23.574] Timer tick, asking Buildbucket for the build status
[19:44:23.697] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:23.697] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:34:0) after 1m0s
[19:45:23.848] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:34:0)
[19:45:23.848] Timer tick, asking Buildbucket for the build status
[19:45:23.958] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:23.958] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:35:0) after 1m0s
[19:46:24.005] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:35:0)
[19:46:24.005] Timer tick, asking Buildbucket for the build status
[19:46:24.086] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:24.086] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:36:0) after 1m0s
[19:47:24.451] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:36:0)
[19:47:24.451] Timer tick, asking Buildbucket for the build status
[19:47:24.544] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:24.544] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:37:0) after 1m0s
[19:48:24.671] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:37:0)
[19:48:24.671] Timer tick, asking Buildbucket for the build status
[19:48:24.823] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:24.823] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:38:0) after 1m0s
[19:49:25.064] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:38:0)
[19:49:25.064] Timer tick, asking Buildbucket for the build status
[19:49:25.219] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:25.219] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:39:0) after 1m0s
[19:50:25.307] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:39:0)
[19:50:25.307] Timer tick, asking Buildbucket for the build status
[19:50:25.468] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:25.468] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:40:0) after 1m0s
[19:51:25.514] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:40:0)
[19:51:25.514] Timer tick, asking Buildbucket for the build status
[19:51:25.585] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:25.585] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:41:0) after 1m0s
[19:52:25.644] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:41:0)
[19:52:25.644] Timer tick, asking Buildbucket for the build status
[19:52:25.713] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:25.713] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:42:0) after 1m0s
[19:53:25.776] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:42:0)
[19:53:25.776] Timer tick, asking Buildbucket for the build status
[19:53:26.385] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:26.388] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:43:0) after 1m0s
[19:54:26.500] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:43:0)
[19:54:26.500] Timer tick, asking Buildbucket for the build status
[19:54:26.868] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:26.868] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:44:0) after 1m0s
[19:55:26.924] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:44:0)
[19:55:26.924] Timer tick, asking Buildbucket for the build status
[19:55:27.492] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:27.492] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:45:0) after 1m0s
[19:56:27.531] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:45:0)
[19:56:27.531] Timer tick, asking Buildbucket for the build status
[19:56:27.609] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:27.609] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:46:0) after 1m0s
[19:57:27.646] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:46:0)
[19:57:27.646] Timer tick, asking Buildbucket for the build status
[19:57:27.782] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:27.782] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:47:0) after 1m0s
[19:58:27.816] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:47:0)
[19:58:27.816] Timer tick, asking Buildbucket for the build status
[19:58:28.043] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:28.045] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:48:0) after 1m0s
[19:59:28.093] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:48:0)
[19:59:28.093] Timer tick, asking Buildbucket for the build status
[19:59:28.163] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:28.163] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:49:0) after 1m0s
[20:00:28.163] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:49:0)
[20:00:28.163] Timer tick, asking Buildbucket for the build status
[20:00:28.238] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:28.238] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:50:0) after 1m0s
[20:01:28.330] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:50:0)
[20:01:28.330] Timer tick, asking Buildbucket for the build status
[20:01:28.413] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:28.414] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:51:0) after 1m0s
[20:02:28.477] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:51:0)
[20:02:28.477] Timer tick, asking Buildbucket for the build status
[20:02:29.161] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:29.161] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:52:0) after 1m0s
[20:03:29.243] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:52:0)
[20:03:29.243] Timer tick, asking Buildbucket for the build status
[20:03:29.411] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:29.411] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:53:0) after 1m0s
[20:04:29.488] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:53:0)
[20:04:29.488] Timer tick, asking Buildbucket for the build status
[20:04:29.566] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:29.566] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:54:0) after 1m0s
[20:05:29.634] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:54:0)
[20:05:29.634] Timer tick, asking Buildbucket for the build status
[20:05:29.709] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:29.709] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:55:0) after 1m0s
[20:06:29.758] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:55:0)
[20:06:29.758] Timer tick, asking Buildbucket for the build status
[20:06:29.958] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:29.958] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:56:0) after 1m0s
[20:07:29.967] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:56:0)
[20:07:29.967] Timer tick, asking Buildbucket for the build status
[20:07:30.437] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:30.437] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:57:0) after 1m0s
[20:08:30.498] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:57:0)
[20:08:30.498] Timer tick, asking Buildbucket for the build status
[20:08:30.640] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:30.640] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:58:0) after 1m0s
[20:09:30.704] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:58:0)
[20:09:30.704] Timer tick, asking Buildbucket for the build status
[20:09:30.778] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:30.778] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:59:0) after 1m0s
[20:10:30.825] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:59:0)
[20:10:30.825] Timer tick, asking Buildbucket for the build status
[20:10:31.636] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:31.636] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:60:0) after 1m0s
[20:11:31.698] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:60:0)
[20:11:31.698] Timer tick, asking Buildbucket for the build status
[20:11:31.763] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:31.763] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:61:0) after 1m0s
[20:12:31.835] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:61:0)
[20:12:31.835] Timer tick, asking Buildbucket for the build status
[20:12:32.181] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:32.181] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:62:0) after 1m0s
[20:13:32.265] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:62:0)
[20:13:32.265] Timer tick, asking Buildbucket for the build status
[20:13:32.468] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:32.468] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:63:0) after 1m0s
[20:14:32.544] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:63:0)
[20:14:32.544] Timer tick, asking Buildbucket for the build status
[20:14:32.661] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:32.661] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:64:0) after 1m0s
[20:15:32.740] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:64:0)
[20:15:32.740] Timer tick, asking Buildbucket for the build status
[20:15:32.842] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:32.842] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:65:0) after 1m0s
[20:16:32.931] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:65:0)
[20:16:32.931] Timer tick, asking Buildbucket for the build status
[20:16:33.015] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:33.015] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:66:0) after 1m0s
[20:17:33.122] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:66:0)
[20:17:33.122] Timer tick, asking Buildbucket for the build status
[20:17:33.213] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:33.213] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:67:0) after 1m0s
[20:18:33.374] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:67:0)
[20:18:33.374] Timer tick, asking Buildbucket for the build status
[20:18:33.527] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:33.527] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:68:0) after 1m0s
[20:19:34.159] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:68:0)
[20:19:34.159] Timer tick, asking Buildbucket for the build status
[20:19:34.281] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:34.281] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:69:0) after 1m0s
[20:20:34.887] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:69:0)
[20:20:34.887] Timer tick, asking Buildbucket for the build status
[20:20:34.993] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:34.993] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:70:0) after 1m0s
[20:21:35.434] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:70:0)
[20:21:35.434] Timer tick, asking Buildbucket for the build status
[20:21:35.931] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:35.931] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:71:0) after 1m0s
[20:22:36.212] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:71:0)
[20:22:36.212] Timer tick, asking Buildbucket for the build status
[20:22:36.273] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:36.273] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:72:0) after 1m0s
[20:23:36.311] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:72:0)
[20:23:36.311] Timer tick, asking Buildbucket for the build status
[20:23:36.421] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:36.421] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:73:0) after 1m0s
[20:24:36.705] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:73:0)
[20:24:36.705] Timer tick, asking Buildbucket for the build status
[20:24:36.897] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:36.897] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:74:0) after 1m0s
[20:25:37.512] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:74:0)
[20:25:37.512] Timer tick, asking Buildbucket for the build status
[20:25:37.588] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:37.588] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:75:0) after 1m0s
[20:26:37.731] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:75:0)
[20:26:37.731] Timer tick, asking Buildbucket for the build status
[20:26:37.804] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:37.804] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:76:0) after 1m0s
[20:27:38.009] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:76:0)
[20:27:38.009] Timer tick, asking Buildbucket for the build status
[20:27:38.224] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:38.224] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:77:0) after 1m0s
[20:28:38.646] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:77:0)
[20:28:38.651] Timer tick, asking Buildbucket for the build status
[20:28:39.148] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:39.148] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:78:0) after 1m0s
[20:29:39.184] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:78:0)
[20:29:39.184] Timer tick, asking Buildbucket for the build status
[20:29:39.281] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:39.281] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:79:0) after 1m0s
[20:30:39.313] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:79:0)
[20:30:39.313] Timer tick, asking Buildbucket for the build status
[20:30:41.438] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:41.438] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:80:0) after 1m0s
[20:31:41.462] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:80:0)
[20:31:41.462] Timer tick, asking Buildbucket for the build status
[20:31:41.744] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:41.744] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:81:0) after 1m0s
[20:32:42.030] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:81:0)
[20:32:42.030] Timer tick, asking Buildbucket for the build status
[20:32:42.408] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:42.408] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:82:0) after 1m0s
[20:33:42.606] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:82:0)
[20:33:42.606] Timer tick, asking Buildbucket for the build status
[20:33:42.786] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:42.788] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:83:0) after 1m0s
[20:34:43.120] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:83:0)
[20:34:43.121] Timer tick, asking Buildbucket for the build status
[20:34:43.507] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:43.507] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:84:0) after 1m0s
[20:35:43.525] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:84:0)
[20:35:43.525] Timer tick, asking Buildbucket for the build status
[20:35:43.613] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:43.613] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:85:0) after 1m0s
[20:36:43.652] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:85:0)
[20:36:43.652] Timer tick, asking Buildbucket for the build status
[20:36:43.739] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:43.739] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:86:0) after 1m0s
[20:37:44.026] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:86:0)
[20:37:44.026] Timer tick, asking Buildbucket for the build status
[20:37:44.119] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:44.119] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:87:0) after 1m0s
[20:38:44.252] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:87:0)
[20:38:44.252] Timer tick, asking Buildbucket for the build status
[20:38:44.470] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:44.470] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:88:0) after 1m0s
[20:39:44.634] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:88:0)
[20:39:44.634] Timer tick, asking Buildbucket for the build status
[20:39:44.732] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:44.732] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:89:0) after 1m0s
[20:40:44.988] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:89:0)
[20:40:44.988] Timer tick, asking Buildbucket for the build status
[20:40:45.379] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:45.379] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:90:0) after 1m0s
[20:41:45.546] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:90:0)
[20:41:45.546] Timer tick, asking Buildbucket for the build status
[20:41:45.631] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:45.631] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:91:0) after 1m0s
[20:42:45.795] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:91:0)
[20:42:45.795] Timer tick, asking Buildbucket for the build status
[20:42:45.899] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:45.899] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:92:0) after 1m0s
[20:43:46.055] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:92:0)
[20:43:46.055] Timer tick, asking Buildbucket for the build status
[20:43:46.233] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:46.233] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:93:0) after 1m0s
[20:44:46.394] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:93:0)
[20:44:46.394] Timer tick, asking Buildbucket for the build status
[20:44:46.474] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:46.474] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:94:0) after 1m0s
[20:45:46.668] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:94:0)
[20:45:46.668] Timer tick, asking Buildbucket for the build status
[20:45:46.734] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:46.734] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:95:0) after 1m0s
[20:46:47.281] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:95:0)
[20:46:47.281] Timer tick, asking Buildbucket for the build status
[20:46:47.540] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:47.540] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:96:0) after 1m0s
[20:47:47.662] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:96:0)
[20:47:47.662] Timer tick, asking Buildbucket for the build status
[20:47:49.005] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:49.005] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:97:0) after 1m0s
[20:48:49.352] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:97:0)
[20:48:49.352] Timer tick, asking Buildbucket for the build status
[20:48:50.644] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:50.652] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:98:0) after 1m0s
[20:49:50.738] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:98:0)
[20:49:50.738] Timer tick, asking Buildbucket for the build status
[20:49:51.124] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:51.124] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:99:0) after 1m0s
[20:50:51.173] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:99:0)
[20:50:51.173] Timer tick, asking Buildbucket for the build status
[20:50:51.240] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:51.240] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:100:0) after 1m0s
[20:51:51.469] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:100:0)
[20:51:51.469] Timer tick, asking Buildbucket for the build status
[20:51:51.562] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:51.562] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:101:0) after 1m0s
[20:52:51.652] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:101:0)
[20:52:51.652] Timer tick, asking Buildbucket for the build status
[20:52:51.726] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:51.726] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:102:0) after 1m0s
[20:53:51.766] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:102:0)
[20:53:51.766] Timer tick, asking Buildbucket for the build status
[20:53:52.029] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:52.029] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:103:0) after 1m0s
[20:54:52.176] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:103:0)
[20:54:52.176] Timer tick, asking Buildbucket for the build status
[20:54:52.305] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:52.305] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:104:0) after 1m0s
[20:55:52.320] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:104:0)
[20:55:52.320] Timer tick, asking Buildbucket for the build status
[20:55:52.662] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:52.662] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:105:0) after 1m0s
[20:56:52.925] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:105:0)
[20:56:52.925] Timer tick, asking Buildbucket for the build status
[20:56:53.054] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:53.054] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:106:0) after 1m0s
[20:57:53.077] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:106:0)
[20:57:53.077] Timer tick, asking Buildbucket for the build status
[20:57:53.161] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:53.161] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:107:0) after 1m0s
[20:58:53.785] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:107:0)
[20:58:53.785] Timer tick, asking Buildbucket for the build status
[20:58:53.935] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:53.935] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:108:0) after 1m0s
[20:59:54.045] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:108:0)
[20:59:54.045] Timer tick, asking Buildbucket for the build status
[20:59:54.330] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:54.330] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:109:0) after 1m0s
[21:00:54.737] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:109:0)
[21:00:54.737] Timer tick, asking Buildbucket for the build status
[21:00:54.864] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:54.864] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:110:0) after 1m0s
[21:01:54.954] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:110:0)
[21:01:54.954] Timer tick, asking Buildbucket for the build status
[21:01:55.169] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:55.169] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:111:0) after 1m0s
[21:02:55.285] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:111:0)
[21:02:55.285] Timer tick, asking Buildbucket for the build status
[21:02:55.442] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:55.443] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:112:0) after 1m0s
[21:03:55.651] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:112:0)
[21:03:55.651] Timer tick, asking Buildbucket for the build status
[21:03:56.021] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:56.021] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:113:0) after 1m0s
[21:04:56.188] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:113:0)
[21:04:56.188] Timer tick, asking Buildbucket for the build status
[21:04:56.261] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:56.261] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:114:0) after 1m0s
[21:05:56.400] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:114:0)
[21:05:56.400] Timer tick, asking Buildbucket for the build status
[21:05:56.824] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:56.828] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:115:0) after 1m0s
[21:06:57.002] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:115:0)
[21:06:57.002] Timer tick, asking Buildbucket for the build status
[21:06:57.079] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:57.080] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:116:0) after 1m0s
[21:07:57.179] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:116:0)
[21:07:57.179] Timer tick, asking Buildbucket for the build status
[21:07:57.293] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:57.293] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:117:0) after 1m0s
[21:08:57.351] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:117:0)
[21:08:57.351] Timer tick, asking Buildbucket for the build status
[21:08:57.500] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:57.500] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:118:0) after 1m0s
[21:09:57.543] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:118:0)
[21:09:57.543] Timer tick, asking Buildbucket for the build status
[21:09:57.735] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:57.735] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:119:0) after 1m0s
[21:10:57.976] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:119:0)
[21:10:57.976] Timer tick, asking Buildbucket for the build status
[21:10:58.109] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:58.109] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:120:0) after 1m0s
[21:11:58.282] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:120:0)
[21:11:58.282] Timer tick, asking Buildbucket for the build status
[21:11:58.408] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:58.408] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:121:0) after 1m0s
[21:12:58.455] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:121:0)
[21:12:58.455] Timer tick, asking Buildbucket for the build status
[21:12:58.581] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:58.581] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:122:0) after 1m0s
[21:13:58.724] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:122:0)
[21:13:58.724] Timer tick, asking Buildbucket for the build status
[21:13:58.832] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:58.832] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:123:0) after 1m0s
[21:14:58.938] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:123:0)
[21:14:58.938] Timer tick, asking Buildbucket for the build status
[21:14:59.039] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:59.039] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:124:0) after 1m0s
[21:15:59.851] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:124:0)
[21:15:59.851] Timer tick, asking Buildbucket for the build status
[21:16:00.003] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:00.003] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:125:0) after 1m0s
[21:17:00.309] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:125:0)
[21:17:00.309] Timer tick, asking Buildbucket for the build status
[21:17:00.534] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:00.534] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:126:0) after 1m0s
[21:18:00.664] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:126:0)
[21:18:00.664] Timer tick, asking Buildbucket for the build status
[21:18:00.783] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:00.783] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:127:0) after 1m0s
[21:19:00.976] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:127:0)
[21:19:00.976] Timer tick, asking Buildbucket for the build status
[21:19:01.131] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:01.131] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:128:0) after 1m0s
[21:20:01.288] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:128:0)
[21:20:01.288] Timer tick, asking Buildbucket for the build status
[21:20:01.399] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:01.399] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:129:0) after 1m0s
[21:21:01.582] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:129:0)
[21:21:01.582] Timer tick, asking Buildbucket for the build status
[21:21:02.072] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:02.072] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:130:0) after 1m0s
[21:22:02.425] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:130:0)
[21:22:02.425] Timer tick, asking Buildbucket for the build status
[21:22:02.539] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:02.539] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:131:0) after 1m0s
[21:23:02.680] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:131:0)
[21:23:02.680] Timer tick, asking Buildbucket for the build status
[21:23:02.761] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:02.761] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:132:0) after 1m0s
[21:24:02.797] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:132:0)
[21:24:02.797] Timer tick, asking Buildbucket for the build status
[21:24:03.122] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:03.122] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:133:0) after 1m0s
[21:25:03.214] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:133:0)
[21:25:03.214] Timer tick, asking Buildbucket for the build status
[21:25:03.776] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:03.776] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:134:0) after 1m0s
[21:26:03.806] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:134:0)
[21:26:03.806] Timer tick, asking Buildbucket for the build status
[21:26:04.795] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:04.795] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:135:0) after 1m0s
[21:27:04.922] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:135:0)
[21:27:04.922] Timer tick, asking Buildbucket for the build status
[21:27:05.042] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:05.042] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:136:0) after 1m0s
[21:28:05.414] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:136:0)
[21:28:05.415] Timer tick, asking Buildbucket for the build status
[21:28:05.605] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:05.608] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:137:0) after 1m0s
[21:29:05.702] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:137:0)
[21:29:05.702] Timer tick, asking Buildbucket for the build status
[21:29:08.966] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:08.966] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:138:0) after 1m0s
[21:30:09.719] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:138:0)
[21:30:09.719] Timer tick, asking Buildbucket for the build status
[21:30:10.019] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:10.020] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:139:0) after 1m0s
[21:31:10.013] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:139:0)
[21:31:10.013] Timer tick, asking Buildbucket for the build status
[21:31:10.067] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:10.067] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:140:0) after 1m0s
[21:32:10.762] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:140:0)
[21:32:10.762] Timer tick, asking Buildbucket for the build status
[21:32:10.951] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:10.951] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:141:0) after 1m0s
[21:33:10.988] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:141:0)
[21:33:10.988] Timer tick, asking Buildbucket for the build status
[21:33:23.760] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:23.760] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:142:0) after 1m0s
[21:34:24.226] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:142:0)
[21:34:24.226] Timer tick, asking Buildbucket for the build status
[21:34:24.411] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:24.411] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:143:0) after 1m0s
[21:35:24.712] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:143:0)
[21:35:24.712] Timer tick, asking Buildbucket for the build status
[21:35:24.805] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:24.805] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:144:0) after 1m0s
[21:36:24.913] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:144:0)
[21:36:24.913] Timer tick, asking Buildbucket for the build status
[21:36:25.111] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:25.111] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:145:0) after 1m0s
[21:37:25.423] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:145:0)
[21:37:25.423] Timer tick, asking Buildbucket for the build status
[21:37:25.622] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:25.622] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:146:0) after 1m0s
[21:38:26.028] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:146:0)
[21:38:26.028] Timer tick, asking Buildbucket for the build status
[21:38:26.172] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:26.172] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:147:0) after 1m0s
[21:39:26.564] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:147:0)
[21:39:26.564] Timer tick, asking Buildbucket for the build status
[21:39:28.887] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:28.887] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:148:0) after 1m0s
[21:40:29.504] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:148:0)
[21:40:29.504] Timer tick, asking Buildbucket for the build status
[21:40:29.577] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:29.577] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:149:0) after 1m0s
[21:41:29.649] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:149:0)
[21:41:29.649] Timer tick, asking Buildbucket for the build status
[21:41:29.744] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:29.744] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:150:0) after 1m0s
[21:42:29.972] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:150:0)
[21:42:29.972] Timer tick, asking Buildbucket for the build status
[21:42:30.255] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:30.255] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:151:0) after 1m0s
[21:43:30.290] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:151:0)
[21:43:30.290] Timer tick, asking Buildbucket for the build status
[21:43:30.423] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:30.423] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:152:0) after 1m0s
[21:44:30.872] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:152:0)
[21:44:30.872] Timer tick, asking Buildbucket for the build status
[21:44:30.960] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:30.960] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:153:0) after 1m0s
[21:45:31.196] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:153:0)
[21:45:31.196] Timer tick, asking Buildbucket for the build status
[21:45:31.301] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:31.301] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:154:0) after 1m0s
[21:46:31.340] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:154:0)
[21:46:31.340] Timer tick, asking Buildbucket for the build status
[21:46:31.430] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:31.430] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:155:0) after 1m0s
[21:47:31.451] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:155:0)
[21:47:31.451] Timer tick, asking Buildbucket for the build status
[21:47:31.618] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:31.618] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:156:0) after 1m0s
[21:48:32.268] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:156:0)
[21:48:32.268] Timer tick, asking Buildbucket for the build status
[21:48:33.717] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:33.717] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:157:0) after 1m0s
[21:49:33.786] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:157:0)
[21:49:33.786] Timer tick, asking Buildbucket for the build status
[21:49:33.885] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:33.885] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:158:0) after 1m0s
[21:50:33.951] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:158:0)
[21:50:33.951] Timer tick, asking Buildbucket for the build status
[21:50:34.018] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:34.018] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:159:0) after 1m0s
[21:51:34.044] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:159:0)
[21:51:34.044] Timer tick, asking Buildbucket for the build status
[21:51:34.139] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:34.139] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:160:0) after 1m0s
[21:52:34.217] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:160:0)
[21:52:34.217] Timer tick, asking Buildbucket for the build status
[21:52:34.341] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:34.341] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:161:0) after 1m0s
[21:53:34.432] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:161:0)
[21:53:34.432] Timer tick, asking Buildbucket for the build status
[21:53:34.583] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:34.583] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:162:0) after 1m0s
[21:54:34.773] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:162:0)
[21:54:34.773] Timer tick, asking Buildbucket for the build status
[21:54:34.908] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:34.908] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:163:0) after 1m0s
[21:55:34.997] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:163:0)
[21:55:34.997] Timer tick, asking Buildbucket for the build status
[21:55:35.159] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:35.160] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:164:0) after 1m0s
[21:56:35.486] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:164:0)
[21:56:35.486] Timer tick, asking Buildbucket for the build status
[21:56:35.625] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:35.625] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:165:0) after 1m0s
[21:57:35.703] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:165:0)
[21:57:35.703] Timer tick, asking Buildbucket for the build status
[21:57:35.999] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:35.999] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:166:0) after 1m0s
[21:58:36.098] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:166:0)
[21:58:36.098] Timer tick, asking Buildbucket for the build status
[21:58:36.300] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:36.300] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:167:0) after 1m0s
[21:59:36.534] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:167:0)
[21:59:36.534] Timer tick, asking Buildbucket for the build status
[21:59:36.621] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:36.621] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:168:0) after 1m0s
[22:00:36.738] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:168:0)
[22:00:36.738] Timer tick, asking Buildbucket for the build status
[22:00:36.853] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:36.853] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:169:0) after 1m0s
[22:01:37.153] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:169:0)
[22:01:37.153] Timer tick, asking Buildbucket for the build status
[22:01:37.540] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:37.540] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:170:0) after 1m0s
[22:02:37.941] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:170:0)
[22:02:37.941] Timer tick, asking Buildbucket for the build status
[22:02:38.027] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:38.027] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:171:0) after 1m0s
[22:03:38.444] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:171:0)
[22:03:38.444] Timer tick, asking Buildbucket for the build status
[22:03:38.625] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:38.625] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:172:0) after 1m0s
[22:04:38.674] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:172:0)
[22:04:38.674] Timer tick, asking Buildbucket for the build status
[22:04:38.824] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:38.824] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:173:0) after 1m0s
[22:05:39.108] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:173:0)
[22:05:39.108] Timer tick, asking Buildbucket for the build status
[22:05:39.488] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:39.488] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:174:0) after 1m0s
[22:06:39.550] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:174:0)
[22:06:39.550] Timer tick, asking Buildbucket for the build status
[22:06:39.632] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:39.633] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:175:0) after 1m0s
[22:07:39.690] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:175:0)
[22:07:39.690] Timer tick, asking Buildbucket for the build status
[22:07:39.823] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:39.823] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:176:0) after 1m0s
[22:08:39.824] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:176:0)
[22:08:39.824] Timer tick, asking Buildbucket for the build status
[22:08:39.967] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:39.967] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:177:0) after 1m0s
[22:09:39.982] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:177:0)
[22:09:39.982] Timer tick, asking Buildbucket for the build status
[22:09:40.083] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:40.083] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:178:0) after 1m0s
[22:10:40.323] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:178:0)
[22:10:40.323] Timer tick, asking Buildbucket for the build status
[22:10:40.516] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:40.516] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:179:0) after 1m0s
[22:11:40.639] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:179:0)
[22:11:40.639] Timer tick, asking Buildbucket for the build status
[22:11:40.831] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:40.831] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:180:0) after 1m0s
[22:12:41.392] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:180:0)
[22:12:41.392] Timer tick, asking Buildbucket for the build status
[22:12:41.639] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:41.639] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:181:0) after 1m0s
[22:13:41.731] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:181:0)
[22:13:41.731] Timer tick, asking Buildbucket for the build status
[22:13:41.942] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:41.942] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:182:0) after 1m0s
[22:14:42.010] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:182:0)
[22:14:42.010] Timer tick, asking Buildbucket for the build status
[22:14:42.283] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:42.283] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:183:0) after 1m0s
[22:15:42.301] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:183:0)
[22:15:42.301] Timer tick, asking Buildbucket for the build status
[22:15:42.506] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:42.507] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:184:0) after 1m0s
[22:16:42.561] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:184:0)
[22:16:42.561] Timer tick, asking Buildbucket for the build status
[22:16:42.654] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:42.654] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:185:0) after 1m0s
[22:17:42.728] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:185:0)
[22:17:42.728] Timer tick, asking Buildbucket for the build status
[22:17:42.787] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:42.787] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:186:0) after 1m0s
[22:18:42.803] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:186:0)
[22:18:42.803] Timer tick, asking Buildbucket for the build status
[22:18:42.984] Build 8870243105159107376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:42.984] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035673167340860000:187:0) after 1m0s
[22:19:03.937] Received PubSub notification, asking Buildbucket for the build status
[22:19:04.031] Build 8870243105159107376: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:19:04.031] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1599085143037147",
"created_by": "project:chromium",
"created_ts": "1599073992538008",
"id": "8870243105159107376",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a270ae9a2998a3f3031e8e2af3fe69a5a33852ce\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"a270ae9a2998a3f3031e8e2af3fe69a5a33852ce\", \"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-6-vnlw\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 490, \"got_angle_revision\": \"121d985642fd5599e95221f70140dc5df4137bdb\", \"got_dawn_revision\": \"e9bc506e0ab03dd7984ab5a6aade07651f2d9c17\", \"got_nacl_revision\": \"3008f9e6de122325d8f9dbf02f7cdd51fa1ec306\", \"got_revision\": \"a270ae9a2998a3f3031e8e2af3fe69a5a33852ce\", \"got_revision_cp\": \"refs/heads/master@{#803947}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"e1051cbaad46dc98967bee2e00a697d7f82b6658\", \"got_v8_revision\": \"2b9e3dd7f14646ec720f274a85d860172fc136d4\", \"got_v8_revision_cp\": \"refs/heads/8.7.57@{#1}\", \"got_webrtc_revision\": \"444c13c078a7e9bb2174419e12113e39929551d8\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32028}\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a270ae9a2998a3f3031e8e2af3fe69a5a33852ce\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_9b3ebe5fd1c5be87380c40d216747346a59b28cf26de183f0e8e2b32e944d3c8_v2\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-6-vnlw\"], \"image\": [\"chrome-win10-1703-20081700-d9392568d25\"], \"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\": [\"5507-6e8d655\"], \"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": "1599074033360422",
"status": "COMPLETED",
"status_changed_ts": "1599085143559218",
"tags": [
"build_address:luci.chromium.ci/win-official/490",
"builder:win-official",
"buildset:commit/git/a270ae9a2998a3f3031e8e2af3fe69a5a33852ce",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a270ae9a2998a3f3031e8e2af3fe69a5a33852ce",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9035673167340860000",
"scheduler_job_id:chromium/win-official",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8870243105159107376/+/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:4e690e4b69057810",
"user_agent:luci-scheduler"
],
"updated_ts": "1599085143566679",
"url": "https://ci.chromium.org/b/8870243105159107376",
"utcnow_ts": "1599085144022830"
}
}
[22:19:04.031] Invocation finished in 3h5m52.958847949s with status SUCCEEDED