[20:06:44.735] New invocation is queued and will start shortly
[20:06:45.972] Starting the invocation (attempt 1)
[20:06:46.050] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:06:46.050] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:06:46.050] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9031411740171253072",
"parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"80fe8a6458cb02dfd1c96cf976f2d288d9d0b71d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-official",
"scheduler_invocation_id:9031411740171253072",
"scheduler_job_id:chromium/win-official",
"user_agent:luci-scheduler",
"buildset:commit/git/80fe8a6458cb02dfd1c96cf976f2d288d9d0b71d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/80fe8a6458cb02dfd1c96cf976f2d288d9d0b71d",
"gitiles_ref:refs/heads/master"
]
}
[20:06:46.714] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1603138006158695",
"id": "8865981678013049600",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"80fe8a6458cb02dfd1c96cf976f2d288d9d0b71d\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603138006566416",
"tags": [
"build_address:luci.chromium.ci/win-official/855",
"builder:win-official",
"buildset:commit/git/80fe8a6458cb02dfd1c96cf976f2d288d9d0b71d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/80fe8a6458cb02dfd1c96cf976f2d288d9d0b71d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031411740171253072",
"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/8865981678013049600/+/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": "1603138006566545",
"url": "https://ci.chromium.org/b/8865981678013049600",
"utcnow_ts": "1603138006703637"
}
}
[20:06:46.714] Task URL: https://ci.chromium.org/b/8865981678013049600
[20:06:46.714] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:2:0) after 1m0s
[20:07:46.738] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:2:0)
[20:07:46.738] Timer tick, asking Buildbucket for the build status
[20:07:47.035] Build 8865981678013049600: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:07:47.035] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:3:0) after 1m0s
[20:07:57.640] Received PubSub notification, asking Buildbucket for the build status
[20:07:57.714] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:47.158] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:3:0)
[20:08:47.159] Timer tick, asking Buildbucket for the build status
[20:08:47.255] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:47.255] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:5:0) after 1m0s
[20:09:47.246] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:5:0)
[20:09:47.246] Timer tick, asking Buildbucket for the build status
[20:09:47.343] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:47.343] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:6:0) after 1m0s
[20:10:47.408] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:6:0)
[20:10:47.408] Timer tick, asking Buildbucket for the build status
[20:10:47.526] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:47.526] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:7:0) after 1m0s
[20:11:47.553] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:7:0)
[20:11:47.553] Timer tick, asking Buildbucket for the build status
[20:11:47.641] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:47.641] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:8:0) after 1m0s
[20:12:47.654] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:8:0)
[20:12:47.654] Timer tick, asking Buildbucket for the build status
[20:12:47.767] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:47.767] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:9:0) after 1m0s
[20:13:47.770] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:9:0)
[20:13:47.770] Timer tick, asking Buildbucket for the build status
[20:13:48.918] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:48.918] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:10:0) after 1m0s
[20:14:48.985] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:10:0)
[20:14:48.985] Timer tick, asking Buildbucket for the build status
[20:14:49.219] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:49.219] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:11:0) after 1m0s
[20:15:49.287] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:11:0)
[20:15:49.287] Timer tick, asking Buildbucket for the build status
[20:15:49.439] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:49.439] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:12:0) after 1m0s
[20:16:49.482] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:12:0)
[20:16:49.482] Timer tick, asking Buildbucket for the build status
[20:16:49.556] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:49.556] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:13:0) after 1m0s
[20:17:49.583] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:13:0)
[20:17:49.584] Timer tick, asking Buildbucket for the build status
[20:17:49.695] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:49.695] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:14:0) after 1m0s
[20:18:49.962] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:14:0)
[20:18:49.962] Timer tick, asking Buildbucket for the build status
[20:18:50.121] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:50.121] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:15:0) after 1m0s
[20:19:50.271] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:15:0)
[20:19:50.271] Timer tick, asking Buildbucket for the build status
[20:19:50.441] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:50.441] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:16:0) after 1m0s
[20:20:50.583] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:16:0)
[20:20:50.583] Timer tick, asking Buildbucket for the build status
[20:20:53.197] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:53.197] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:17:0) after 1m0s
[20:21:53.270] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:17:0)
[20:21:53.270] Timer tick, asking Buildbucket for the build status
[20:21:53.376] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:53.376] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:18:0) after 1m0s
[20:22:53.394] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:18:0)
[20:22:53.394] Timer tick, asking Buildbucket for the build status
[20:22:53.693] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:53.693] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:19:0) after 1m0s
[20:23:53.719] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:19:0)
[20:23:53.719] Timer tick, asking Buildbucket for the build status
[20:23:53.994] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:53.994] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:20:0) after 1m0s
[20:24:54.044] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:20:0)
[20:24:54.044] Timer tick, asking Buildbucket for the build status
[20:24:54.168] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:54.168] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:21:0) after 1m0s
[20:25:54.562] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:21:0)
[20:25:54.562] Timer tick, asking Buildbucket for the build status
[20:26:05.117] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:05.117] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:22:0) after 1m0s
[20:27:05.193] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:22:0)
[20:27:05.193] Timer tick, asking Buildbucket for the build status
[20:27:05.251] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:05.251] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:23:0) after 1m0s
[20:28:05.409] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:23:0)
[20:28:05.409] Timer tick, asking Buildbucket for the build status
[20:28:05.513] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:05.513] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:24:0) after 1m0s
[20:29:05.636] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:24:0)
[20:29:05.636] Timer tick, asking Buildbucket for the build status
[20:29:05.719] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:05.719] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:25:0) after 1m0s
[20:30:05.761] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:25:0)
[20:30:05.761] Timer tick, asking Buildbucket for the build status
[20:30:05.839] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:05.839] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:26:0) after 1m0s
[20:31:05.854] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:26:0)
[20:31:05.854] Timer tick, asking Buildbucket for the build status
[20:31:05.960] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:05.960] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:27:0) after 1m0s
[20:32:06.091] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:27:0)
[20:32:06.091] Timer tick, asking Buildbucket for the build status
[20:32:06.189] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:06.189] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:28:0) after 1m0s
[20:33:06.264] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:28:0)
[20:33:06.264] Timer tick, asking Buildbucket for the build status
[20:33:06.540] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:06.540] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:29:0) after 1m0s
[20:34:06.565] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:29:0)
[20:34:06.565] Timer tick, asking Buildbucket for the build status
[20:34:06.649] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:06.649] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:30:0) after 1m0s
[20:35:06.633] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:30:0)
[20:35:06.633] Timer tick, asking Buildbucket for the build status
[20:35:06.695] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:06.695] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:31:0) after 1m0s
[20:36:06.724] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:31:0)
[20:36:06.724] Timer tick, asking Buildbucket for the build status
[20:36:06.791] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:06.791] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:32:0) after 1m0s
[20:37:06.793] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:32:0)
[20:37:06.793] Timer tick, asking Buildbucket for the build status
[20:37:07.069] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:07.069] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:33:0) after 1m0s
[20:38:07.079] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:33:0)
[20:38:07.079] Timer tick, asking Buildbucket for the build status
[20:38:07.919] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:07.919] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:34:0) after 1m0s
[20:39:07.973] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:34:0)
[20:39:07.973] Timer tick, asking Buildbucket for the build status
[20:39:08.193] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:08.193] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:35:0) after 1m0s
[20:40:08.192] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:35:0)
[20:40:08.192] Timer tick, asking Buildbucket for the build status
[20:40:08.294] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:08.294] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:36:0) after 1m0s
[20:41:08.286] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:36:0)
[20:41:08.286] Timer tick, asking Buildbucket for the build status
[20:41:08.344] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:08.344] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:37:0) after 1m0s
[20:42:08.366] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:37:0)
[20:42:08.366] Timer tick, asking Buildbucket for the build status
[20:42:08.583] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:08.583] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:38:0) after 1m0s
[20:43:08.630] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:38:0)
[20:43:08.630] Timer tick, asking Buildbucket for the build status
[20:43:08.854] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:08.854] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:39:0) after 1m0s
[20:44:08.904] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:39:0)
[20:44:08.905] Timer tick, asking Buildbucket for the build status
[20:44:09.124] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:09.125] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:40:0) after 1m0s
[20:45:09.148] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:40:0)
[20:45:09.148] Timer tick, asking Buildbucket for the build status
[20:45:09.566] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:09.566] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:41:0) after 1m0s
[20:46:09.612] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:41:0)
[20:46:09.612] Timer tick, asking Buildbucket for the build status
[20:46:10.003] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:10.003] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:42:0) after 1m0s
[20:47:10.064] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:42:0)
[20:47:10.064] Timer tick, asking Buildbucket for the build status
[20:47:10.168] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:10.168] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:43:0) after 1m0s
[20:48:10.201] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:43:0)
[20:48:10.201] Timer tick, asking Buildbucket for the build status
[20:48:10.464] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:10.464] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:44:0) after 1m0s
[20:49:10.466] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:44:0)
[20:49:10.466] Timer tick, asking Buildbucket for the build status
[20:49:10.543] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:10.543] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:45:0) after 1m0s
[20:50:10.584] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:45:0)
[20:50:10.584] Timer tick, asking Buildbucket for the build status
[20:50:10.673] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:10.673] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:46:0) after 1m0s
[20:51:10.697] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:46:0)
[20:51:10.697] Timer tick, asking Buildbucket for the build status
[20:51:10.846] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:10.846] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:47:0) after 1m0s
[20:52:10.886] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:47:0)
[20:52:10.886] Timer tick, asking Buildbucket for the build status
[20:52:11.092] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:11.092] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:48:0) after 1m0s
[20:53:11.127] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:48:0)
[20:53:11.127] Timer tick, asking Buildbucket for the build status
[20:53:11.280] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:11.280] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:49:0) after 1m0s
[20:54:11.365] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:49:0)
[20:54:11.365] Timer tick, asking Buildbucket for the build status
[20:54:11.460] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:11.460] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:50:0) after 1m0s
[20:55:11.518] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:50:0)
[20:55:11.518] Timer tick, asking Buildbucket for the build status
[20:55:11.575] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:11.575] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:51:0) after 1m0s
[20:56:11.673] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:51:0)
[20:56:11.673] Timer tick, asking Buildbucket for the build status
[20:56:11.755] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:11.755] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:52:0) after 1m0s
[20:57:11.816] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:52:0)
[20:57:11.816] Timer tick, asking Buildbucket for the build status
[20:57:11.883] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:11.883] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:53:0) after 1m0s
[20:58:11.930] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:53:0)
[20:58:11.930] Timer tick, asking Buildbucket for the build status
[20:58:12.063] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:12.063] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:54:0) after 1m0s
[20:59:12.199] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:54:0)
[20:59:12.199] Timer tick, asking Buildbucket for the build status
[20:59:12.392] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:12.393] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:55:0) after 1m0s
[21:00:12.436] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:55:0)
[21:00:12.436] Timer tick, asking Buildbucket for the build status
[21:00:12.723] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:12.723] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:56:0) after 1m0s
[21:01:12.861] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:56:0)
[21:01:12.861] Timer tick, asking Buildbucket for the build status
[21:01:13.005] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:13.005] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:57:0) after 1m0s
[21:02:13.284] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:57:0)
[21:02:13.284] Timer tick, asking Buildbucket for the build status
[21:02:13.595] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:13.595] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:58:0) after 1m0s
[21:03:13.771] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:58:0)
[21:03:13.771] Timer tick, asking Buildbucket for the build status
[21:03:13.960] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:13.960] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:59:0) after 1m0s
[21:04:14.154] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:59:0)
[21:04:14.154] Timer tick, asking Buildbucket for the build status
[21:04:14.369] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:14.369] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:60:0) after 1m0s
[21:05:14.443] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:60:0)
[21:05:14.443] Timer tick, asking Buildbucket for the build status
[21:05:14.517] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:14.517] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:61:0) after 1m0s
[21:06:14.674] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:61:0)
[21:06:14.674] Timer tick, asking Buildbucket for the build status
[21:06:14.737] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:14.737] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:62:0) after 1m0s
[21:07:14.879] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:62:0)
[21:07:14.879] Timer tick, asking Buildbucket for the build status
[21:07:14.959] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:14.959] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:63:0) after 1m0s
[21:08:15.174] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:63:0)
[21:08:15.174] Timer tick, asking Buildbucket for the build status
[21:08:15.726] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:15.726] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:64:0) after 1m0s
[21:09:15.807] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:64:0)
[21:09:15.807] Timer tick, asking Buildbucket for the build status
[21:09:16.053] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:16.053] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:65:0) after 1m0s
[21:10:16.150] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:65:0)
[21:10:16.150] Timer tick, asking Buildbucket for the build status
[21:10:16.273] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:16.273] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:66:0) after 1m0s
[21:11:16.268] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:66:0)
[21:11:16.268] Timer tick, asking Buildbucket for the build status
[21:11:16.365] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:16.365] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:67:0) after 1m0s
[21:12:16.475] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:67:0)
[21:12:16.475] Timer tick, asking Buildbucket for the build status
[21:12:16.544] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:16.544] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:68:0) after 1m0s
[21:13:16.628] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:68:0)
[21:13:16.628] Timer tick, asking Buildbucket for the build status
[21:13:17.153] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:17.153] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:69:0) after 1m0s
[21:14:17.148] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:69:0)
[21:14:17.148] Timer tick, asking Buildbucket for the build status
[21:14:17.212] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:17.212] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:70:0) after 1m0s
[21:15:17.272] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:70:0)
[21:15:17.272] Timer tick, asking Buildbucket for the build status
[21:15:17.341] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:17.341] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:71:0) after 1m0s
[21:16:17.367] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:71:0)
[21:16:17.367] Timer tick, asking Buildbucket for the build status
[21:16:17.470] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:17.470] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:72:0) after 1m0s
[21:17:17.505] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:72:0)
[21:17:17.505] Timer tick, asking Buildbucket for the build status
[21:17:17.584] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:17.584] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:73:0) after 1m0s
[21:18:17.664] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:73:0)
[21:18:17.664] Timer tick, asking Buildbucket for the build status
[21:18:17.865] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:17.865] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:74:0) after 1m0s
[21:19:17.973] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:74:0)
[21:19:17.974] Timer tick, asking Buildbucket for the build status
[21:19:18.154] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:18.154] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:75:0) after 1m0s
[21:20:18.232] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:75:0)
[21:20:18.232] Timer tick, asking Buildbucket for the build status
[21:20:18.294] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:18.294] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:76:0) after 1m0s
[21:21:18.348] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:76:0)
[21:21:18.348] Timer tick, asking Buildbucket for the build status
[21:21:18.419] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:18.419] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:77:0) after 1m0s
[21:22:18.548] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:77:0)
[21:22:18.548] Timer tick, asking Buildbucket for the build status
[21:22:18.602] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:18.602] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:78:0) after 1m0s
[21:23:18.774] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:78:0)
[21:23:18.774] Timer tick, asking Buildbucket for the build status
[21:23:19.107] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:19.107] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:79:0) after 1m0s
[21:24:19.311] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:79:0)
[21:24:19.311] Timer tick, asking Buildbucket for the build status
[21:24:19.527] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:19.527] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:80:0) after 1m0s
[21:25:19.630] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:80:0)
[21:25:19.630] Timer tick, asking Buildbucket for the build status
[21:25:20.123] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:20.123] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:81:0) after 1m0s
[21:26:20.169] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:81:0)
[21:26:20.169] Timer tick, asking Buildbucket for the build status
[21:26:20.607] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:20.607] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:82:0) after 1m0s
[21:27:20.668] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:82:0)
[21:27:20.668] Timer tick, asking Buildbucket for the build status
[21:27:20.742] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:20.742] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:83:0) after 1m0s
[21:28:20.780] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:83:0)
[21:28:20.780] Timer tick, asking Buildbucket for the build status
[21:28:20.904] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:20.904] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:84:0) after 1m0s
[21:29:20.929] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:84:0)
[21:29:20.929] Timer tick, asking Buildbucket for the build status
[21:29:21.179] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:21.179] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:85:0) after 1m0s
[21:30:21.194] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:85:0)
[21:30:21.194] Timer tick, asking Buildbucket for the build status
[21:30:21.253] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:21.253] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:86:0) after 1m0s
[21:31:21.308] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:86:0)
[21:31:21.308] Timer tick, asking Buildbucket for the build status
[21:31:21.395] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:21.395] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:87:0) after 1m0s
[21:32:21.548] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:87:0)
[21:32:21.549] Timer tick, asking Buildbucket for the build status
[21:32:22.975] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:22.975] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:88:0) after 1m0s
[21:33:23.022] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:88:0)
[21:33:23.022] Timer tick, asking Buildbucket for the build status
[21:33:23.283] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:23.283] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:89:0) after 1m0s
[21:34:23.294] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:89:0)
[21:34:23.294] Timer tick, asking Buildbucket for the build status
[21:34:23.419] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:23.419] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:90:0) after 1m0s
[21:35:23.418] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:90:0)
[21:35:23.418] Timer tick, asking Buildbucket for the build status
[21:35:23.485] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:23.485] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:91:0) after 1m0s
[21:36:23.671] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:91:0)
[21:36:23.671] Timer tick, asking Buildbucket for the build status
[21:36:23.763] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:23.763] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:92:0) after 1m0s
[21:37:23.912] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:92:0)
[21:37:23.912] Timer tick, asking Buildbucket for the build status
[21:37:23.991] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:23.991] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:93:0) after 1m0s
[21:38:24.112] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:93:0)
[21:38:24.112] Timer tick, asking Buildbucket for the build status
[21:38:24.244] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:24.244] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:94:0) after 1m0s
[21:39:24.292] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:94:0)
[21:39:24.292] Timer tick, asking Buildbucket for the build status
[21:39:24.376] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:24.376] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:95:0) after 1m0s
[21:40:24.407] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:95:0)
[21:40:24.407] Timer tick, asking Buildbucket for the build status
[21:40:24.473] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:24.473] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:96:0) after 1m0s
[21:41:24.588] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:96:0)
[21:41:24.588] Timer tick, asking Buildbucket for the build status
[21:41:24.869] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:24.869] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:97:0) after 1m0s
[21:42:24.943] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:97:0)
[21:42:24.943] Timer tick, asking Buildbucket for the build status
[21:42:25.136] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:25.136] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:98:0) after 1m0s
[21:43:25.204] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:98:0)
[21:43:25.204] Timer tick, asking Buildbucket for the build status
[21:43:25.338] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:25.338] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:99:0) after 1m0s
[21:44:25.403] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:99:0)
[21:44:25.403] Timer tick, asking Buildbucket for the build status
[21:44:25.487] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:25.487] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:100:0) after 1m0s
[21:45:25.633] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:100:0)
[21:45:25.633] Timer tick, asking Buildbucket for the build status
[21:45:25.696] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:25.696] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:101:0) after 1m0s
[21:46:25.787] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:101:0)
[21:46:25.787] Timer tick, asking Buildbucket for the build status
[21:46:26.777] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:26.777] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:102:0) after 1m0s
[21:47:26.911] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:102:0)
[21:47:26.911] Timer tick, asking Buildbucket for the build status
[21:47:27.078] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:27.078] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:103:0) after 1m0s
[21:48:27.123] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:103:0)
[21:48:27.123] Timer tick, asking Buildbucket for the build status
[21:48:27.798] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:27.798] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:104:0) after 1m0s
[21:49:27.983] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:104:0)
[21:49:27.984] Timer tick, asking Buildbucket for the build status
[21:49:28.047] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:28.047] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:105:0) after 1m0s
[21:50:28.078] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:105:0)
[21:50:28.078] Timer tick, asking Buildbucket for the build status
[21:50:28.392] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:28.392] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:106:0) after 1m0s
[21:51:28.417] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:106:0)
[21:51:28.417] Timer tick, asking Buildbucket for the build status
[21:51:28.498] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:28.498] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:107:0) after 1m0s
[21:52:29.573] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:107:0)
[21:52:29.573] Timer tick, asking Buildbucket for the build status
[21:52:29.641] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:29.641] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:108:0) after 1m0s
[21:53:29.933] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:108:0)
[21:53:29.933] Timer tick, asking Buildbucket for the build status
[21:53:30.046] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:30.047] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:109:0) after 1m0s
[21:54:31.951] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:109:0)
[21:54:31.951] Timer tick, asking Buildbucket for the build status
[21:54:32.021] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:32.021] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:110:0) after 1m0s
[21:55:32.051] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:110:0)
[21:55:32.051] Timer tick, asking Buildbucket for the build status
[21:55:32.286] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:32.286] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:111:0) after 1m0s
[21:56:32.380] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:111:0)
[21:56:32.380] Timer tick, asking Buildbucket for the build status
[21:56:32.457] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:32.457] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:112:0) after 1m0s
[21:57:32.500] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:112:0)
[21:57:32.500] Timer tick, asking Buildbucket for the build status
[21:57:32.558] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:32.558] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:113:0) after 1m0s
[21:58:32.611] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:113:0)
[21:58:32.611] Timer tick, asking Buildbucket for the build status
[21:58:32.733] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:32.733] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:114:0) after 1m0s
[21:59:32.750] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:114:0)
[21:59:32.750] Timer tick, asking Buildbucket for the build status
[21:59:32.849] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:32.849] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:115:0) after 1m0s
[22:00:32.990] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:115:0)
[22:00:32.990] Timer tick, asking Buildbucket for the build status
[22:00:33.129] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:33.129] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:116:0) after 1m0s
[22:01:33.161] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:116:0)
[22:01:33.161] Timer tick, asking Buildbucket for the build status
[22:01:33.227] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:33.227] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:117:0) after 1m0s
[22:02:33.325] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:117:0)
[22:02:33.325] Timer tick, asking Buildbucket for the build status
[22:02:33.399] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:33.399] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:118:0) after 1m0s
[22:03:33.507] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:118:0)
[22:03:33.507] Timer tick, asking Buildbucket for the build status
[22:03:33.708] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:33.709] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:119:0) after 1m0s
[22:04:33.800] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:119:0)
[22:04:33.800] Timer tick, asking Buildbucket for the build status
[22:04:33.936] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:33.936] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:120:0) after 1m0s
[22:05:33.948] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:120:0)
[22:05:33.948] Timer tick, asking Buildbucket for the build status
[22:05:34.187] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:34.187] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:121:0) after 1m0s
[22:06:34.243] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:121:0)
[22:06:34.243] Timer tick, asking Buildbucket for the build status
[22:06:34.402] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:34.402] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:122:0) after 1m0s
[22:07:34.483] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:122:0)
[22:07:34.483] Timer tick, asking Buildbucket for the build status
[22:07:34.688] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:34.688] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:123:0) after 1m0s
[22:08:34.752] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:123:0)
[22:08:34.752] Timer tick, asking Buildbucket for the build status
[22:08:34.876] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:34.876] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:124:0) after 1m0s
[22:09:34.909] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:124:0)
[22:09:34.909] Timer tick, asking Buildbucket for the build status
[22:09:34.971] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:34.971] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:125:0) after 1m0s
[22:10:35.082] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:125:0)
[22:10:35.082] Timer tick, asking Buildbucket for the build status
[22:10:35.152] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:35.152] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:126:0) after 1m0s
[22:11:35.277] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:126:0)
[22:11:35.277] Timer tick, asking Buildbucket for the build status
[22:11:35.349] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:35.349] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:127:0) after 1m0s
[22:12:35.397] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:127:0)
[22:12:35.397] Timer tick, asking Buildbucket for the build status
[22:12:35.467] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:35.467] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:128:0) after 1m0s
[22:13:35.463] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:128:0)
[22:13:35.463] Timer tick, asking Buildbucket for the build status
[22:13:35.569] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:35.569] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:129:0) after 1m0s
[22:14:35.563] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:129:0)
[22:14:35.563] Timer tick, asking Buildbucket for the build status
[22:14:35.625] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:35.625] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:130:0) after 1m0s
[22:15:35.734] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:130:0)
[22:15:35.734] Timer tick, asking Buildbucket for the build status
[22:15:35.802] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:35.802] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:131:0) after 1m0s
[22:16:35.838] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:131:0)
[22:16:35.838] Timer tick, asking Buildbucket for the build status
[22:16:35.921] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:35.921] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:132:0) after 1m0s
[22:17:35.950] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:132:0)
[22:17:35.950] Timer tick, asking Buildbucket for the build status
[22:17:36.013] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:36.013] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:133:0) after 1m0s
[22:18:36.095] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:133:0)
[22:18:36.095] Timer tick, asking Buildbucket for the build status
[22:18:36.555] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:36.555] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:134:0) after 1m0s
[22:19:36.572] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:134:0)
[22:19:36.572] Timer tick, asking Buildbucket for the build status
[22:19:36.829] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:36.829] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:135:0) after 1m0s
[22:20:36.857] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:135:0)
[22:20:36.857] Timer tick, asking Buildbucket for the build status
[22:20:37.000] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:37.000] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:136:0) after 1m0s
[22:21:37.114] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:136:0)
[22:21:37.114] Timer tick, asking Buildbucket for the build status
[22:21:37.408] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:37.408] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:137:0) after 1m0s
[22:22:37.446] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:137:0)
[22:22:37.446] Timer tick, asking Buildbucket for the build status
[22:22:37.510] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:37.510] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:138:0) after 1m0s
[22:23:37.597] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:138:0)
[22:23:37.597] Timer tick, asking Buildbucket for the build status
[22:23:38.429] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:38.429] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:139:0) after 1m0s
[22:24:38.484] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:139:0)
[22:24:38.484] Timer tick, asking Buildbucket for the build status
[22:24:38.780] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:38.780] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:140:0) after 1m0s
[22:25:38.835] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:140:0)
[22:25:38.835] Timer tick, asking Buildbucket for the build status
[22:25:39.001] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:39.001] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:141:0) after 1m0s
[22:26:39.069] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:141:0)
[22:26:39.069] Timer tick, asking Buildbucket for the build status
[22:26:39.134] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:39.134] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:142:0) after 1m0s
[22:27:39.277] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:142:0)
[22:27:39.277] Timer tick, asking Buildbucket for the build status
[22:27:39.502] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:39.502] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:143:0) after 1m0s
[22:28:39.599] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:143:0)
[22:28:39.599] Timer tick, asking Buildbucket for the build status
[22:28:39.695] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:39.695] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:144:0) after 1m0s
[22:29:39.784] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:144:0)
[22:29:39.784] Timer tick, asking Buildbucket for the build status
[22:29:39.839] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:39.839] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:145:0) after 1m0s
[22:30:39.900] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:145:0)
[22:30:39.900] Timer tick, asking Buildbucket for the build status
[22:30:40.103] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:40.103] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:146:0) after 1m0s
[22:31:40.184] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:146:0)
[22:31:40.184] Timer tick, asking Buildbucket for the build status
[22:31:40.322] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:40.322] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:147:0) after 1m0s
[22:32:40.360] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:147:0)
[22:32:40.360] Timer tick, asking Buildbucket for the build status
[22:32:40.522] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:40.522] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:148:0) after 1m0s
[22:33:40.571] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:148:0)
[22:33:40.571] Timer tick, asking Buildbucket for the build status
[22:33:40.670] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:40.670] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:149:0) after 1m0s
[22:34:40.728] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:149:0)
[22:34:40.729] Timer tick, asking Buildbucket for the build status
[22:34:40.819] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:40.819] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:150:0) after 1m0s
[22:35:40.881] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:150:0)
[22:35:40.881] Timer tick, asking Buildbucket for the build status
[22:35:41.076] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:41.076] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:151:0) after 1m0s
[22:36:41.059] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:151:0)
[22:36:41.059] Timer tick, asking Buildbucket for the build status
[22:36:41.129] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:41.129] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:152:0) after 1m0s
[22:37:41.239] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:152:0)
[22:37:41.239] Timer tick, asking Buildbucket for the build status
[22:37:41.300] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:41.300] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:153:0) after 1m0s
[22:38:41.340] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:153:0)
[22:38:41.340] Timer tick, asking Buildbucket for the build status
[22:38:41.479] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:41.479] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:154:0) after 1m0s
[22:39:41.726] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:154:0)
[22:39:41.726] Timer tick, asking Buildbucket for the build status
[22:39:41.808] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:41.808] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:155:0) after 1m0s
[22:40:41.939] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:155:0)
[22:40:41.939] Timer tick, asking Buildbucket for the build status
[22:40:41.999] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:41.999] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:156:0) after 1m0s
[22:41:42.058] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:156:0)
[22:41:42.058] Timer tick, asking Buildbucket for the build status
[22:41:42.260] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:42.260] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:157:0) after 1m0s
[22:42:42.307] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:157:0)
[22:42:42.307] Timer tick, asking Buildbucket for the build status
[22:42:42.378] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:42.378] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:158:0) after 1m0s
[22:43:42.388] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:158:0)
[22:43:42.388] Timer tick, asking Buildbucket for the build status
[22:43:42.510] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:42.510] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:159:0) after 1m0s
[22:44:42.563] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:159:0)
[22:44:42.563] Timer tick, asking Buildbucket for the build status
[22:44:44.974] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:44.974] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:160:0) after 1m0s
[22:45:45.046] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:160:0)
[22:45:45.046] Timer tick, asking Buildbucket for the build status
[22:45:45.124] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:45.124] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:161:0) after 1m0s
[22:46:45.155] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:161:0)
[22:46:45.155] Timer tick, asking Buildbucket for the build status
[22:46:45.305] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:45.305] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:162:0) after 1m0s
[22:47:45.356] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:162:0)
[22:47:45.356] Timer tick, asking Buildbucket for the build status
[22:47:45.420] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:45.420] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:163:0) after 1m0s
[22:48:45.506] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:163:0)
[22:48:45.506] Timer tick, asking Buildbucket for the build status
[22:48:45.661] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:45.661] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:164:0) after 1m0s
[22:49:45.694] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:164:0)
[22:49:45.694] Timer tick, asking Buildbucket for the build status
[22:49:45.763] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:45.763] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:165:0) after 1m0s
[22:50:45.790] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:165:0)
[22:50:45.790] Timer tick, asking Buildbucket for the build status
[22:50:45.863] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:45.863] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:166:0) after 1m0s
[22:51:45.907] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:166:0)
[22:51:45.907] Timer tick, asking Buildbucket for the build status
[22:51:46.031] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:46.031] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:167:0) after 1m0s
[22:52:46.080] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:167:0)
[22:52:46.080] Timer tick, asking Buildbucket for the build status
[22:52:46.147] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:46.147] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:168:0) after 1m0s
[22:53:46.177] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:168:0)
[22:53:46.177] Timer tick, asking Buildbucket for the build status
[22:53:46.482] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:46.482] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:169:0) after 1m0s
[22:54:46.585] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:169:0)
[22:54:46.585] Timer tick, asking Buildbucket for the build status
[22:54:46.778] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:46.778] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:170:0) after 1m0s
[22:55:46.996] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:170:0)
[22:55:46.996] Timer tick, asking Buildbucket for the build status
[22:55:47.226] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:47.226] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:171:0) after 1m0s
[22:56:47.567] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:171:0)
[22:56:47.567] Timer tick, asking Buildbucket for the build status
[22:56:47.630] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:47.630] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:172:0) after 1m0s
[22:57:47.709] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:172:0)
[22:57:47.709] Timer tick, asking Buildbucket for the build status
[22:57:47.787] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:47.787] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:173:0) after 1m0s
[22:58:48.045] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:173:0)
[22:58:48.045] Timer tick, asking Buildbucket for the build status
[22:58:48.154] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:48.154] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:174:0) after 1m0s
[22:59:48.186] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:174:0)
[22:59:48.186] Timer tick, asking Buildbucket for the build status
[22:59:48.262] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:48.262] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:175:0) after 1m0s
[23:00:48.328] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:175:0)
[23:00:48.328] Timer tick, asking Buildbucket for the build status
[23:00:48.400] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:48.400] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:176:0) after 1m0s
[23:01:48.413] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:176:0)
[23:01:48.413] Timer tick, asking Buildbucket for the build status
[23:01:48.713] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:48.713] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:177:0) after 1m0s
[23:02:48.815] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:177:0)
[23:02:48.815] Timer tick, asking Buildbucket for the build status
[23:02:48.878] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:48.878] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:178:0) after 1m0s
[23:03:49.069] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:178:0)
[23:03:49.069] Timer tick, asking Buildbucket for the build status
[23:03:49.406] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:49.406] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:179:0) after 1m0s
[23:04:49.525] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:179:0)
[23:04:49.525] Timer tick, asking Buildbucket for the build status
[23:04:49.613] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:49.613] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:180:0) after 1m0s
[23:05:49.775] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:180:0)
[23:05:49.775] Timer tick, asking Buildbucket for the build status
[23:05:49.840] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:49.840] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:181:0) after 1m0s
[23:06:49.946] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:181:0)
[23:06:49.946] Timer tick, asking Buildbucket for the build status
[23:06:50.034] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:50.034] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:182:0) after 1m0s
[23:07:50.114] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:182:0)
[23:07:50.114] Timer tick, asking Buildbucket for the build status
[23:07:54.686] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:54.686] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:183:0) after 1m0s
[23:08:54.730] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:183:0)
[23:08:54.730] Timer tick, asking Buildbucket for the build status
[23:08:55.014] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:55.015] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:184:0) after 1m0s
[23:09:55.040] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:184:0)
[23:09:55.042] Timer tick, asking Buildbucket for the build status
[23:09:55.120] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:55.120] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:185:0) after 1m0s
[23:10:55.164] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:185:0)
[23:10:55.164] Timer tick, asking Buildbucket for the build status
[23:10:55.243] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:55.243] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:186:0) after 1m0s
[23:11:55.277] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:186:0)
[23:11:55.277] Timer tick, asking Buildbucket for the build status
[23:11:55.479] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:55.479] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:187:0) after 1m0s
[23:12:55.619] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:187:0)
[23:12:55.619] Timer tick, asking Buildbucket for the build status
[23:12:55.710] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:55.710] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:188:0) after 1m0s
[23:13:55.792] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:188:0)
[23:13:55.792] Timer tick, asking Buildbucket for the build status
[23:13:56.208] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:56.208] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:189:0) after 1m0s
[23:14:56.275] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:189:0)
[23:14:56.275] Timer tick, asking Buildbucket for the build status
[23:14:56.412] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:56.412] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:190:0) after 1m0s
[23:15:56.499] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:190:0)
[23:15:56.499] Timer tick, asking Buildbucket for the build status
[23:15:56.568] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:56.568] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:191:0) after 1m0s
[23:16:56.644] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:191:0)
[23:16:56.644] Timer tick, asking Buildbucket for the build status
[23:16:56.708] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:56.708] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:192:0) after 1m0s
[23:17:56.796] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:192:0)
[23:17:56.796] Timer tick, asking Buildbucket for the build status
[23:17:56.911] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:56.911] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:193:0) after 1m0s
[23:18:56.913] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:193:0)
[23:18:56.913] Timer tick, asking Buildbucket for the build status
[23:18:57.887] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:57.887] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:194:0) after 1m0s
[23:19:57.965] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:194:0)
[23:19:57.965] Timer tick, asking Buildbucket for the build status
[23:19:58.045] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:58.045] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:195:0) after 1m0s
[23:20:58.093] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:195:0)
[23:20:58.093] Timer tick, asking Buildbucket for the build status
[23:20:58.174] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:58.174] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:196:0) after 1m0s
[23:21:58.332] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:196:0)
[23:21:58.332] Timer tick, asking Buildbucket for the build status
[23:21:58.388] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:58.388] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:197:0) after 1m0s
[23:22:58.455] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:197:0)
[23:22:58.455] Timer tick, asking Buildbucket for the build status
[23:22:58.517] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:58.517] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:198:0) after 1m0s
[23:23:58.577] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:198:0)
[23:23:58.577] Timer tick, asking Buildbucket for the build status
[23:23:59.821] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:59.821] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:199:0) after 1m0s
[23:24:59.861] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:199:0)
[23:24:59.861] Timer tick, asking Buildbucket for the build status
[23:24:59.924] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:59.924] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:200:0) after 1m0s
[23:26:00.006] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:200:0)
[23:26:00.006] Timer tick, asking Buildbucket for the build status
[23:26:00.484] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:00.484] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:201:0) after 1m0s
[23:27:00.546] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:201:0)
[23:27:00.546] Timer tick, asking Buildbucket for the build status
[23:27:00.631] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:00.631] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:202:0) after 1m0s
[23:28:00.780] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:202:0)
[23:28:00.780] Timer tick, asking Buildbucket for the build status
[23:28:00.840] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:00.840] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:203:0) after 1m0s
[23:29:02.108] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:203:0)
[23:29:02.108] Timer tick, asking Buildbucket for the build status
[23:29:02.282] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:02.282] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:204:0) after 1m0s
[23:30:02.318] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:204:0)
[23:30:02.318] Timer tick, asking Buildbucket for the build status
[23:30:02.775] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:02.775] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:205:0) after 1m0s
[23:31:03.251] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:205:0)
[23:31:03.251] Timer tick, asking Buildbucket for the build status
[23:31:03.585] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:03.585] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:206:0) after 1m0s
[23:32:03.722] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:206:0)
[23:32:03.722] Timer tick, asking Buildbucket for the build status
[23:32:03.810] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:03.810] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:207:0) after 1m0s
[23:33:03.858] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:207:0)
[23:33:03.858] Timer tick, asking Buildbucket for the build status
[23:33:03.966] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:03.966] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:208:0) after 1m0s
[23:34:04.012] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:208:0)
[23:34:04.012] Timer tick, asking Buildbucket for the build status
[23:34:04.133] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:04.133] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:209:0) after 1m0s
[23:35:04.144] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:209:0)
[23:35:04.144] Timer tick, asking Buildbucket for the build status
[23:35:04.226] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:04.226] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:210:0) after 1m0s
[23:36:04.297] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:210:0)
[23:36:04.297] Timer tick, asking Buildbucket for the build status
[23:36:04.363] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:04.363] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:211:0) after 1m0s
[23:37:04.423] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:211:0)
[23:37:04.423] Timer tick, asking Buildbucket for the build status
[23:37:04.519] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:04.519] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:212:0) after 1m0s
[23:38:04.683] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:212:0)
[23:38:04.683] Timer tick, asking Buildbucket for the build status
[23:38:04.746] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:04.746] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:213:0) after 1m0s
[23:39:04.783] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:213:0)
[23:39:04.783] Timer tick, asking Buildbucket for the build status
[23:39:04.907] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:04.907] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:214:0) after 1m0s
[23:40:05.014] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:214:0)
[23:40:05.014] Timer tick, asking Buildbucket for the build status
[23:40:05.266] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:05.266] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:215:0) after 1m0s
[23:41:05.360] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:215:0)
[23:41:05.360] Timer tick, asking Buildbucket for the build status
[23:41:05.615] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:05.615] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:216:0) after 1m0s
[23:42:05.648] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:216:0)
[23:42:05.648] Timer tick, asking Buildbucket for the build status
[23:42:05.996] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:05.996] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:217:0) after 1m0s
[23:43:06.140] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:217:0)
[23:43:06.140] Timer tick, asking Buildbucket for the build status
[23:43:06.422] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:06.422] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:218:0) after 1m0s
[23:44:06.462] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:218:0)
[23:44:06.462] Timer tick, asking Buildbucket for the build status
[23:44:06.782] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:06.782] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:219:0) after 1m0s
[23:45:06.824] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:219:0)
[23:45:06.824] Timer tick, asking Buildbucket for the build status
[23:45:06.936] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:06.936] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:220:0) after 1m0s
[23:46:06.975] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:220:0)
[23:46:06.975] Timer tick, asking Buildbucket for the build status
[23:46:07.049] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:07.049] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:221:0) after 1m0s
[23:47:07.273] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:221:0)
[23:47:07.273] Timer tick, asking Buildbucket for the build status
[23:47:07.359] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:07.360] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:222:0) after 1m0s
[23:48:07.501] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:222:0)
[23:48:07.501] Timer tick, asking Buildbucket for the build status
[23:48:07.561] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:07.561] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:223:0) after 1m0s
[23:49:07.672] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:223:0)
[23:49:07.672] Timer tick, asking Buildbucket for the build status
[23:49:08.217] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:08.217] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:224:0) after 1m0s
[23:50:08.269] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:224:0)
[23:50:08.269] Timer tick, asking Buildbucket for the build status
[23:50:08.334] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:08.334] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:225:0) after 1m0s
[23:51:08.364] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:225:0)
[23:51:08.364] Timer tick, asking Buildbucket for the build status
[23:51:08.437] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:08.437] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:226:0) after 1m0s
[23:52:08.427] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:226:0)
[23:52:08.427] Timer tick, asking Buildbucket for the build status
[23:52:08.761] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:08.761] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:227:0) after 1m0s
[23:53:08.804] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:227:0)
[23:53:08.804] Timer tick, asking Buildbucket for the build status
[23:53:08.868] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:08.868] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:228:0) after 1m0s
[23:54:09.004] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:228:0)
[23:54:09.004] Timer tick, asking Buildbucket for the build status
[23:54:09.313] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:09.313] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:229:0) after 1m0s
[23:55:09.366] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:229:0)
[23:55:09.366] Timer tick, asking Buildbucket for the build status
[23:55:09.996] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:09.996] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:230:0) after 1m0s
[23:56:10.071] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:230:0)
[23:56:10.071] Timer tick, asking Buildbucket for the build status
[23:56:10.139] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:10.139] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:231:0) after 1m0s
[23:57:10.148] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:231:0)
[23:57:10.148] Timer tick, asking Buildbucket for the build status
[23:57:10.210] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:10.210] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:232:0) after 1m0s
[23:58:10.258] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:232:0)
[23:58:10.258] Timer tick, asking Buildbucket for the build status
[23:58:10.319] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:10.319] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:233:0) after 1m0s
[23:59:10.355] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:233:0)
[23:59:10.355] Timer tick, asking Buildbucket for the build status
[23:59:11.582] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:11.582] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:234:0) after 1m0s
[00:00:11.628] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:234:0)
[00:00:11.628] Timer tick, asking Buildbucket for the build status
[00:00:11.741] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:11.741] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:235:0) after 1m0s
[00:01:11.871] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:235:0)
[00:01:11.871] Timer tick, asking Buildbucket for the build status
[00:01:12.045] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:12.045] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:236:0) after 1m0s
[00:02:12.186] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:236:0)
[00:02:12.186] Timer tick, asking Buildbucket for the build status
[00:02:12.304] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:12.304] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:237:0) after 1m0s
[00:03:12.384] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:237:0)
[00:03:12.384] Timer tick, asking Buildbucket for the build status
[00:03:12.453] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:12.453] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:238:0) after 1m0s
[00:04:12.556] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:238:0)
[00:04:12.556] Timer tick, asking Buildbucket for the build status
[00:04:12.672] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:12.672] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:239:0) after 1m0s
[00:05:12.727] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:239:0)
[00:05:12.727] Timer tick, asking Buildbucket for the build status
[00:05:12.910] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:12.911] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:240:0) after 1m0s
[00:06:12.972] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:240:0)
[00:06:12.972] Timer tick, asking Buildbucket for the build status
[00:06:13.046] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:13.046] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:241:0) after 1m0s
[00:07:13.296] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:241:0)
[00:07:13.296] Timer tick, asking Buildbucket for the build status
[00:07:13.693] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:13.693] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:242:0) after 1m0s
[00:08:13.734] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:242:0)
[00:08:13.734] Timer tick, asking Buildbucket for the build status
[00:08:13.863] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:13.863] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:243:0) after 1m0s
[00:09:13.896] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:243:0)
[00:09:13.896] Timer tick, asking Buildbucket for the build status
[00:09:13.986] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:13.986] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:244:0) after 1m0s
[00:10:14.056] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:244:0)
[00:10:14.056] Timer tick, asking Buildbucket for the build status
[00:10:14.125] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:14.125] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:245:0) after 1m0s
[00:11:14.213] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:245:0)
[00:11:14.213] Timer tick, asking Buildbucket for the build status
[00:11:14.280] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:14.280] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:246:0) after 1m0s
[00:12:14.341] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:246:0)
[00:12:14.341] Timer tick, asking Buildbucket for the build status
[00:12:14.415] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:14.415] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:247:0) after 1m0s
[00:13:14.540] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:247:0)
[00:13:14.541] Timer tick, asking Buildbucket for the build status
[00:13:14.694] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:14.694] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:248:0) after 1m0s
[00:14:14.859] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:248:0)
[00:14:14.859] Timer tick, asking Buildbucket for the build status
[00:14:14.929] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:14.929] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:249:0) after 1m0s
[00:15:14.996] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:249:0)
[00:15:14.996] Timer tick, asking Buildbucket for the build status
[00:15:15.063] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:15.063] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:250:0) after 1m0s
[00:16:15.300] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:250:0)
[00:16:15.300] Timer tick, asking Buildbucket for the build status
[00:16:15.427] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:15.427] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:251:0) after 1m0s
[00:17:15.714] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:251:0)
[00:17:15.714] Timer tick, asking Buildbucket for the build status
[00:17:15.924] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:15.924] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:252:0) after 1m0s
[00:18:16.199] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:252:0)
[00:18:16.199] Timer tick, asking Buildbucket for the build status
[00:18:16.323] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:16.323] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:253:0) after 1m0s
[00:19:16.707] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:253:0)
[00:19:16.707] Timer tick, asking Buildbucket for the build status
[00:19:16.768] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:16.768] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:254:0) after 1m0s
[00:20:16.894] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:254:0)
[00:20:16.894] Timer tick, asking Buildbucket for the build status
[00:20:16.953] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:16.953] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:255:0) after 1m0s
[00:21:17.047] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:255:0)
[00:21:17.047] Timer tick, asking Buildbucket for the build status
[00:21:17.497] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:17.497] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:256:0) after 1m0s
[00:22:17.692] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:256:0)
[00:22:17.692] Timer tick, asking Buildbucket for the build status
[00:22:17.789] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:17.789] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:257:0) after 1m0s
[00:23:18.002] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:257:0)
[00:23:18.002] Timer tick, asking Buildbucket for the build status
[00:23:18.112] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:18.112] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:258:0) after 1m0s
[00:24:18.269] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:258:0)
[00:24:18.269] Timer tick, asking Buildbucket for the build status
[00:24:18.417] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:18.417] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:259:0) after 1m0s
[00:25:18.570] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:259:0)
[00:25:18.570] Timer tick, asking Buildbucket for the build status
[00:25:18.688] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:18.688] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:260:0) after 1m0s
[00:26:18.731] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:260:0)
[00:26:18.731] Timer tick, asking Buildbucket for the build status
[00:26:18.800] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:18.800] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:261:0) after 1m0s
[00:27:18.841] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:261:0)
[00:27:18.841] Timer tick, asking Buildbucket for the build status
[00:27:18.907] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:18.907] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:262:0) after 1m0s
[00:28:19.054] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:262:0)
[00:28:19.054] Timer tick, asking Buildbucket for the build status
[00:28:19.383] Build 8865981678013049600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:19.383] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031411740171253072:263:0) after 1m0s
[00:28:43.741] Received PubSub notification, asking Buildbucket for the build status
[00:28:43.806] Build 8865981678013049600: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:28:43.806] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1603153722945895",
"created_by": "project:chromium",
"created_ts": "1603138006158695",
"id": "8865981678013049600",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"80fe8a6458cb02dfd1c96cf976f2d288d9d0b71d\"}}",
"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\": \"80fe8a6458cb02dfd1c96cf976f2d288d9d0b71d\", \"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-1dls\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 855, \"got_angle_revision\": \"6d3d381e725125d6adb0f4a571426e3cfc6ab5a5\", \"got_dawn_revision\": \"aff4c0366314c445dda2537a2f27c8c60ddf51da\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"80fe8a6458cb02dfd1c96cf976f2d288d9d0b71d\", \"got_revision_cp\": \"refs/heads/master@{#818602}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"df17a76102dfabb3f1bd6e51449cece9f77b45e3\", \"got_v8_revision\": \"375e574dc6b0b5ccacbb4ab9bb5b48ca5531fdf7\", \"got_v8_revision_cp\": \"refs/heads/8.8.130@{#1}\", \"got_webrtc_revision\": \"d40c764ba81e24883b8c79ffa257c1eacab50fc7\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32440}\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"80fe8a6458cb02dfd1c96cf976f2d288d9d0b71d\"}, \"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-1dls\"], \"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\": [\"5601-97d7e7d\"], \"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": "1603138076280623",
"status": "COMPLETED",
"status_changed_ts": "1603153723405928",
"tags": [
"build_address:luci.chromium.ci/win-official/855",
"builder:win-official",
"buildset:commit/git/80fe8a6458cb02dfd1c96cf976f2d288d9d0b71d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/80fe8a6458cb02dfd1c96cf976f2d288d9d0b71d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031411740171253072",
"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/8865981678013049600/+/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:4f5b4ad94aaf4b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1603153723410709",
"url": "https://ci.chromium.org/b/8865981678013049600",
"utcnow_ts": "1603153723796227"
}
}
[00:28:43.806] Invocation finished in 4h21m59.089808191s with status SUCCEEDED