[04:41:56.813] New invocation is queued and will start shortly
[04:41:59.410] Starting the invocation (attempt 1)
[04:41:59.469] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:41:59.469] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:41:59.469] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9026668284251458992",
"parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"e0d412d8e2cb7bc7f86b8339cf387b734be15ed8\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-official",
"scheduler_invocation_id:9026668284251458992",
"scheduler_job_id:chromium/win-official",
"user_agent:luci-scheduler",
"buildset:commit/git/e0d412d8e2cb7bc7f86b8339cf387b734be15ed8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e0d412d8e2cb7bc7f86b8339cf387b734be15ed8",
"gitiles_ref:refs/heads/master"
]
}
[04:42:00.951] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1607661719685011",
"id": "8861238220578059728",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e0d412d8e2cb7bc7f86b8339cf387b734be15ed8\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1607661720471424",
"tags": [
"build_address:luci.chromium.ci/win-official/1151",
"builder:win-official",
"buildset:commit/git/e0d412d8e2cb7bc7f86b8339cf387b734be15ed8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e0d412d8e2cb7bc7f86b8339cf387b734be15ed8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026668284251458992",
"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/8861238220578059728/+/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": "1607661720471577",
"url": "https://ci.chromium.org/b/8861238220578059728",
"utcnow_ts": "1607661720920139"
}
}
[04:42:00.951] Task URL: https://ci.chromium.org/b/8861238220578059728
[04:42:00.951] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:2:0) after 1m0s
[04:42:30.053] Received PubSub notification, asking Buildbucket for the build status
[04:42:30.236] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:01.083] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:2:0)
[04:43:01.083] Timer tick, asking Buildbucket for the build status
[04:43:01.153] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:01.153] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:4:0) after 1m0s
[04:44:01.209] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:4:0)
[04:44:01.209] Timer tick, asking Buildbucket for the build status
[04:44:01.356] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:01.357] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:5:0) after 1m0s
[04:45:01.327] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:5:0)
[04:45:01.327] Timer tick, asking Buildbucket for the build status
[04:45:01.402] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:01.402] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:6:0) after 1m0s
[04:46:01.461] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:6:0)
[04:46:01.461] Timer tick, asking Buildbucket for the build status
[04:46:01.550] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:01.550] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:7:0) after 1m0s
[04:47:01.581] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:7:0)
[04:47:01.581] Timer tick, asking Buildbucket for the build status
[04:47:01.749] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:01.749] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:8:0) after 1m0s
[04:48:01.791] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:8:0)
[04:48:01.791] Timer tick, asking Buildbucket for the build status
[04:48:01.895] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:01.895] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:9:0) after 1m0s
[04:49:01.970] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:9:0)
[04:49:01.970] Timer tick, asking Buildbucket for the build status
[04:49:02.073] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:02.073] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:10:0) after 1m0s
[04:50:02.099] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:10:0)
[04:50:02.099] Timer tick, asking Buildbucket for the build status
[04:50:02.186] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:02.187] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:11:0) after 1m0s
[04:51:02.242] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:11:0)
[04:51:02.242] Timer tick, asking Buildbucket for the build status
[04:51:02.320] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:02.320] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:12:0) after 1m0s
[04:52:02.341] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:12:0)
[04:52:02.341] Timer tick, asking Buildbucket for the build status
[04:52:02.485] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:02.485] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:13:0) after 1m0s
[04:53:02.518] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:13:0)
[04:53:02.518] Timer tick, asking Buildbucket for the build status
[04:53:02.835] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:02.836] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:14:0) after 1m0s
[04:54:02.877] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:14:0)
[04:54:02.877] Timer tick, asking Buildbucket for the build status
[04:54:03.026] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:03.026] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:15:0) after 1m0s
[04:55:03.069] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:15:0)
[04:55:03.069] Timer tick, asking Buildbucket for the build status
[04:55:03.162] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:03.162] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:16:0) after 1m0s
[04:56:03.191] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:16:0)
[04:56:03.191] Timer tick, asking Buildbucket for the build status
[04:56:03.331] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:03.331] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:17:0) after 1m0s
[04:57:03.387] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:17:0)
[04:57:03.387] Timer tick, asking Buildbucket for the build status
[04:57:03.634] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:03.634] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:18:0) after 1m0s
[04:58:03.673] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:18:0)
[04:58:03.673] Timer tick, asking Buildbucket for the build status
[04:58:03.825] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:03.825] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:19:0) after 1m0s
[04:59:03.851] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:19:0)
[04:59:03.851] Timer tick, asking Buildbucket for the build status
[04:59:04.202] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:04.202] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:20:0) after 1m0s
[05:00:04.239] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:20:0)
[05:00:04.239] Timer tick, asking Buildbucket for the build status
[05:00:04.419] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:04.419] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:21:0) after 1m0s
[05:01:04.591] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:21:0)
[05:01:04.591] Timer tick, asking Buildbucket for the build status
[05:01:04.670] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:04.670] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:22:0) after 1m0s
[05:02:04.702] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:22:0)
[05:02:04.702] Timer tick, asking Buildbucket for the build status
[05:02:04.931] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:04.931] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:23:0) after 1m0s
[05:03:05.017] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:23:0)
[05:03:05.017] Timer tick, asking Buildbucket for the build status
[05:03:05.153] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:05.153] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:24:0) after 1m0s
[05:04:05.194] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:24:0)
[05:04:05.194] Timer tick, asking Buildbucket for the build status
[05:04:05.494] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:05.494] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:25:0) after 1m0s
[05:05:05.540] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:25:0)
[05:05:05.540] Timer tick, asking Buildbucket for the build status
[05:05:05.624] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:05.624] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:26:0) after 1m0s
[05:06:05.648] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:26:0)
[05:06:05.648] Timer tick, asking Buildbucket for the build status
[05:06:05.727] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:05.727] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:27:0) after 1m0s
[05:07:05.798] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:27:0)
[05:07:05.798] Timer tick, asking Buildbucket for the build status
[05:07:05.998] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:05.998] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:28:0) after 1m0s
[05:08:06.025] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:28:0)
[05:08:06.025] Timer tick, asking Buildbucket for the build status
[05:08:06.134] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:06.134] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:29:0) after 1m0s
[05:09:06.190] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:29:0)
[05:09:06.190] Timer tick, asking Buildbucket for the build status
[05:09:06.290] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:06.290] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:30:0) after 1m0s
[05:10:06.339] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:30:0)
[05:10:06.339] Timer tick, asking Buildbucket for the build status
[05:10:06.433] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:06.433] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:31:0) after 1m0s
[05:11:06.793] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:31:0)
[05:11:06.793] Timer tick, asking Buildbucket for the build status
[05:11:06.916] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:06.916] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:32:0) after 1m0s
[05:12:07.077] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:32:0)
[05:12:07.078] Timer tick, asking Buildbucket for the build status
[05:12:08.347] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:08.347] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:33:0) after 1m0s
[05:13:08.413] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:33:0)
[05:13:08.413] Timer tick, asking Buildbucket for the build status
[05:13:08.518] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:08.518] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:34:0) after 1m0s
[05:14:08.618] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:34:0)
[05:14:08.618] Timer tick, asking Buildbucket for the build status
[05:14:08.699] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:08.699] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:35:0) after 1m0s
[05:15:08.919] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:35:0)
[05:15:08.919] Timer tick, asking Buildbucket for the build status
[05:15:09.052] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:09.052] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:36:0) after 1m0s
[05:16:09.216] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:36:0)
[05:16:09.216] Timer tick, asking Buildbucket for the build status
[05:16:09.329] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:09.329] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:37:0) after 1m0s
[05:17:09.523] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:37:0)
[05:17:09.523] Timer tick, asking Buildbucket for the build status
[05:17:09.636] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:09.636] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:38:0) after 1m0s
[05:18:09.917] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:38:0)
[05:18:09.917] Timer tick, asking Buildbucket for the build status
[05:18:10.059] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:10.059] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:39:0) after 1m0s
[05:19:10.192] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:39:0)
[05:19:10.192] Timer tick, asking Buildbucket for the build status
[05:19:10.347] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:10.347] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:40:0) after 1m0s
[05:20:10.408] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:40:0)
[05:20:10.408] Timer tick, asking Buildbucket for the build status
[05:20:10.470] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:10.470] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:41:0) after 1m0s
[05:21:10.503] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:41:0)
[05:21:10.503] Timer tick, asking Buildbucket for the build status
[05:21:11.016] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:11.016] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:42:0) after 1m0s
[05:22:11.044] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:42:0)
[05:22:11.044] Timer tick, asking Buildbucket for the build status
[05:22:11.411] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:11.411] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:43:0) after 1m0s
[05:23:11.468] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:43:0)
[05:23:11.468] Timer tick, asking Buildbucket for the build status
[05:23:11.549] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:11.549] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:44:0) after 1m0s
[05:24:11.559] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:44:0)
[05:24:11.559] Timer tick, asking Buildbucket for the build status
[05:24:11.686] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:11.686] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:45:0) after 1m0s
[05:25:11.792] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:45:0)
[05:25:11.792] Timer tick, asking Buildbucket for the build status
[05:25:12.088] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:12.088] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:46:0) after 1m0s
[05:26:12.275] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:46:0)
[05:26:12.275] Timer tick, asking Buildbucket for the build status
[05:26:12.454] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:12.454] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:47:0) after 1m0s
[05:27:12.576] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:47:0)
[05:27:12.576] Timer tick, asking Buildbucket for the build status
[05:27:12.690] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:12.690] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:48:0) after 1m0s
[05:28:12.810] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:48:0)
[05:28:12.810] Timer tick, asking Buildbucket for the build status
[05:28:12.915] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:12.915] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:49:0) after 1m0s
[05:29:13.077] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:49:0)
[05:29:13.077] Timer tick, asking Buildbucket for the build status
[05:29:13.159] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:13.159] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:50:0) after 1m0s
[05:30:13.310] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:50:0)
[05:30:13.310] Timer tick, asking Buildbucket for the build status
[05:30:13.382] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:13.383] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:51:0) after 1m0s
[05:31:13.518] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:51:0)
[05:31:13.518] Timer tick, asking Buildbucket for the build status
[05:31:13.570] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:13.570] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:52:0) after 1m0s
[05:32:13.721] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:52:0)
[05:32:13.721] Timer tick, asking Buildbucket for the build status
[05:32:13.830] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:13.830] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:53:0) after 1m0s
[05:33:13.897] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:53:0)
[05:33:13.897] Timer tick, asking Buildbucket for the build status
[05:33:14.016] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:14.017] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:54:0) after 1m0s
[05:34:14.192] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:54:0)
[05:34:14.192] Timer tick, asking Buildbucket for the build status
[05:34:14.275] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:14.275] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:55:0) after 1m0s
[05:35:14.337] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:55:0)
[05:35:14.337] Timer tick, asking Buildbucket for the build status
[05:35:14.420] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:14.420] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:56:0) after 1m0s
[05:36:14.605] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:56:0)
[05:36:14.605] Timer tick, asking Buildbucket for the build status
[05:36:14.676] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:14.676] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:57:0) after 1m0s
[05:37:14.867] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:57:0)
[05:37:14.867] Timer tick, asking Buildbucket for the build status
[05:37:15.030] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:15.030] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:58:0) after 1m0s
[05:38:15.196] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:58:0)
[05:38:15.196] Timer tick, asking Buildbucket for the build status
[05:38:15.257] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:15.257] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:59:0) after 1m0s
[05:39:15.412] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:59:0)
[05:39:15.412] Timer tick, asking Buildbucket for the build status
[05:39:15.481] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:15.481] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:60:0) after 1m0s
[05:40:15.515] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:60:0)
[05:40:15.515] Timer tick, asking Buildbucket for the build status
[05:40:15.626] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:15.626] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:61:0) after 1m0s
[05:41:15.715] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:61:0)
[05:41:15.715] Timer tick, asking Buildbucket for the build status
[05:41:15.779] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:15.779] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:62:0) after 1m0s
[05:42:16.005] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:62:0)
[05:42:16.005] Timer tick, asking Buildbucket for the build status
[05:42:16.124] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:16.124] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:63:0) after 1m0s
[05:43:16.184] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:63:0)
[05:43:16.184] Timer tick, asking Buildbucket for the build status
[05:43:16.321] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:16.321] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:64:0) after 1m0s
[05:44:16.317] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:64:0)
[05:44:16.317] Timer tick, asking Buildbucket for the build status
[05:44:16.381] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:16.381] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:65:0) after 1m0s
[05:45:16.398] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:65:0)
[05:45:16.398] Timer tick, asking Buildbucket for the build status
[05:45:16.838] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:16.838] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:66:0) after 1m0s
[05:46:16.929] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:66:0)
[05:46:16.929] Timer tick, asking Buildbucket for the build status
[05:46:17.019] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:17.019] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:67:0) after 1m0s
[05:47:17.033] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:67:0)
[05:47:17.033] Timer tick, asking Buildbucket for the build status
[05:47:17.169] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:17.169] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:68:0) after 1m0s
[05:48:17.220] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:68:0)
[05:48:17.220] Timer tick, asking Buildbucket for the build status
[05:48:17.326] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:17.326] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:69:0) after 1m0s
[05:49:17.410] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:69:0)
[05:49:17.410] Timer tick, asking Buildbucket for the build status
[05:49:17.468] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:17.468] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:70:0) after 1m0s
[05:50:17.536] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:70:0)
[05:50:17.536] Timer tick, asking Buildbucket for the build status
[05:50:17.603] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:17.603] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:71:0) after 1m0s
[05:51:17.752] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:71:0)
[05:51:17.752] Timer tick, asking Buildbucket for the build status
[05:51:18.011] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:18.011] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:72:0) after 1m0s
[05:52:18.152] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:72:0)
[05:52:18.152] Timer tick, asking Buildbucket for the build status
[05:52:18.263] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:18.263] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:73:0) after 1m0s
[05:53:18.339] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:73:0)
[05:53:18.339] Timer tick, asking Buildbucket for the build status
[05:53:18.515] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:18.515] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:74:0) after 1m0s
[05:54:18.640] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:74:0)
[05:54:18.640] Timer tick, asking Buildbucket for the build status
[05:54:18.717] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:18.717] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:75:0) after 1m0s
[05:55:18.876] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:75:0)
[05:55:18.876] Timer tick, asking Buildbucket for the build status
[05:55:18.950] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:18.950] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:76:0) after 1m0s
[05:56:18.985] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:76:0)
[05:56:18.985] Timer tick, asking Buildbucket for the build status
[05:56:19.115] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:19.115] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:77:0) after 1m0s
[05:57:19.190] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:77:0)
[05:57:19.190] Timer tick, asking Buildbucket for the build status
[05:57:19.294] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:19.294] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:78:0) after 1m0s
[05:58:19.413] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:78:0)
[05:58:19.413] Timer tick, asking Buildbucket for the build status
[05:58:19.482] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:19.482] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:79:0) after 1m0s
[05:59:19.607] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:79:0)
[05:59:19.607] Timer tick, asking Buildbucket for the build status
[05:59:19.667] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:19.667] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:80:0) after 1m0s
[06:00:19.705] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:80:0)
[06:00:19.705] Timer tick, asking Buildbucket for the build status
[06:00:19.827] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:19.827] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:81:0) after 1m0s
[06:01:29.672] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:81:0)
[06:01:29.672] Timer tick, asking Buildbucket for the build status
[06:01:29.741] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:29.741] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:82:0) after 1m0s
[06:02:29.918] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:82:0)
[06:02:29.918] Timer tick, asking Buildbucket for the build status
[06:02:30.028] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:30.028] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:83:0) after 1m0s
[06:03:30.305] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:83:0)
[06:03:30.305] Timer tick, asking Buildbucket for the build status
[06:03:30.388] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:30.388] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:84:0) after 1m0s
[06:04:30.528] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:84:0)
[06:04:30.528] Timer tick, asking Buildbucket for the build status
[06:04:30.819] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:30.819] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:85:0) after 1m0s
[06:05:30.920] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:85:0)
[06:05:30.920] Timer tick, asking Buildbucket for the build status
[06:05:30.982] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:30.982] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:86:0) after 1m0s
[06:06:31.166] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:86:0)
[06:06:31.166] Timer tick, asking Buildbucket for the build status
[06:06:31.445] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:31.445] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:87:0) after 1m0s
[06:07:31.571] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:87:0)
[06:07:31.571] Timer tick, asking Buildbucket for the build status
[06:07:31.701] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:31.701] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:88:0) after 1m0s
[06:08:31.752] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:88:0)
[06:08:31.752] Timer tick, asking Buildbucket for the build status
[06:08:31.817] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:31.817] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:89:0) after 1m0s
[06:09:31.829] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:89:0)
[06:09:31.829] Timer tick, asking Buildbucket for the build status
[06:09:31.952] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:31.952] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:90:0) after 1m0s
[06:10:32.105] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:90:0)
[06:10:32.105] Timer tick, asking Buildbucket for the build status
[06:10:32.175] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:32.175] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:91:0) after 1m0s
[06:11:32.382] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:91:0)
[06:11:32.382] Timer tick, asking Buildbucket for the build status
[06:11:32.829] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:32.829] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:92:0) after 1m0s
[06:12:32.876] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:92:0)
[06:12:32.876] Timer tick, asking Buildbucket for the build status
[06:12:33.003] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:33.003] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:93:0) after 1m0s
[06:13:33.058] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:93:0)
[06:13:33.058] Timer tick, asking Buildbucket for the build status
[06:13:33.157] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:33.158] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:94:0) after 1m0s
[06:14:33.183] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:94:0)
[06:14:33.183] Timer tick, asking Buildbucket for the build status
[06:14:33.405] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:33.405] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:95:0) after 1m0s
[06:15:33.431] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:95:0)
[06:15:33.431] Timer tick, asking Buildbucket for the build status
[06:15:33.514] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:33.514] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:96:0) after 1m0s
[06:17:02.818] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:96:0)
[06:17:02.818] Timer tick, asking Buildbucket for the build status
[06:17:03.036] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:03.036] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:97:0) after 1m0s
[06:18:03.144] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:97:0)
[06:18:03.144] Timer tick, asking Buildbucket for the build status
[06:18:03.324] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:03.324] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:98:0) after 1m0s
[06:19:03.418] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:98:0)
[06:19:03.418] Timer tick, asking Buildbucket for the build status
[06:19:03.538] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:03.538] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:99:0) after 1m0s
[06:20:03.564] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:99:0)
[06:20:03.564] Timer tick, asking Buildbucket for the build status
[06:20:03.630] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:03.630] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:100:0) after 1m0s
[06:21:03.728] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:100:0)
[06:21:03.728] Timer tick, asking Buildbucket for the build status
[06:21:03.786] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:03.786] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:101:0) after 1m0s
[06:22:03.768] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:101:0)
[06:22:03.768] Timer tick, asking Buildbucket for the build status
[06:22:03.825] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:03.825] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:102:0) after 1m0s
[06:23:03.850] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:102:0)
[06:23:03.850] Timer tick, asking Buildbucket for the build status
[06:23:04.211] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:04.211] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:103:0) after 1m0s
[06:24:04.269] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:103:0)
[06:24:04.269] Timer tick, asking Buildbucket for the build status
[06:24:04.428] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:04.428] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:104:0) after 1m0s
[06:25:04.454] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:104:0)
[06:25:04.454] Timer tick, asking Buildbucket for the build status
[06:25:04.526] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:04.526] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:105:0) after 1m0s
[06:26:04.553] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:105:0)
[06:26:04.553] Timer tick, asking Buildbucket for the build status
[06:26:04.936] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:04.936] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:106:0) after 1m0s
[06:27:04.951] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:106:0)
[06:27:04.951] Timer tick, asking Buildbucket for the build status
[06:27:05.021] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:05.021] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:107:0) after 1m0s
[06:28:05.073] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:107:0)
[06:28:05.073] Timer tick, asking Buildbucket for the build status
[06:28:05.206] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:05.206] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:108:0) after 1m0s
[06:29:05.270] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:108:0)
[06:29:05.270] Timer tick, asking Buildbucket for the build status
[06:29:05.348] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:05.348] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:109:0) after 1m0s
[06:30:05.372] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:109:0)
[06:30:05.372] Timer tick, asking Buildbucket for the build status
[06:30:05.508] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:05.508] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:110:0) after 1m0s
[06:31:05.540] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:110:0)
[06:31:05.540] Timer tick, asking Buildbucket for the build status
[06:31:05.657] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:05.657] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:111:0) after 1m0s
[06:32:05.745] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:111:0)
[06:32:05.745] Timer tick, asking Buildbucket for the build status
[06:32:06.126] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:06.126] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:112:0) after 1m0s
[06:33:06.191] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:112:0)
[06:33:06.191] Timer tick, asking Buildbucket for the build status
[06:33:06.453] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:06.453] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:113:0) after 1m0s
[06:34:06.512] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:113:0)
[06:34:06.512] Timer tick, asking Buildbucket for the build status
[06:34:06.616] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:06.616] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:114:0) after 1m0s
[06:35:06.660] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:114:0)
[06:35:06.660] Timer tick, asking Buildbucket for the build status
[06:35:07.118] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:07.118] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:115:0) after 1m0s
[06:36:07.139] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:115:0)
[06:36:07.139] Timer tick, asking Buildbucket for the build status
[06:36:07.415] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:07.415] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:116:0) after 1m0s
[06:37:07.459] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:116:0)
[06:37:07.459] Timer tick, asking Buildbucket for the build status
[06:37:07.577] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:07.577] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:117:0) after 1m0s
[06:38:07.647] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:117:0)
[06:38:07.647] Timer tick, asking Buildbucket for the build status
[06:38:07.710] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:07.710] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:118:0) after 1m0s
[06:39:07.817] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:118:0)
[06:39:07.817] Timer tick, asking Buildbucket for the build status
[06:39:07.913] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:07.913] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:119:0) after 1m0s
[06:40:07.963] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:119:0)
[06:40:07.963] Timer tick, asking Buildbucket for the build status
[06:40:08.147] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:08.147] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:120:0) after 1m0s
[06:41:08.211] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:120:0)
[06:41:08.211] Timer tick, asking Buildbucket for the build status
[06:41:08.302] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:08.302] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:121:0) after 1m0s
[06:42:08.387] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:121:0)
[06:42:08.387] Timer tick, asking Buildbucket for the build status
[06:42:12.177] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:12.177] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:122:0) after 1m0s
[06:43:12.206] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:122:0)
[06:43:12.206] Timer tick, asking Buildbucket for the build status
[06:43:12.275] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:12.275] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:123:0) after 1m0s
[06:44:12.261] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:123:0)
[06:44:12.261] Timer tick, asking Buildbucket for the build status
[06:44:12.597] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:12.597] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:124:0) after 1m0s
[06:45:12.732] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:124:0)
[06:45:12.732] Timer tick, asking Buildbucket for the build status
[06:45:12.796] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:12.796] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:125:0) after 1m0s
[06:46:12.933] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:125:0)
[06:46:12.933] Timer tick, asking Buildbucket for the build status
[06:46:12.998] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:12.998] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:126:0) after 1m0s
[06:47:13.189] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:126:0)
[06:47:13.189] Timer tick, asking Buildbucket for the build status
[06:47:13.326] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:13.326] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:127:0) after 1m0s
[06:48:13.522] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:127:0)
[06:48:13.522] Timer tick, asking Buildbucket for the build status
[06:48:13.606] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:13.606] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:128:0) after 1m0s
[06:49:13.711] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:128:0)
[06:49:13.711] Timer tick, asking Buildbucket for the build status
[06:49:13.783] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:13.783] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:129:0) after 1m0s
[06:50:13.939] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:129:0)
[06:50:13.939] Timer tick, asking Buildbucket for the build status
[06:50:14.136] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:14.136] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:130:0) after 1m0s
[06:51:14.347] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:130:0)
[06:51:14.347] Timer tick, asking Buildbucket for the build status
[06:51:14.410] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:14.410] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:131:0) after 1m0s
[06:52:14.500] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:131:0)
[06:52:14.500] Timer tick, asking Buildbucket for the build status
[06:52:14.652] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:14.652] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:132:0) after 1m0s
[06:53:14.671] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:132:0)
[06:53:14.671] Timer tick, asking Buildbucket for the build status
[06:53:14.751] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:14.751] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:133:0) after 1m0s
[06:54:14.781] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:133:0)
[06:54:14.782] Timer tick, asking Buildbucket for the build status
[06:54:14.851] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:14.851] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:134:0) after 1m0s
[06:55:14.873] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:134:0)
[06:55:14.873] Timer tick, asking Buildbucket for the build status
[06:55:14.945] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:14.945] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:135:0) after 1m0s
[06:56:14.982] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:135:0)
[06:56:14.982] Timer tick, asking Buildbucket for the build status
[06:56:15.068] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:15.068] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:136:0) after 1m0s
[06:57:15.191] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:136:0)
[06:57:15.191] Timer tick, asking Buildbucket for the build status
[06:57:15.438] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:15.438] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:137:0) after 1m0s
[06:58:15.497] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:137:0)
[06:58:15.497] Timer tick, asking Buildbucket for the build status
[06:58:15.583] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:15.583] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:138:0) after 1m0s
[06:59:15.638] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:138:0)
[06:59:15.638] Timer tick, asking Buildbucket for the build status
[06:59:15.707] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:15.707] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:139:0) after 1m0s
[07:00:15.776] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:139:0)
[07:00:15.776] Timer tick, asking Buildbucket for the build status
[07:00:15.839] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:15.839] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:140:0) after 1m0s
[07:01:15.878] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:140:0)
[07:01:15.878] Timer tick, asking Buildbucket for the build status
[07:01:15.945] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:15.945] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:141:0) after 1m0s
[07:02:16.212] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:141:0)
[07:02:16.212] Timer tick, asking Buildbucket for the build status
[07:02:16.367] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:16.367] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:142:0) after 1m0s
[07:03:16.474] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:142:0)
[07:03:16.474] Timer tick, asking Buildbucket for the build status
[07:03:16.544] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:16.544] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:143:0) after 1m0s
[07:04:16.615] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:143:0)
[07:04:16.616] Timer tick, asking Buildbucket for the build status
[07:04:16.805] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:16.805] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:144:0) after 1m0s
[07:05:16.859] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:144:0)
[07:05:16.859] Timer tick, asking Buildbucket for the build status
[07:05:16.923] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:16.923] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:145:0) after 1m0s
[07:06:16.978] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:145:0)
[07:06:16.978] Timer tick, asking Buildbucket for the build status
[07:06:17.250] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:17.250] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:146:0) after 1m0s
[07:07:17.275] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:146:0)
[07:07:17.275] Timer tick, asking Buildbucket for the build status
[07:07:17.385] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:17.385] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:147:0) after 1m0s
[07:08:17.396] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:147:0)
[07:08:17.396] Timer tick, asking Buildbucket for the build status
[07:08:17.452] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:17.452] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:148:0) after 1m0s
[07:09:17.454] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:148:0)
[07:09:17.454] Timer tick, asking Buildbucket for the build status
[07:09:17.519] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:17.519] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:149:0) after 1m0s
[07:10:17.547] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:149:0)
[07:10:17.547] Timer tick, asking Buildbucket for the build status
[07:10:17.796] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:17.796] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:150:0) after 1m0s
[07:11:17.837] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:150:0)
[07:11:17.837] Timer tick, asking Buildbucket for the build status
[07:11:17.919] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:17.919] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:151:0) after 1m0s
[07:12:18.054] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:151:0)
[07:12:18.054] Timer tick, asking Buildbucket for the build status
[07:12:18.171] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:18.171] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:152:0) after 1m0s
[07:13:18.264] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:152:0)
[07:13:18.264] Timer tick, asking Buildbucket for the build status
[07:13:18.444] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:18.445] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:153:0) after 1m0s
[07:14:18.575] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:153:0)
[07:14:18.575] Timer tick, asking Buildbucket for the build status
[07:14:19.246] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:19.246] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:154:0) after 1m0s
[07:15:19.273] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:154:0)
[07:15:19.273] Timer tick, asking Buildbucket for the build status
[07:15:19.496] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:19.496] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:155:0) after 1m0s
[07:16:19.528] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:155:0)
[07:16:19.528] Timer tick, asking Buildbucket for the build status
[07:16:19.803] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:19.803] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:156:0) after 1m0s
[07:17:19.955] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:156:0)
[07:17:19.955] Timer tick, asking Buildbucket for the build status
[07:17:20.222] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:20.222] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:157:0) after 1m0s
[07:18:20.276] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:157:0)
[07:18:20.276] Timer tick, asking Buildbucket for the build status
[07:18:20.363] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:20.363] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:158:0) after 1m0s
[07:19:20.428] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:158:0)
[07:19:20.429] Timer tick, asking Buildbucket for the build status
[07:19:20.496] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:20.496] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:159:0) after 1m0s
[07:20:20.531] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:159:0)
[07:20:20.531] Timer tick, asking Buildbucket for the build status
[07:20:20.618] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:20.618] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:160:0) after 1m0s
[07:21:20.685] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:160:0)
[07:21:20.685] Timer tick, asking Buildbucket for the build status
[07:21:20.775] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:20.775] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:161:0) after 1m0s
[07:22:20.783] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:161:0)
[07:22:20.783] Timer tick, asking Buildbucket for the build status
[07:22:20.890] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:20.890] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:162:0) after 1m0s
[07:23:20.957] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:162:0)
[07:23:20.957] Timer tick, asking Buildbucket for the build status
[07:23:21.022] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:21.022] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:163:0) after 1m0s
[07:24:21.063] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:163:0)
[07:24:21.063] Timer tick, asking Buildbucket for the build status
[07:24:21.131] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:21.131] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:164:0) after 1m0s
[07:25:21.118] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:164:0)
[07:25:21.118] Timer tick, asking Buildbucket for the build status
[07:25:21.188] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:21.188] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:165:0) after 1m0s
[07:26:21.220] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:165:0)
[07:26:21.220] Timer tick, asking Buildbucket for the build status
[07:26:21.301] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:21.301] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:166:0) after 1m0s
[07:27:21.417] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:166:0)
[07:27:21.417] Timer tick, asking Buildbucket for the build status
[07:27:21.533] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:21.533] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:167:0) after 1m0s
[07:28:21.527] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:167:0)
[07:28:21.527] Timer tick, asking Buildbucket for the build status
[07:28:21.587] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:21.587] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:168:0) after 1m0s
[07:29:21.628] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:168:0)
[07:29:21.628] Timer tick, asking Buildbucket for the build status
[07:29:21.792] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:21.792] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:169:0) after 1m0s
[07:30:21.916] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:169:0)
[07:30:21.917] Timer tick, asking Buildbucket for the build status
[07:30:22.209] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:22.209] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:170:0) after 1m0s
[07:31:22.455] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:170:0)
[07:31:22.455] Timer tick, asking Buildbucket for the build status
[07:31:22.598] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:22.598] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:171:0) after 1m0s
[07:32:22.812] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:171:0)
[07:32:22.812] Timer tick, asking Buildbucket for the build status
[07:32:22.950] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:22.950] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:172:0) after 1m0s
[07:33:23.130] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:172:0)
[07:33:23.130] Timer tick, asking Buildbucket for the build status
[07:33:23.200] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:23.200] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:173:0) after 1m0s
[07:34:23.530] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:173:0)
[07:34:23.530] Timer tick, asking Buildbucket for the build status
[07:34:23.610] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:23.610] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:174:0) after 1m0s
[07:35:23.730] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:174:0)
[07:35:23.730] Timer tick, asking Buildbucket for the build status
[07:35:23.947] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:23.947] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:175:0) after 1m0s
[07:36:24.195] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:175:0)
[07:36:24.195] Timer tick, asking Buildbucket for the build status
[07:36:24.378] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:24.378] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:176:0) after 1m0s
[07:37:24.569] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:176:0)
[07:37:24.569] Timer tick, asking Buildbucket for the build status
[07:37:24.710] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:24.710] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:177:0) after 1m0s
[07:38:24.730] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:177:0)
[07:38:24.730] Timer tick, asking Buildbucket for the build status
[07:38:24.800] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:24.800] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:178:0) after 1m0s
[07:39:25.087] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:178:0)
[07:39:25.087] Timer tick, asking Buildbucket for the build status
[07:39:25.175] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:25.175] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:179:0) after 1m0s
[07:40:25.404] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:179:0)
[07:40:25.404] Timer tick, asking Buildbucket for the build status
[07:40:25.525] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:25.525] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:180:0) after 1m0s
[07:41:25.782] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:180:0)
[07:41:25.782] Timer tick, asking Buildbucket for the build status
[07:41:25.846] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:25.846] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:181:0) after 1m0s
[07:42:25.988] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:181:0)
[07:42:25.988] Timer tick, asking Buildbucket for the build status
[07:42:26.213] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:26.213] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:182:0) after 1m0s
[07:43:26.271] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:182:0)
[07:43:26.271] Timer tick, asking Buildbucket for the build status
[07:43:26.466] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:26.466] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:183:0) after 1m0s
[07:44:26.570] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:183:0)
[07:44:26.570] Timer tick, asking Buildbucket for the build status
[07:44:26.643] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:26.643] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:184:0) after 1m0s
[07:45:26.659] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:184:0)
[07:45:26.659] Timer tick, asking Buildbucket for the build status
[07:45:29.238] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:29.238] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:185:0) after 1m0s
[07:46:29.431] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:185:0)
[07:46:29.431] Timer tick, asking Buildbucket for the build status
[07:46:29.713] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:29.713] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:186:0) after 1m0s
[07:47:29.914] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:186:0)
[07:47:29.914] Timer tick, asking Buildbucket for the build status
[07:47:30.080] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:30.080] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:187:0) after 1m0s
[07:48:30.262] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:187:0)
[07:48:30.262] Timer tick, asking Buildbucket for the build status
[07:48:30.334] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:30.334] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:188:0) after 1m0s
[07:49:30.466] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:188:0)
[07:49:30.466] Timer tick, asking Buildbucket for the build status
[07:49:30.916] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:30.916] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:189:0) after 1m0s
[07:50:31.055] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:189:0)
[07:50:31.055] Timer tick, asking Buildbucket for the build status
[07:50:31.113] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:31.113] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:190:0) after 1m0s
[07:51:31.206] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:190:0)
[07:51:31.206] Timer tick, asking Buildbucket for the build status
[07:51:31.273] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:31.273] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:191:0) after 1m0s
[07:52:31.389] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:191:0)
[07:52:31.389] Timer tick, asking Buildbucket for the build status
[07:52:31.510] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:31.510] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:192:0) after 1m0s
[07:53:31.543] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:192:0)
[07:53:31.543] Timer tick, asking Buildbucket for the build status
[07:53:31.632] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:31.632] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:193:0) after 1m0s
[07:54:31.703] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:193:0)
[07:54:31.703] Timer tick, asking Buildbucket for the build status
[07:54:31.777] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:31.777] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:194:0) after 1m0s
[07:55:31.796] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:194:0)
[07:55:31.796] Timer tick, asking Buildbucket for the build status
[07:55:31.860] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:31.860] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:195:0) after 1m0s
[07:56:32.022] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:195:0)
[07:56:32.022] Timer tick, asking Buildbucket for the build status
[07:56:32.096] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:32.096] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:196:0) after 1m0s
[07:57:32.238] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:196:0)
[07:57:32.238] Timer tick, asking Buildbucket for the build status
[07:57:32.357] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:32.357] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:197:0) after 1m0s
[07:58:32.425] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:197:0)
[07:58:32.425] Timer tick, asking Buildbucket for the build status
[07:58:32.494] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:32.494] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:198:0) after 1m0s
[07:59:32.509] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:198:0)
[07:59:32.509] Timer tick, asking Buildbucket for the build status
[07:59:32.608] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:32.608] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:199:0) after 1m0s
[08:00:32.681] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:199:0)
[08:00:32.681] Timer tick, asking Buildbucket for the build status
[08:00:32.937] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:32.937] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:200:0) after 1m0s
[08:01:32.997] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:200:0)
[08:01:32.997] Timer tick, asking Buildbucket for the build status
[08:01:33.123] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:33.123] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:201:0) after 1m0s
[08:02:33.160] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:201:0)
[08:02:33.160] Timer tick, asking Buildbucket for the build status
[08:02:33.284] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:33.284] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:202:0) after 1m0s
[08:03:33.380] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:202:0)
[08:03:33.380] Timer tick, asking Buildbucket for the build status
[08:03:33.440] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:33.440] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:203:0) after 1m0s
[08:04:33.577] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:203:0)
[08:04:33.577] Timer tick, asking Buildbucket for the build status
[08:04:33.654] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:33.654] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:204:0) after 1m0s
[08:05:33.760] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:204:0)
[08:05:33.760] Timer tick, asking Buildbucket for the build status
[08:05:33.854] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:33.854] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:205:0) after 1m0s
[08:06:33.919] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:205:0)
[08:06:33.919] Timer tick, asking Buildbucket for the build status
[08:06:34.309] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:34.309] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:206:0) after 1m0s
[08:07:34.338] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:206:0)
[08:07:34.338] Timer tick, asking Buildbucket for the build status
[08:07:34.544] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:34.544] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:207:0) after 1m0s
[08:08:34.598] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:207:0)
[08:08:34.598] Timer tick, asking Buildbucket for the build status
[08:08:34.691] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:34.691] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:208:0) after 1m0s
[08:09:34.754] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:208:0)
[08:09:34.754] Timer tick, asking Buildbucket for the build status
[08:09:35.024] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:35.024] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:209:0) after 1m0s
[08:10:35.126] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:209:0)
[08:10:35.126] Timer tick, asking Buildbucket for the build status
[08:10:35.230] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:35.230] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:210:0) after 1m0s
[08:11:35.250] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:210:0)
[08:11:35.250] Timer tick, asking Buildbucket for the build status
[08:11:35.317] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:35.317] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:211:0) after 1m0s
[08:12:35.342] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:211:0)
[08:12:35.342] Timer tick, asking Buildbucket for the build status
[08:12:35.441] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:35.441] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:212:0) after 1m0s
[08:13:35.542] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:212:0)
[08:13:35.542] Timer tick, asking Buildbucket for the build status
[08:13:35.701] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:35.701] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:213:0) after 1m0s
[08:14:35.736] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:213:0)
[08:14:35.736] Timer tick, asking Buildbucket for the build status
[08:14:35.795] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:35.795] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:214:0) after 1m0s
[08:15:35.838] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:214:0)
[08:15:35.838] Timer tick, asking Buildbucket for the build status
[08:15:35.911] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:35.911] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:215:0) after 1m0s
[08:16:35.984] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:215:0)
[08:16:35.984] Timer tick, asking Buildbucket for the build status
[08:16:36.125] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:36.125] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:216:0) after 1m0s
[08:17:36.168] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:216:0)
[08:17:36.168] Timer tick, asking Buildbucket for the build status
[08:17:36.280] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:36.280] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:217:0) after 1m0s
[08:18:36.371] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:217:0)
[08:18:36.371] Timer tick, asking Buildbucket for the build status
[08:18:36.444] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:36.444] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:218:0) after 1m0s
[08:19:36.429] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:218:0)
[08:19:36.429] Timer tick, asking Buildbucket for the build status
[08:19:36.496] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:36.496] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:219:0) after 1m0s
[08:20:36.529] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:219:0)
[08:20:36.529] Timer tick, asking Buildbucket for the build status
[08:20:36.586] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:36.586] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:220:0) after 1m0s
[08:21:36.642] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:220:0)
[08:21:36.642] Timer tick, asking Buildbucket for the build status
[08:21:36.696] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:36.696] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:221:0) after 1m0s
[08:22:36.740] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:221:0)
[08:22:36.740] Timer tick, asking Buildbucket for the build status
[08:22:36.844] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:36.844] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:222:0) after 1m0s
[08:23:36.868] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:222:0)
[08:23:36.868] Timer tick, asking Buildbucket for the build status
[08:23:36.938] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:36.938] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:223:0) after 1m0s
[08:24:37.001] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:223:0)
[08:24:37.001] Timer tick, asking Buildbucket for the build status
[08:24:37.138] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:37.138] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:224:0) after 1m0s
[08:25:37.177] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:224:0)
[08:25:37.177] Timer tick, asking Buildbucket for the build status
[08:25:37.244] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:37.244] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:225:0) after 1m0s
[08:26:37.327] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:225:0)
[08:26:37.327] Timer tick, asking Buildbucket for the build status
[08:26:37.395] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:37.395] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:226:0) after 1m0s
[08:27:37.643] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:226:0)
[08:27:37.643] Timer tick, asking Buildbucket for the build status
[08:27:38.212] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:38.212] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:227:0) after 1m0s
[08:28:38.358] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:227:0)
[08:28:38.358] Timer tick, asking Buildbucket for the build status
[08:28:38.439] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:38.439] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:228:0) after 1m0s
[08:29:38.592] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:228:0)
[08:29:38.592] Timer tick, asking Buildbucket for the build status
[08:29:38.743] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:38.743] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:229:0) after 1m0s
[08:30:38.817] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:229:0)
[08:30:38.817] Timer tick, asking Buildbucket for the build status
[08:30:38.878] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:38.878] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:230:0) after 1m0s
[08:31:38.973] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:230:0)
[08:31:38.973] Timer tick, asking Buildbucket for the build status
[08:31:39.147] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:39.147] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:231:0) after 1m0s
[08:32:39.334] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:231:0)
[08:32:39.334] Timer tick, asking Buildbucket for the build status
[08:32:39.452] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:39.452] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:232:0) after 1m0s
[08:33:39.518] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:232:0)
[08:33:39.518] Timer tick, asking Buildbucket for the build status
[08:33:39.581] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:39.581] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:233:0) after 1m0s
[08:34:39.647] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:233:0)
[08:34:39.647] Timer tick, asking Buildbucket for the build status
[08:34:39.704] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:39.705] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:234:0) after 1m0s
[08:35:39.751] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:234:0)
[08:35:39.751] Timer tick, asking Buildbucket for the build status
[08:35:39.822] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:39.822] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:235:0) after 1m0s
[08:36:39.853] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:235:0)
[08:36:39.853] Timer tick, asking Buildbucket for the build status
[08:36:39.926] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:39.926] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:236:0) after 1m0s
[08:37:39.987] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:236:0)
[08:37:39.987] Timer tick, asking Buildbucket for the build status
[08:37:40.403] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:40.403] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:237:0) after 1m0s
[08:38:40.482] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:237:0)
[08:38:40.482] Timer tick, asking Buildbucket for the build status
[08:38:40.900] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:40.900] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:238:0) after 1m0s
[08:39:40.951] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:238:0)
[08:39:40.951] Timer tick, asking Buildbucket for the build status
[08:39:41.010] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:41.010] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:239:0) after 1m0s
[08:40:41.104] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:239:0)
[08:40:41.104] Timer tick, asking Buildbucket for the build status
[08:40:41.163] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:41.163] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:240:0) after 1m0s
[08:41:41.259] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:240:0)
[08:41:41.259] Timer tick, asking Buildbucket for the build status
[08:41:41.330] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:41.330] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:241:0) after 1m0s
[08:42:41.387] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:241:0)
[08:42:41.387] Timer tick, asking Buildbucket for the build status
[08:42:41.534] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:41.534] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:242:0) after 1m0s
[08:43:41.603] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:242:0)
[08:43:41.603] Timer tick, asking Buildbucket for the build status
[08:43:41.663] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:41.663] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:243:0) after 1m0s
[08:44:41.681] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:243:0)
[08:44:41.681] Timer tick, asking Buildbucket for the build status
[08:44:41.736] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:41.736] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:244:0) after 1m0s
[08:45:41.779] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:244:0)
[08:45:41.779] Timer tick, asking Buildbucket for the build status
[08:45:41.849] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:41.849] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:245:0) after 1m0s
[08:46:42.009] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:245:0)
[08:46:42.009] Timer tick, asking Buildbucket for the build status
[08:46:42.071] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:42.071] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:246:0) after 1m0s
[08:47:42.198] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:246:0)
[08:47:42.198] Timer tick, asking Buildbucket for the build status
[08:47:42.729] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:42.729] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:247:0) after 1m0s
[08:48:42.936] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:247:0)
[08:48:42.936] Timer tick, asking Buildbucket for the build status
[08:48:43.003] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:43.003] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:248:0) after 1m0s
[08:49:43.097] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:248:0)
[08:49:43.097] Timer tick, asking Buildbucket for the build status
[08:49:43.178] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:43.178] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:249:0) after 1m0s
[08:50:43.303] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:249:0)
[08:50:43.303] Timer tick, asking Buildbucket for the build status
[08:50:43.373] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:43.373] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:250:0) after 1m0s
[08:51:43.454] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:250:0)
[08:51:43.454] Timer tick, asking Buildbucket for the build status
[08:51:43.523] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:43.523] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:251:0) after 1m0s
[08:52:43.623] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:251:0)
[08:52:43.623] Timer tick, asking Buildbucket for the build status
[08:52:43.741] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:43.741] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:252:0) after 1m0s
[08:53:43.905] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:252:0)
[08:53:43.905] Timer tick, asking Buildbucket for the build status
[08:53:43.974] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:43.974] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:253:0) after 1m0s
[08:54:44.082] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:253:0)
[08:54:44.082] Timer tick, asking Buildbucket for the build status
[08:54:44.147] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:44.147] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:254:0) after 1m0s
[08:55:44.187] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:254:0)
[08:55:44.187] Timer tick, asking Buildbucket for the build status
[08:55:44.267] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:44.267] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:255:0) after 1m0s
[08:56:44.398] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:255:0)
[08:56:44.398] Timer tick, asking Buildbucket for the build status
[08:56:44.468] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:44.468] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:256:0) after 1m0s
[08:57:44.462] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:256:0)
[08:57:44.462] Timer tick, asking Buildbucket for the build status
[08:57:44.564] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:44.564] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:257:0) after 1m0s
[08:58:44.609] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:257:0)
[08:58:44.609] Timer tick, asking Buildbucket for the build status
[08:58:44.821] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:44.821] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:258:0) after 1m0s
[08:59:44.915] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:258:0)
[08:59:44.915] Timer tick, asking Buildbucket for the build status
[08:59:45.045] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:45.045] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:259:0) after 1m0s
[09:00:45.065] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:259:0)
[09:00:45.065] Timer tick, asking Buildbucket for the build status
[09:00:45.186] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:45.186] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:260:0) after 1m0s
[09:01:45.216] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:260:0)
[09:01:45.216] Timer tick, asking Buildbucket for the build status
[09:01:45.283] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:45.283] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:261:0) after 1m0s
[09:02:45.401] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:261:0)
[09:02:45.401] Timer tick, asking Buildbucket for the build status
[09:02:45.503] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:45.503] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:262:0) after 1m0s
[09:03:45.527] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:262:0)
[09:03:45.527] Timer tick, asking Buildbucket for the build status
[09:03:45.612] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:45.612] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:263:0) after 1m0s
[09:04:45.669] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:263:0)
[09:04:45.669] Timer tick, asking Buildbucket for the build status
[09:04:45.730] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:45.730] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:264:0) after 1m0s
[09:05:45.800] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:264:0)
[09:05:45.800] Timer tick, asking Buildbucket for the build status
[09:05:45.876] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:45.876] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:265:0) after 1m0s
[09:06:45.866] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:265:0)
[09:06:45.866] Timer tick, asking Buildbucket for the build status
[09:06:45.949] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:45.949] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:266:0) after 1m0s
[09:07:45.978] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:266:0)
[09:07:45.978] Timer tick, asking Buildbucket for the build status
[09:07:47.191] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:47.191] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:267:0) after 1m0s
[09:08:47.287] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:267:0)
[09:08:47.287] Timer tick, asking Buildbucket for the build status
[09:08:47.377] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:47.377] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:268:0) after 1m0s
[09:09:47.391] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:268:0)
[09:09:47.391] Timer tick, asking Buildbucket for the build status
[09:09:47.465] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:47.465] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:269:0) after 1m0s
[09:10:47.501] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:269:0)
[09:10:47.501] Timer tick, asking Buildbucket for the build status
[09:10:47.566] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:47.566] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:270:0) after 1m0s
[09:11:47.632] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:270:0)
[09:11:47.632] Timer tick, asking Buildbucket for the build status
[09:11:47.760] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:47.760] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:271:0) after 1m0s
[09:12:47.856] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:271:0)
[09:12:47.856] Timer tick, asking Buildbucket for the build status
[09:12:47.986] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:47.986] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:272:0) after 1m0s
[09:13:48.074] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:272:0)
[09:13:48.074] Timer tick, asking Buildbucket for the build status
[09:13:48.181] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:48.181] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:273:0) after 1m0s
[09:14:48.210] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:273:0)
[09:14:48.210] Timer tick, asking Buildbucket for the build status
[09:14:48.275] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:48.275] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:274:0) after 1m0s
[09:15:48.343] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:274:0)
[09:15:48.343] Timer tick, asking Buildbucket for the build status
[09:15:48.714] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:48.714] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:275:0) after 1m0s
[09:16:48.784] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:275:0)
[09:16:48.784] Timer tick, asking Buildbucket for the build status
[09:16:48.936] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:48.936] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:276:0) after 1m0s
[09:17:48.983] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:276:0)
[09:17:48.983] Timer tick, asking Buildbucket for the build status
[09:17:49.082] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:49.082] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:277:0) after 1m0s
[09:18:49.128] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:277:0)
[09:18:49.128] Timer tick, asking Buildbucket for the build status
[09:18:49.227] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:49.227] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:278:0) after 1m0s
[09:19:49.347] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:278:0)
[09:19:49.347] Timer tick, asking Buildbucket for the build status
[09:19:49.410] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:49.410] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:279:0) after 1m0s
[09:20:49.533] Handling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:279:0)
[09:20:49.533] Timer tick, asking Buildbucket for the build status
[09:20:49.647] Build 8861238220578059728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:49.647] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9026668284251458992:280:0) after 1m0s
[09:21:39.668] Received PubSub notification, asking Buildbucket for the build status
[09:21:39.764] Build 8861238220578059728: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:21:39.764] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1607678499230802",
"created_by": "project:chromium",
"created_ts": "1607661719685011",
"id": "8861238220578059728",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e0d412d8e2cb7bc7f86b8339cf387b734be15ed8\"}}",
"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}, \"$kitchen/crbug_1150511_keys_with_int_value\": [\"$recipe_engine/buildbucket.build.infra.swarming.priority\", \"$recipe_engine/buildbucket.build.number\", \"buildnumber\"], \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"e0d412d8e2cb7bc7f86b8339cf387b734be15ed8\", \"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-i5ub\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 1151, \"got_angle_revision\": \"9912971cf9b3dc5f9890a2a2435031988624fdc7\", \"got_dawn_revision\": \"6bcd4aceef100810284d61bd9dad0e9bd05e4c92\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"e0d412d8e2cb7bc7f86b8339cf387b734be15ed8\", \"got_revision_cp\": \"refs/heads/master@{#835995}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"0a64a974755521dbb2b16332002a927fb830a0d4\", \"got_v8_revision\": \"4d774788aff02fc9d9912a098630585025942f16\", \"got_v8_revision_cp\": \"refs/heads/8.9.134@{#1}\", \"got_webrtc_revision\": \"d7808f1c464a07c8f1e2f97ec7ee92fda998d590\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32804}\", \"mirrored_builders\": [\"tryserver.chromium:win-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e0d412d8e2cb7bc7f86b8339cf387b734be15ed8\"}, \"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-i5ub\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1607661749268742",
"status": "COMPLETED",
"status_changed_ts": "1607678499500265",
"tags": [
"build_address:luci.chromium.ci/win-official/1151",
"builder:win-official",
"buildset:commit/git/e0d412d8e2cb7bc7f86b8339cf387b734be15ed8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e0d412d8e2cb7bc7f86b8339cf387b734be15ed8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026668284251458992",
"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/8861238220578059728/+/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:5068ec9dc6057910",
"user_agent:luci-scheduler"
],
"updated_ts": "1607678499505650",
"url": "https://ci.chromium.org/b/8861238220578059728",
"utcnow_ts": "1607678499757483"
}
}
[09:21:39.764] Invocation finished in 4h39m42.966468144s with status SUCCEEDED