[07:14:50.995] New invocation is queued and will start shortly
[07:14:52.097] Starting the invocation (attempt 1)
[07:14:52.155] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:14:52.157] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:14:52.158] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9033906421738208064",
"parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"9bca119b4660dc3e25a6b178d23ebcb4262bf2ba\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-official",
"scheduler_invocation_id:9033906421738208064",
"scheduler_job_id:chromium/win-official",
"user_agent:luci-scheduler",
"buildset:commit/git/9bca119b4660dc3e25a6b178d23ebcb4262bf2ba",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9bca119b4660dc3e25a6b178d23ebcb4262bf2ba",
"gitiles_ref:refs/heads/master"
]
}
[07:14:53.836] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1600758892349466",
"id": "8868476359654416384",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9bca119b4660dc3e25a6b178d23ebcb4262bf2ba\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1600758893517727",
"tags": [
"build_address:luci.chromium.ci/win-official/637",
"builder:win-official",
"buildset:commit/git/9bca119b4660dc3e25a6b178d23ebcb4262bf2ba",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9bca119b4660dc3e25a6b178d23ebcb4262bf2ba",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9033906421738208064",
"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/8868476359654416384/+/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": "1600758893517854",
"url": "https://ci.chromium.org/b/8868476359654416384",
"utcnow_ts": "1600758893787012"
}
}
[07:14:53.836] Task URL: https://ci.chromium.org/b/8868476359654416384
[07:14:53.836] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:2:0) after 1m0s
[07:15:34.290] Received PubSub notification, asking Buildbucket for the build status
[07:15:35.316] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:53.917] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:2:0)
[07:15:53.917] Timer tick, asking Buildbucket for the build status
[07:15:54.131] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:54.131] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:4:0) after 1m0s
[07:16:54.197] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:4:0)
[07:16:54.197] Timer tick, asking Buildbucket for the build status
[07:16:54.556] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:54.556] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:5:0) after 1m0s
[07:17:54.647] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:5:0)
[07:17:54.647] Timer tick, asking Buildbucket for the build status
[07:17:55.139] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:55.139] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:6:0) after 1m0s
[07:18:55.237] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:6:0)
[07:18:55.237] Timer tick, asking Buildbucket for the build status
[07:18:55.351] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:55.351] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:7:0) after 1m0s
[07:19:55.376] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:7:0)
[07:19:55.376] Timer tick, asking Buildbucket for the build status
[07:19:55.618] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:55.618] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:8:0) after 1m0s
[07:20:55.781] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:8:0)
[07:20:55.781] Timer tick, asking Buildbucket for the build status
[07:20:56.097] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:56.097] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:9:0) after 1m0s
[07:21:56.165] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:9:0)
[07:21:56.165] Timer tick, asking Buildbucket for the build status
[07:21:56.402] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:56.402] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:10:0) after 1m0s
[07:22:56.675] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:10:0)
[07:22:56.675] Timer tick, asking Buildbucket for the build status
[07:22:57.104] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:57.104] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:11:0) after 1m0s
[07:23:57.296] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:11:0)
[07:23:57.296] Timer tick, asking Buildbucket for the build status
[07:23:57.590] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:57.590] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:12:0) after 1m0s
[07:24:57.696] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:12:0)
[07:24:57.696] Timer tick, asking Buildbucket for the build status
[07:24:58.212] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:58.212] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:13:0) after 1m0s
[07:25:58.259] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:13:0)
[07:25:58.259] Timer tick, asking Buildbucket for the build status
[07:25:58.428] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:58.428] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:14:0) after 1m0s
[07:26:58.502] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:14:0)
[07:26:58.502] Timer tick, asking Buildbucket for the build status
[07:27:01.097] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:01.097] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:15:0) after 1m0s
[07:28:02.085] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:15:0)
[07:28:02.085] Timer tick, asking Buildbucket for the build status
[07:28:02.317] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:02.317] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:16:0) after 1m0s
[07:29:03.865] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:16:0)
[07:29:03.865] Timer tick, asking Buildbucket for the build status
[07:29:03.993] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:03.993] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:17:0) after 1m0s
[07:30:04.059] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:17:0)
[07:30:04.059] Timer tick, asking Buildbucket for the build status
[07:30:04.433] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:04.433] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:18:0) after 1m0s
[07:31:04.486] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:18:0)
[07:31:04.486] Timer tick, asking Buildbucket for the build status
[07:31:04.854] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:04.854] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:19:0) after 1m0s
[07:32:04.849] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:19:0)
[07:32:04.849] Timer tick, asking Buildbucket for the build status
[07:32:05.189] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:05.189] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:20:0) after 1m0s
[07:33:05.279] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:20:0)
[07:33:05.279] Timer tick, asking Buildbucket for the build status
[07:33:05.421] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:05.421] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:21:0) after 1m0s
[07:34:05.546] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:21:0)
[07:34:05.546] Timer tick, asking Buildbucket for the build status
[07:34:05.799] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:05.799] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:22:0) after 1m0s
[07:35:06.114] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:22:0)
[07:35:06.114] Timer tick, asking Buildbucket for the build status
[07:35:06.550] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:06.551] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:23:0) after 1m0s
[07:36:06.747] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:23:0)
[07:36:06.747] Timer tick, asking Buildbucket for the build status
[07:36:07.303] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:07.303] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:24:0) after 1m0s
[07:37:07.386] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:24:0)
[07:37:07.386] Timer tick, asking Buildbucket for the build status
[07:37:07.816] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:07.816] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:25:0) after 1m0s
[07:38:07.986] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:25:0)
[07:38:07.986] Timer tick, asking Buildbucket for the build status
[07:38:08.428] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:08.428] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:26:0) after 1m0s
[07:39:08.515] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:26:0)
[07:39:08.515] Timer tick, asking Buildbucket for the build status
[07:39:08.699] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:08.699] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:27:0) after 1m0s
[07:40:08.750] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:27:0)
[07:40:08.751] Timer tick, asking Buildbucket for the build status
[07:40:09.005] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:09.005] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:28:0) after 1m0s
[07:41:09.046] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:28:0)
[07:41:09.046] Timer tick, asking Buildbucket for the build status
[07:41:09.198] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:09.198] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:29:0) after 1m0s
[07:42:09.239] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:29:0)
[07:42:09.239] Timer tick, asking Buildbucket for the build status
[07:42:09.421] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:09.421] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:30:0) after 1m0s
[07:43:09.463] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:30:0)
[07:43:09.464] Timer tick, asking Buildbucket for the build status
[07:43:09.827] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:09.827] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:31:0) after 1m0s
[07:44:09.887] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:31:0)
[07:44:09.887] Timer tick, asking Buildbucket for the build status
[07:44:10.798] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:10.798] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:32:0) after 1m0s
[07:45:10.986] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:32:0)
[07:45:10.986] Timer tick, asking Buildbucket for the build status
[07:45:11.629] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:11.629] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:33:0) after 1m0s
[07:46:11.696] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:33:0)
[07:46:11.696] Timer tick, asking Buildbucket for the build status
[07:46:11.926] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:11.926] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:34:0) after 1m0s
[07:47:11.951] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:34:0)
[07:47:11.951] Timer tick, asking Buildbucket for the build status
[07:47:12.315] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:12.315] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:35:0) after 1m0s
[07:48:12.330] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:35:0)
[07:48:12.330] Timer tick, asking Buildbucket for the build status
[07:48:12.623] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:12.623] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:36:0) after 1m0s
[07:49:12.712] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:36:0)
[07:49:12.712] Timer tick, asking Buildbucket for the build status
[07:49:12.892] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:12.892] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:37:0) after 1m0s
[07:50:12.974] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:37:0)
[07:50:12.974] Timer tick, asking Buildbucket for the build status
[07:50:13.320] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:13.320] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:38:0) after 1m0s
[07:51:13.347] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:38:0)
[07:51:13.347] Timer tick, asking Buildbucket for the build status
[07:51:13.506] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:13.507] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:39:0) after 1m0s
[07:52:13.572] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:39:0)
[07:52:13.572] Timer tick, asking Buildbucket for the build status
[07:52:13.810] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:13.810] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:40:0) after 1m0s
[07:53:13.867] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:40:0)
[07:53:13.867] Timer tick, asking Buildbucket for the build status
[07:53:14.087] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:14.087] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:41:0) after 1m0s
[07:54:14.122] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:41:0)
[07:54:14.122] Timer tick, asking Buildbucket for the build status
[07:54:14.322] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:14.322] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:42:0) after 1m0s
[07:55:14.495] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:42:0)
[07:55:14.495] Timer tick, asking Buildbucket for the build status
[07:55:15.014] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:15.014] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:43:0) after 1m0s
[07:56:15.217] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:43:0)
[07:56:15.217] Timer tick, asking Buildbucket for the build status
[07:56:15.409] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:15.410] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:44:0) after 1m0s
[07:57:15.568] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:44:0)
[07:57:15.568] Timer tick, asking Buildbucket for the build status
[07:57:15.716] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:15.716] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:45:0) after 1m0s
[07:58:15.739] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:45:0)
[07:58:15.739] Timer tick, asking Buildbucket for the build status
[07:58:16.016] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:16.016] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:46:0) after 1m0s
[07:59:16.125] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:46:0)
[07:59:16.125] Timer tick, asking Buildbucket for the build status
[07:59:16.297] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:16.298] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:47:0) after 1m0s
[08:00:16.343] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:47:0)
[08:00:16.344] Timer tick, asking Buildbucket for the build status
[08:00:16.711] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:16.711] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:48:0) after 1m0s
[08:01:16.775] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:48:0)
[08:01:16.775] Timer tick, asking Buildbucket for the build status
[08:01:17.241] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:17.241] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:49:0) after 1m0s
[08:02:17.439] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:49:0)
[08:02:17.439] Timer tick, asking Buildbucket for the build status
[08:02:17.999] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:17.999] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:50:0) after 1m0s
[08:03:18.192] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:50:0)
[08:03:18.192] Timer tick, asking Buildbucket for the build status
[08:03:18.618] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:18.619] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:51:0) after 1m0s
[08:04:18.676] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:51:0)
[08:04:18.676] Timer tick, asking Buildbucket for the build status
[08:04:19.125] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:19.125] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:52:0) after 1m0s
[08:05:19.384] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:52:0)
[08:05:19.384] Timer tick, asking Buildbucket for the build status
[08:05:21.444] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:21.444] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:53:0) after 1m0s
[08:06:21.496] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:53:0)
[08:06:21.496] Timer tick, asking Buildbucket for the build status
[08:06:21.692] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:21.692] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:54:0) after 1m0s
[08:07:21.751] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:54:0)
[08:07:21.751] Timer tick, asking Buildbucket for the build status
[08:07:21.910] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:21.910] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:55:0) after 1m0s
[08:08:21.950] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:55:0)
[08:08:21.950] Timer tick, asking Buildbucket for the build status
[08:08:22.311] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:22.311] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:56:0) after 1m0s
[08:09:22.367] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:56:0)
[08:09:22.367] Timer tick, asking Buildbucket for the build status
[08:09:22.599] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:22.599] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:57:0) after 1m0s
[08:10:22.734] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:57:0)
[08:10:22.734] Timer tick, asking Buildbucket for the build status
[08:10:22.947] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:22.947] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:58:0) after 1m0s
[08:11:23.068] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:58:0)
[08:11:23.068] Timer tick, asking Buildbucket for the build status
[08:11:23.416] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:23.416] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:59:0) after 1m0s
[08:12:23.434] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:59:0)
[08:12:23.434] Timer tick, asking Buildbucket for the build status
[08:12:25.427] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:25.427] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:60:0) after 1m0s
[08:13:25.476] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:60:0)
[08:13:25.476] Timer tick, asking Buildbucket for the build status
[08:13:25.713] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:25.713] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:61:0) after 1m0s
[08:14:25.786] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:61:0)
[08:14:25.786] Timer tick, asking Buildbucket for the build status
[08:14:26.054] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:26.054] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:62:0) after 1m0s
[08:15:26.182] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:62:0)
[08:15:26.182] Timer tick, asking Buildbucket for the build status
[08:15:26.651] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:26.651] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:63:0) after 1m0s
[08:16:26.689] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:63:0)
[08:16:26.689] Timer tick, asking Buildbucket for the build status
[08:16:26.844] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:26.844] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:64:0) after 1m0s
[08:17:26.888] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:64:0)
[08:17:26.888] Timer tick, asking Buildbucket for the build status
[08:17:27.024] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:27.024] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:65:0) after 1m0s
[08:18:27.098] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:65:0)
[08:18:27.098] Timer tick, asking Buildbucket for the build status
[08:18:27.444] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:27.444] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:66:0) after 1m0s
[08:19:27.552] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:66:0)
[08:19:27.552] Timer tick, asking Buildbucket for the build status
[08:19:27.694] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:27.694] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:67:0) after 1m0s
[08:20:27.724] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:67:0)
[08:20:27.724] Timer tick, asking Buildbucket for the build status
[08:20:28.606] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:28.606] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:68:0) after 1m0s
[08:21:28.627] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:68:0)
[08:21:28.627] Timer tick, asking Buildbucket for the build status
[08:21:28.801] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:28.801] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:69:0) after 1m0s
[08:22:28.825] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:69:0)
[08:22:28.825] Timer tick, asking Buildbucket for the build status
[08:22:28.995] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:28.995] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:70:0) after 1m0s
[08:23:29.072] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:70:0)
[08:23:29.072] Timer tick, asking Buildbucket for the build status
[08:23:29.323] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:29.323] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:71:0) after 1m0s
[08:24:29.470] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:71:0)
[08:24:29.470] Timer tick, asking Buildbucket for the build status
[08:24:29.986] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:29.986] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:72:0) after 1m0s
[08:25:30.138] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:72:0)
[08:25:30.138] Timer tick, asking Buildbucket for the build status
[08:25:30.718] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:30.718] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:73:0) after 1m0s
[08:26:30.764] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:73:0)
[08:26:30.764] Timer tick, asking Buildbucket for the build status
[08:26:31.016] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:31.016] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:74:0) after 1m0s
[08:27:31.051] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:74:0)
[08:27:31.051] Timer tick, asking Buildbucket for the build status
[08:27:31.192] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:31.192] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:75:0) after 1m0s
[08:28:31.294] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:75:0)
[08:28:31.294] Timer tick, asking Buildbucket for the build status
[08:28:31.511] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:31.511] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:76:0) after 1m0s
[08:29:31.561] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:76:0)
[08:29:31.561] Timer tick, asking Buildbucket for the build status
[08:29:31.919] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:31.919] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:77:0) after 1m0s
[08:30:31.984] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:77:0)
[08:30:31.984] Timer tick, asking Buildbucket for the build status
[08:30:32.807] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:32.807] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:78:0) after 1m0s
[08:31:32.843] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:78:0)
[08:31:32.843] Timer tick, asking Buildbucket for the build status
[08:31:33.117] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:33.117] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:79:0) after 1m0s
[08:32:33.178] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:79:0)
[08:32:33.178] Timer tick, asking Buildbucket for the build status
[08:32:33.315] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:33.315] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:80:0) after 1m0s
[08:33:33.477] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:80:0)
[08:33:33.477] Timer tick, asking Buildbucket for the build status
[08:33:33.814] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:33.814] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:81:0) after 1m0s
[08:34:33.906] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:81:0)
[08:34:33.906] Timer tick, asking Buildbucket for the build status
[08:34:34.151] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:34.151] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:82:0) after 1m0s
[08:35:34.311] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:82:0)
[08:35:34.311] Timer tick, asking Buildbucket for the build status
[08:35:34.870] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:34.870] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:83:0) after 1m0s
[08:36:34.990] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:83:0)
[08:36:34.990] Timer tick, asking Buildbucket for the build status
[08:36:36.678] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:36.678] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:84:0) after 1m0s
[08:37:36.701] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:84:0)
[08:37:36.701] Timer tick, asking Buildbucket for the build status
[08:37:37.028] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:37.028] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:85:0) after 1m0s
[08:38:37.114] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:85:0)
[08:38:37.114] Timer tick, asking Buildbucket for the build status
[08:38:37.393] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:37.393] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:86:0) after 1m0s
[08:39:37.882] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:86:0)
[08:39:37.882] Timer tick, asking Buildbucket for the build status
[08:39:38.591] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:38.591] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:87:0) after 1m0s
[08:40:38.709] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:87:0)
[08:40:38.709] Timer tick, asking Buildbucket for the build status
[08:40:39.210] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:39.211] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:88:0) after 1m0s
[08:41:39.296] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:88:0)
[08:41:39.296] Timer tick, asking Buildbucket for the build status
[08:41:39.491] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:39.491] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:89:0) after 1m0s
[08:42:39.675] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:89:0)
[08:42:39.675] Timer tick, asking Buildbucket for the build status
[08:42:39.924] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:39.924] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:90:0) after 1m0s
[08:43:40.343] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:90:0)
[08:43:40.343] Timer tick, asking Buildbucket for the build status
[08:43:40.820] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:40.820] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:91:0) after 1m0s
[08:44:41.028] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:91:0)
[08:44:41.028] Timer tick, asking Buildbucket for the build status
[08:44:41.416] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:41.417] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:92:0) after 1m0s
[08:45:41.621] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:92:0)
[08:45:41.621] Timer tick, asking Buildbucket for the build status
[08:45:42.006] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:42.006] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:93:0) after 1m0s
[08:46:42.422] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:93:0)
[08:46:42.422] Timer tick, asking Buildbucket for the build status
[08:46:42.632] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:42.632] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:94:0) after 1m0s
[08:47:42.746] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:94:0)
[08:47:42.746] Timer tick, asking Buildbucket for the build status
[08:47:44.272] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:44.272] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:95:0) after 1m0s
[08:48:44.455] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:95:0)
[08:48:44.455] Timer tick, asking Buildbucket for the build status
[08:48:44.525] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:44.525] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:96:0) after 1m0s
[08:49:44.646] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:96:0)
[08:49:44.646] Timer tick, asking Buildbucket for the build status
[08:49:44.792] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:44.792] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:97:0) after 1m0s
[08:50:44.864] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:97:0)
[08:50:44.864] Timer tick, asking Buildbucket for the build status
[08:50:45.640] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:45.640] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:98:0) after 1m0s
[08:51:45.823] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:98:0)
[08:51:45.823] Timer tick, asking Buildbucket for the build status
[08:51:46.112] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:46.112] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:99:0) after 1m0s
[08:52:46.197] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:99:0)
[08:52:46.197] Timer tick, asking Buildbucket for the build status
[08:52:46.726] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:46.726] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:100:0) after 1m0s
[08:53:46.794] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:100:0)
[08:53:46.794] Timer tick, asking Buildbucket for the build status
[08:53:47.657] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:47.657] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:101:0) after 1m0s
[08:54:47.689] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:101:0)
[08:54:47.689] Timer tick, asking Buildbucket for the build status
[08:54:47.916] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:47.916] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:102:0) after 1m0s
[08:55:47.972] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:102:0)
[08:55:47.972] Timer tick, asking Buildbucket for the build status
[08:55:48.416] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:48.416] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:103:0) after 1m0s
[08:56:48.532] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:103:0)
[08:56:48.532] Timer tick, asking Buildbucket for the build status
[08:56:48.713] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:48.713] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:104:0) after 1m0s
[08:57:48.771] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:104:0)
[08:57:48.771] Timer tick, asking Buildbucket for the build status
[08:57:49.211] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:49.211] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:105:0) after 1m0s
[08:58:49.288] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:105:0)
[08:58:49.288] Timer tick, asking Buildbucket for the build status
[08:58:49.862] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:49.862] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:106:0) after 1m0s
[08:59:49.914] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:106:0)
[08:59:49.914] Timer tick, asking Buildbucket for the build status
[08:59:50.107] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:50.107] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:107:0) after 1m0s
[09:00:50.274] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:107:0)
[09:00:50.274] Timer tick, asking Buildbucket for the build status
[09:00:50.712] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:50.712] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:108:0) after 1m0s
[09:01:50.759] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:108:0)
[09:01:50.759] Timer tick, asking Buildbucket for the build status
[09:01:51.003] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:51.003] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:109:0) after 1m0s
[09:02:51.029] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:109:0)
[09:02:51.029] Timer tick, asking Buildbucket for the build status
[09:02:51.125] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:51.125] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:110:0) after 1m0s
[09:03:51.163] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:110:0)
[09:03:51.163] Timer tick, asking Buildbucket for the build status
[09:03:51.820] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:51.820] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:111:0) after 1m0s
[09:04:51.877] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:111:0)
[09:04:51.877] Timer tick, asking Buildbucket for the build status
[09:04:52.338] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:52.338] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:112:0) after 1m0s
[09:05:52.356] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:112:0)
[09:05:52.356] Timer tick, asking Buildbucket for the build status
[09:05:52.695] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:52.695] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:113:0) after 1m0s
[09:06:52.792] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:113:0)
[09:06:52.792] Timer tick, asking Buildbucket for the build status
[09:06:53.017] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:53.017] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:114:0) after 1m0s
[09:07:53.076] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:114:0)
[09:07:53.076] Timer tick, asking Buildbucket for the build status
[09:07:53.513] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:53.513] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:115:0) after 1m0s
[09:08:53.719] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:115:0)
[09:08:53.719] Timer tick, asking Buildbucket for the build status
[09:08:54.009] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:54.009] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:116:0) after 1m0s
[09:09:54.167] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:116:0)
[09:09:54.167] Timer tick, asking Buildbucket for the build status
[09:09:54.304] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:54.304] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:117:0) after 1m0s
[09:10:54.359] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:117:0)
[09:10:54.359] Timer tick, asking Buildbucket for the build status
[09:10:54.703] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:54.703] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:118:0) after 1m0s
[09:11:54.751] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:118:0)
[09:11:54.751] Timer tick, asking Buildbucket for the build status
[09:11:54.834] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:54.834] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:119:0) after 1m0s
[09:12:54.912] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:119:0)
[09:12:54.912] Timer tick, asking Buildbucket for the build status
[09:12:55.205] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:55.205] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:120:0) after 1m0s
[09:13:55.328] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:120:0)
[09:13:55.328] Timer tick, asking Buildbucket for the build status
[09:13:55.519] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:55.519] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:121:0) after 1m0s
[09:14:55.601] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:121:0)
[09:14:55.601] Timer tick, asking Buildbucket for the build status
[09:14:55.820] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:55.820] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:122:0) after 1m0s
[09:15:55.868] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:122:0)
[09:15:55.868] Timer tick, asking Buildbucket for the build status
[09:15:56.498] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:56.498] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:123:0) after 1m0s
[09:16:56.638] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:123:0)
[09:16:56.638] Timer tick, asking Buildbucket for the build status
[09:16:56.959] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:56.959] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:124:0) after 1m0s
[09:17:57.051] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:124:0)
[09:17:57.051] Timer tick, asking Buildbucket for the build status
[09:17:57.142] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:57.142] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:125:0) after 1m0s
[09:18:57.280] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:125:0)
[09:18:57.280] Timer tick, asking Buildbucket for the build status
[09:18:57.583] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:57.583] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:126:0) after 1m0s
[09:19:58.128] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:126:0)
[09:19:58.128] Timer tick, asking Buildbucket for the build status
[09:19:58.782] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:58.782] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:127:0) after 1m0s
[09:20:58.868] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:127:0)
[09:20:58.868] Timer tick, asking Buildbucket for the build status
[09:20:59.544] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:59.544] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:128:0) after 1m0s
[09:21:59.647] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:128:0)
[09:21:59.647] Timer tick, asking Buildbucket for the build status
[09:22:00.211] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:00.211] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:129:0) after 1m0s
[09:23:00.353] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:129:0)
[09:23:00.353] Timer tick, asking Buildbucket for the build status
[09:23:00.730] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:00.730] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:130:0) after 1m0s
[09:24:02.483] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:130:0)
[09:24:02.483] Timer tick, asking Buildbucket for the build status
[09:24:02.804] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:02.804] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:131:0) after 1m0s
[09:25:02.835] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:131:0)
[09:25:02.835] Timer tick, asking Buildbucket for the build status
[09:25:03.020] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:03.020] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:132:0) after 1m0s
[09:26:04.227] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:132:0)
[09:26:04.227] Timer tick, asking Buildbucket for the build status
[09:26:04.508] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:04.508] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:133:0) after 1m0s
[09:27:04.803] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:133:0)
[09:27:04.803] Timer tick, asking Buildbucket for the build status
[09:27:05.121] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:05.121] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:134:0) after 1m0s
[09:28:05.149] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:134:0)
[09:28:05.149] Timer tick, asking Buildbucket for the build status
[09:28:05.409] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:05.409] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:135:0) after 1m0s
[09:29:05.558] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:135:0)
[09:29:05.558] Timer tick, asking Buildbucket for the build status
[09:29:05.983] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:05.983] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:136:0) after 1m0s
[09:30:06.105] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:136:0)
[09:30:06.105] Timer tick, asking Buildbucket for the build status
[09:30:06.241] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:06.241] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:137:0) after 1m0s
[09:31:06.459] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:137:0)
[09:31:06.459] Timer tick, asking Buildbucket for the build status
[09:31:07.202] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:07.202] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:138:0) after 1m0s
[09:32:07.301] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:138:0)
[09:32:07.301] Timer tick, asking Buildbucket for the build status
[09:32:07.868] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:07.868] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:139:0) after 1m0s
[09:33:07.939] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:139:0)
[09:33:07.939] Timer tick, asking Buildbucket for the build status
[09:33:08.933] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:08.933] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:140:0) after 1m0s
[09:34:08.970] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:140:0)
[09:34:08.970] Timer tick, asking Buildbucket for the build status
[09:34:09.094] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:09.094] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:141:0) after 1m0s
[09:35:09.251] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:141:0)
[09:35:09.251] Timer tick, asking Buildbucket for the build status
[09:35:09.431] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:09.432] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:142:0) after 1m0s
[09:36:09.483] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:142:0)
[09:36:09.483] Timer tick, asking Buildbucket for the build status
[09:36:09.831] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:09.831] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:143:0) after 1m0s
[09:37:09.881] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:143:0)
[09:37:09.881] Timer tick, asking Buildbucket for the build status
[09:37:10.002] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:10.002] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:144:0) after 1m0s
[09:38:10.149] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:144:0)
[09:38:10.149] Timer tick, asking Buildbucket for the build status
[09:38:10.895] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:10.895] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:145:0) after 1m0s
[09:39:10.975] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:145:0)
[09:39:10.975] Timer tick, asking Buildbucket for the build status
[09:39:11.209] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:11.209] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:146:0) after 1m0s
[09:40:11.339] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:146:0)
[09:40:11.339] Timer tick, asking Buildbucket for the build status
[09:40:11.597] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:11.597] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:147:0) after 1m0s
[09:41:11.734] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:147:0)
[09:41:11.734] Timer tick, asking Buildbucket for the build status
[09:41:12.469] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:12.469] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:148:0) after 1m0s
[09:42:12.539] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:148:0)
[09:42:12.539] Timer tick, asking Buildbucket for the build status
[09:42:13.053] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:13.053] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:149:0) after 1m0s
[09:43:13.033] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:149:0)
[09:43:13.033] Timer tick, asking Buildbucket for the build status
[09:43:13.201] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:13.201] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:150:0) after 1m0s
[09:44:13.292] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:150:0)
[09:44:13.292] Timer tick, asking Buildbucket for the build status
[09:44:13.743] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:13.743] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:151:0) after 1m0s
[09:45:13.877] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:151:0)
[09:45:13.877] Timer tick, asking Buildbucket for the build status
[09:45:14.219] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:14.219] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:152:0) after 1m0s
[09:46:14.460] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:152:0)
[09:46:14.460] Timer tick, asking Buildbucket for the build status
[09:46:14.924] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:14.924] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:153:0) after 1m0s
[09:47:15.004] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:153:0)
[09:47:15.004] Timer tick, asking Buildbucket for the build status
[09:47:15.127] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:15.127] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:154:0) after 1m0s
[09:48:15.266] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:154:0)
[09:48:15.266] Timer tick, asking Buildbucket for the build status
[09:48:15.505] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:15.505] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:155:0) after 1m0s
[09:49:15.740] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:155:0)
[09:49:15.740] Timer tick, asking Buildbucket for the build status
[09:49:16.033] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:16.033] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:156:0) after 1m0s
[09:50:16.239] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:156:0)
[09:50:16.239] Timer tick, asking Buildbucket for the build status
[09:50:16.503] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:16.503] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:157:0) after 1m0s
[09:51:16.593] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:157:0)
[09:51:16.593] Timer tick, asking Buildbucket for the build status
[09:51:17.532] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:17.532] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:158:0) after 1m0s
[09:52:17.556] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:158:0)
[09:52:17.556] Timer tick, asking Buildbucket for the build status
[09:52:17.615] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:17.615] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:159:0) after 1m0s
[09:53:17.686] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:159:0)
[09:53:17.686] Timer tick, asking Buildbucket for the build status
[09:53:17.897] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:17.897] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:160:0) after 1m0s
[09:54:17.958] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:160:0)
[09:54:17.958] Timer tick, asking Buildbucket for the build status
[09:54:18.200] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:18.200] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:161:0) after 1m0s
[09:55:18.293] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:161:0)
[09:55:18.294] Timer tick, asking Buildbucket for the build status
[09:55:18.776] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:18.776] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:162:0) after 1m0s
[09:56:18.855] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:162:0)
[09:56:18.855] Timer tick, asking Buildbucket for the build status
[09:56:19.308] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:19.308] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:163:0) after 1m0s
[09:57:19.339] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:163:0)
[09:57:19.339] Timer tick, asking Buildbucket for the build status
[09:57:19.728] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:19.728] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:164:0) after 1m0s
[09:58:19.732] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:164:0)
[09:58:19.732] Timer tick, asking Buildbucket for the build status
[09:58:20.023] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:20.023] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:165:0) after 1m0s
[09:59:20.094] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:165:0)
[09:59:20.094] Timer tick, asking Buildbucket for the build status
[09:59:20.590] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:20.590] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:166:0) after 1m0s
[10:00:20.640] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:166:0)
[10:00:20.640] Timer tick, asking Buildbucket for the build status
[10:00:20.798] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:20.798] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:167:0) after 1m0s
[10:01:20.866] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:167:0)
[10:01:20.866] Timer tick, asking Buildbucket for the build status
[10:01:21.447] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:21.447] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:168:0) after 1m0s
[10:02:21.535] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:168:0)
[10:02:21.535] Timer tick, asking Buildbucket for the build status
[10:02:22.231] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:22.231] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:169:0) after 1m0s
[10:03:22.293] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:169:0)
[10:03:22.294] Timer tick, asking Buildbucket for the build status
[10:03:22.667] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:22.667] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:170:0) after 1m0s
[10:04:22.745] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:170:0)
[10:04:22.745] Timer tick, asking Buildbucket for the build status
[10:04:23.041] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:23.042] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:171:0) after 1m0s
[10:05:23.120] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:171:0)
[10:05:23.120] Timer tick, asking Buildbucket for the build status
[10:05:23.542] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:23.542] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:172:0) after 1m0s
[10:06:23.628] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:172:0)
[10:06:23.628] Timer tick, asking Buildbucket for the build status
[10:06:24.117] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:24.117] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:173:0) after 1m0s
[10:07:24.358] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:173:0)
[10:07:24.358] Timer tick, asking Buildbucket for the build status
[10:07:24.717] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:24.717] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:174:0) after 1m0s
[10:08:24.727] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:174:0)
[10:08:24.727] Timer tick, asking Buildbucket for the build status
[10:08:25.021] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:25.021] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:175:0) after 1m0s
[10:09:25.069] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:175:0)
[10:09:25.069] Timer tick, asking Buildbucket for the build status
[10:09:25.570] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:25.570] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:176:0) after 1m0s
[10:10:25.618] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:176:0)
[10:10:25.618] Timer tick, asking Buildbucket for the build status
[10:10:26.984] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:26.984] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:177:0) after 1m0s
[10:11:27.222] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:177:0)
[10:11:27.222] Timer tick, asking Buildbucket for the build status
[10:11:27.590] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:27.590] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:178:0) after 1m0s
[10:12:27.665] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:178:0)
[10:12:27.665] Timer tick, asking Buildbucket for the build status
[10:12:28.143] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:28.143] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:179:0) after 1m0s
[10:13:28.382] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:179:0)
[10:13:28.382] Timer tick, asking Buildbucket for the build status
[10:13:29.034] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:29.034] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:180:0) after 1m0s
[10:14:29.365] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:180:0)
[10:14:29.365] Timer tick, asking Buildbucket for the build status
[10:14:29.713] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:29.713] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:181:0) after 1m0s
[10:15:29.780] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:181:0)
[10:15:29.780] Timer tick, asking Buildbucket for the build status
[10:15:29.897] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:29.897] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:182:0) after 1m0s
[10:16:30.028] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:182:0)
[10:16:30.028] Timer tick, asking Buildbucket for the build status
[10:16:30.528] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:30.528] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:183:0) after 1m0s
[10:17:30.793] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:183:0)
[10:17:30.793] Timer tick, asking Buildbucket for the build status
[10:17:30.882] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:30.882] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:184:0) after 1m0s
[10:18:30.947] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:184:0)
[10:18:30.947] Timer tick, asking Buildbucket for the build status
[10:18:31.022] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:31.022] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:185:0) after 1m0s
[10:19:31.127] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:185:0)
[10:19:31.127] Timer tick, asking Buildbucket for the build status
[10:19:31.209] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:31.209] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:186:0) after 1m0s
[10:20:31.301] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:186:0)
[10:20:31.301] Timer tick, asking Buildbucket for the build status
[10:20:31.493] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:31.493] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:187:0) after 1m0s
[10:21:31.535] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:187:0)
[10:21:31.535] Timer tick, asking Buildbucket for the build status
[10:21:32.276] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:32.276] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:188:0) after 1m0s
[10:22:32.397] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:188:0)
[10:22:32.397] Timer tick, asking Buildbucket for the build status
[10:22:33.309] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:33.309] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:189:0) after 1m0s
[10:23:33.390] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:189:0)
[10:23:33.390] Timer tick, asking Buildbucket for the build status
[10:23:33.500] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:33.500] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:190:0) after 1m0s
[10:24:33.593] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:190:0)
[10:24:33.593] Timer tick, asking Buildbucket for the build status
[10:24:33.796] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:33.796] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:191:0) after 1m0s
[10:25:33.876] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:191:0)
[10:25:33.876] Timer tick, asking Buildbucket for the build status
[10:25:33.936] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:33.936] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:192:0) after 1m0s
[10:26:34.138] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:192:0)
[10:26:34.138] Timer tick, asking Buildbucket for the build status
[10:26:34.529] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:34.529] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:193:0) after 1m0s
[10:27:34.668] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:193:0)
[10:27:34.668] Timer tick, asking Buildbucket for the build status
[10:27:37.914] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:37.914] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:194:0) after 1m0s
[10:28:38.027] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:194:0)
[10:28:38.027] Timer tick, asking Buildbucket for the build status
[10:28:39.593] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:39.593] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:195:0) after 1m0s
[10:29:39.641] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:195:0)
[10:29:39.641] Timer tick, asking Buildbucket for the build status
[10:29:41.917] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:41.917] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:196:0) after 1m0s
[10:30:41.984] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:196:0)
[10:30:41.984] Timer tick, asking Buildbucket for the build status
[10:30:42.492] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:42.492] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:197:0) after 1m0s
[10:31:42.609] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:197:0)
[10:31:42.609] Timer tick, asking Buildbucket for the build status
[10:31:43.781] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:43.781] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:198:0) after 1m0s
[10:32:43.884] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:198:0)
[10:32:43.884] Timer tick, asking Buildbucket for the build status
[10:32:44.132] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:44.132] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:199:0) after 1m0s
[10:33:44.160] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:199:0)
[10:33:44.160] Timer tick, asking Buildbucket for the build status
[10:33:44.598] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:44.598] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:200:0) after 1m0s
[10:34:44.720] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:200:0)
[10:34:44.720] Timer tick, asking Buildbucket for the build status
[10:34:45.103] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:45.103] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:201:0) after 1m0s
[10:35:45.239] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:201:0)
[10:35:45.239] Timer tick, asking Buildbucket for the build status
[10:35:45.393] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:45.393] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:202:0) after 1m0s
[10:36:45.535] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:202:0)
[10:36:45.535] Timer tick, asking Buildbucket for the build status
[10:36:45.999] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:45.999] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:203:0) after 1m0s
[10:37:46.035] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:203:0)
[10:37:46.035] Timer tick, asking Buildbucket for the build status
[10:37:46.125] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:46.125] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:204:0) after 1m0s
[10:38:46.190] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:204:0)
[10:38:46.190] Timer tick, asking Buildbucket for the build status
[10:38:46.348] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:46.348] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:205:0) after 1m0s
[10:39:46.416] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:205:0)
[10:39:46.416] Timer tick, asking Buildbucket for the build status
[10:39:46.638] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:46.638] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:206:0) after 1m0s
[10:40:46.698] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:206:0)
[10:40:46.698] Timer tick, asking Buildbucket for the build status
[10:40:46.930] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:46.930] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:207:0) after 1m0s
[10:41:47.143] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:207:0)
[10:41:47.143] Timer tick, asking Buildbucket for the build status
[10:41:47.528] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:47.528] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:208:0) after 1m0s
[10:42:47.588] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:208:0)
[10:42:47.588] Timer tick, asking Buildbucket for the build status
[10:42:47.817] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:47.817] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:209:0) after 1m0s
[10:43:47.940] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:209:0)
[10:43:47.940] Timer tick, asking Buildbucket for the build status
[10:43:48.108] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:48.108] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:210:0) after 1m0s
[10:44:48.172] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:210:0)
[10:44:48.172] Timer tick, asking Buildbucket for the build status
[10:44:48.324] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:48.324] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:211:0) after 1m0s
[10:45:48.392] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:211:0)
[10:45:48.395] Timer tick, asking Buildbucket for the build status
[10:45:48.702] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:48.702] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:212:0) after 1m0s
[10:46:48.789] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:212:0)
[10:46:48.789] Timer tick, asking Buildbucket for the build status
[10:46:51.516] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:51.516] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:213:0) after 1m0s
[10:47:51.617] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:213:0)
[10:47:51.617] Timer tick, asking Buildbucket for the build status
[10:47:51.794] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:51.794] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:214:0) after 1m0s
[10:48:51.862] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:214:0)
[10:48:51.862] Timer tick, asking Buildbucket for the build status
[10:48:51.991] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:51.991] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:215:0) after 1m0s
[10:49:52.102] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:215:0)
[10:49:52.102] Timer tick, asking Buildbucket for the build status
[10:49:52.325] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:52.325] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:216:0) after 1m0s
[10:50:52.505] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:216:0)
[10:50:52.505] Timer tick, asking Buildbucket for the build status
[10:50:53.116] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:53.116] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:217:0) after 1m0s
[10:51:53.152] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:217:0)
[10:51:53.152] Timer tick, asking Buildbucket for the build status
[10:51:53.612] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:53.612] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:218:0) after 1m0s
[10:52:53.749] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:218:0)
[10:52:53.749] Timer tick, asking Buildbucket for the build status
[10:52:56.282] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:56.282] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:219:0) after 1m0s
[10:53:56.567] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:219:0)
[10:53:56.567] Timer tick, asking Buildbucket for the build status
[10:53:57.010] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:57.010] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:220:0) after 1m0s
[10:54:57.129] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:220:0)
[10:54:57.129] Timer tick, asking Buildbucket for the build status
[10:54:57.299] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:57.299] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:221:0) after 1m0s
[10:55:57.387] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:221:0)
[10:55:57.387] Timer tick, asking Buildbucket for the build status
[10:55:57.602] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:57.603] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:222:0) after 1m0s
[10:56:57.777] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:222:0)
[10:56:57.777] Timer tick, asking Buildbucket for the build status
[10:56:58.392] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:58.392] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:223:0) after 1m0s
[10:57:58.543] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:223:0)
[10:57:58.543] Timer tick, asking Buildbucket for the build status
[10:58:00.166] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:00.167] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:224:0) after 1m0s
[10:59:00.367] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:224:0)
[10:59:00.367] Timer tick, asking Buildbucket for the build status
[10:59:00.513] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:00.513] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:225:0) after 1m0s
[11:00:36.125] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:225:0)
[11:00:36.126] Timer tick, asking Buildbucket for the build status
[11:00:36.197] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:36.197] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:226:0) after 1m0s
[11:01:36.242] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:226:0)
[11:01:36.242] Timer tick, asking Buildbucket for the build status
[11:01:36.347] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:36.347] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:227:0) after 1m0s
[11:02:36.493] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:227:0)
[11:02:36.493] Timer tick, asking Buildbucket for the build status
[11:02:36.745] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:36.745] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:228:0) after 1m0s
[11:03:36.799] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:228:0)
[11:03:36.799] Timer tick, asking Buildbucket for the build status
[11:03:38.391] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:38.391] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:229:0) after 1m0s
[11:04:38.495] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:229:0)
[11:04:38.495] Timer tick, asking Buildbucket for the build status
[11:04:38.673] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:38.673] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:230:0) after 1m0s
[11:05:38.737] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:230:0)
[11:05:38.737] Timer tick, asking Buildbucket for the build status
[11:05:38.848] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:38.848] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:231:0) after 1m0s
[11:06:38.916] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:231:0)
[11:06:38.916] Timer tick, asking Buildbucket for the build status
[11:06:39.498] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:39.498] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:232:0) after 1m0s
[11:07:39.540] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:232:0)
[11:07:39.540] Timer tick, asking Buildbucket for the build status
[11:07:39.615] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:39.615] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:233:0) after 1m0s
[11:08:39.653] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:233:0)
[11:08:39.653] Timer tick, asking Buildbucket for the build status
[11:08:39.730] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:39.730] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:234:0) after 1m0s
[11:09:39.764] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:234:0)
[11:09:39.764] Timer tick, asking Buildbucket for the build status
[11:09:40.109] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:40.109] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:235:0) after 1m0s
[11:10:40.173] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:235:0)
[11:10:40.173] Timer tick, asking Buildbucket for the build status
[11:10:40.257] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:40.257] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:236:0) after 1m0s
[11:11:40.420] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:236:0)
[11:11:40.420] Timer tick, asking Buildbucket for the build status
[11:11:40.609] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:40.609] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:237:0) after 1m0s
[11:12:40.803] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:237:0)
[11:12:40.803] Timer tick, asking Buildbucket for the build status
[11:12:40.935] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:40.935] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:238:0) after 1m0s
[11:13:40.976] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:238:0)
[11:13:40.976] Timer tick, asking Buildbucket for the build status
[11:13:41.082] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:41.082] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:239:0) after 1m0s
[11:14:41.188] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:239:0)
[11:14:41.188] Timer tick, asking Buildbucket for the build status
[11:14:41.332] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:41.332] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:240:0) after 1m0s
[11:15:41.518] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:240:0)
[11:15:41.518] Timer tick, asking Buildbucket for the build status
[11:15:41.649] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:41.649] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:241:0) after 1m0s
[11:16:41.997] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:241:0)
[11:16:41.997] Timer tick, asking Buildbucket for the build status
[11:16:42.441] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:42.441] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:242:0) after 1m0s
[11:17:42.511] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:242:0)
[11:17:42.511] Timer tick, asking Buildbucket for the build status
[11:17:42.996] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:42.996] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:243:0) after 1m0s
[11:18:43.095] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:243:0)
[11:18:43.095] Timer tick, asking Buildbucket for the build status
[11:18:43.315] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:43.315] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:244:0) after 1m0s
[11:19:43.469] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:244:0)
[11:19:43.469] Timer tick, asking Buildbucket for the build status
[11:19:43.572] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:43.572] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:245:0) after 1m0s
[11:20:43.731] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:245:0)
[11:20:43.731] Timer tick, asking Buildbucket for the build status
[11:20:43.805] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:43.805] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:246:0) after 1m0s
[11:21:44.139] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:246:0)
[11:21:44.139] Timer tick, asking Buildbucket for the build status
[11:21:48.321] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:48.321] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:247:0) after 1m0s
[11:22:48.908] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:247:0)
[11:22:48.908] Timer tick, asking Buildbucket for the build status
[11:22:49.095] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:49.095] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:248:0) after 1m0s
[11:23:49.615] Handling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:248:0)
[11:23:49.615] Timer tick, asking Buildbucket for the build status
[11:23:49.939] Build 8868476359654416384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:49.939] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9033906421738208064:249:0) after 1m0s
[11:23:51.906] Received PubSub notification, asking Buildbucket for the build status
[11:23:52.033] Build 8868476359654416384: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:23:52.033] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1600773830830215",
"created_by": "project:chromium",
"created_ts": "1600758892349466",
"id": "8868476359654416384",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9bca119b4660dc3e25a6b178d23ebcb4262bf2ba\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"9bca119b4660dc3e25a6b178d23ebcb4262bf2ba\", \"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-3-9kkf\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 637, \"got_angle_revision\": \"5ec560fb8c75b408dcf6b87858f4d007051560eb\", \"got_dawn_revision\": \"52a588f3c9ba374630158cc045dfa311ed6a7584\", \"got_nacl_revision\": \"69a0d6e8affc94187af10e0673592d1b238c6eb0\", \"got_revision\": \"9bca119b4660dc3e25a6b178d23ebcb4262bf2ba\", \"got_revision_cp\": \"refs/heads/master@{#809223}\", \"got_swarming_client_revision\": \"44c13d73156581ea09b9389001e58c23a4b8d70a\", \"got_swiftshader_revision\": \"6aadd31a5f988b254046addce6aadaa650f098e9\", \"got_v8_revision\": \"ff52c73e00a4a1743dbef2b031ec8289aa89aefa\", \"got_v8_revision_cp\": \"refs/heads/8.7.151@{#1}\", \"got_webrtc_revision\": \"edd7f9e94d43312ee839e7bed9acc5d8eda7ae81\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32153}\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9bca119b4660dc3e25a6b178d23ebcb4262bf2ba\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_9b3ebe5fd1c5be87380c40d216747346a59b28cf26de183f0e8e2b32e944d3c8_v2\", \"git\", \"goma_v2\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-3-9kkf\"], \"image\": [\"chrome-win10-1703-20083100-22dcea0839e\"], \"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\": [\"5531-8ab19d9\"], \"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": "1600758912755114",
"status": "COMPLETED",
"status_changed_ts": "1600773831211870",
"tags": [
"build_address:luci.chromium.ci/win-official/637",
"builder:win-official",
"buildset:commit/git/9bca119b4660dc3e25a6b178d23ebcb4262bf2ba",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9bca119b4660dc3e25a6b178d23ebcb4262bf2ba",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9033906421738208064",
"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/8868476359654416384/+/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:4ecd7bd5ecab2f10",
"user_agent:luci-scheduler"
],
"updated_ts": "1600773831232771",
"url": "https://ci.chromium.org/b/8868476359654416384",
"utcnow_ts": "1600773832025392"
}
}
[11:23:52.033] Invocation finished in 4h9m1.055580317s with status SUCCEEDED