[06:37:18.637] New invocation is queued and will start shortly
[06:37:19.775] Starting the invocation (attempt 1)
[06:37:19.812] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:37:19.812] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:37:19.812] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9032187441147575024",
"parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"2a206a3e99bfa3d2741e7c372878f304ba8811be\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-official",
"scheduler_invocation_id:9032187441147575024",
"scheduler_job_id:chromium/win-official",
"user_agent:luci-scheduler",
"buildset:commit/git/2a206a3e99bfa3d2741e7c372878f304ba8811be",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2a206a3e99bfa3d2741e7c372878f304ba8811be",
"gitiles_ref:refs/heads/master"
]
}
[06:37:20.543] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1602398239889308",
"id": "8866757379167935744",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2a206a3e99bfa3d2741e7c372878f304ba8811be\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1602398240392369",
"tags": [
"build_address:luci.chromium.ci/win-official/788",
"builder:win-official",
"buildset:commit/git/2a206a3e99bfa3d2741e7c372878f304ba8811be",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2a206a3e99bfa3d2741e7c372878f304ba8811be",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9032187441147575024",
"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/8866757379167935744/+/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": "1602398240392520",
"url": "https://ci.chromium.org/b/8866757379167935744",
"utcnow_ts": "1602398240536059"
}
}
[06:37:20.543] Task URL: https://ci.chromium.org/b/8866757379167935744
[06:37:20.543] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:2:0) after 1m0s
[06:38:20.575] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:2:0)
[06:38:20.575] Timer tick, asking Buildbucket for the build status
[06:38:20.690] Build 8866757379167935744: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:38:20.690] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:3:0) after 1m0s
[06:38:22.550] Received PubSub notification, asking Buildbucket for the build status
[06:38:22.619] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:20.757] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:3:0)
[06:39:20.757] Timer tick, asking Buildbucket for the build status
[06:39:20.839] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:20.839] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:5:0) after 1m0s
[06:40:20.897] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:5:0)
[06:40:20.897] Timer tick, asking Buildbucket for the build status
[06:40:20.971] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:20.971] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:6:0) after 1m0s
[06:41:21.046] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:6:0)
[06:41:21.046] Timer tick, asking Buildbucket for the build status
[06:41:21.145] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:21.145] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:7:0) after 1m0s
[06:42:21.233] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:7:0)
[06:42:21.233] Timer tick, asking Buildbucket for the build status
[06:42:21.398] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:21.398] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:8:0) after 1m0s
[06:43:21.428] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:8:0)
[06:43:21.428] Timer tick, asking Buildbucket for the build status
[06:43:21.534] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:21.534] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:9:0) after 1m0s
[06:44:21.554] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:9:0)
[06:44:21.554] Timer tick, asking Buildbucket for the build status
[06:44:21.631] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:21.631] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:10:0) after 1m0s
[06:45:21.669] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:10:0)
[06:45:21.669] Timer tick, asking Buildbucket for the build status
[06:45:21.754] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:21.754] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:11:0) after 1m0s
[06:46:21.799] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:11:0)
[06:46:21.799] Timer tick, asking Buildbucket for the build status
[06:46:21.914] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:21.914] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:12:0) after 1m0s
[06:47:21.985] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:12:0)
[06:47:21.985] Timer tick, asking Buildbucket for the build status
[06:47:22.120] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:22.120] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:13:0) after 1m0s
[06:48:22.166] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:13:0)
[06:48:22.166] Timer tick, asking Buildbucket for the build status
[06:48:22.385] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:22.385] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:14:0) after 1m0s
[06:49:22.506] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:14:0)
[06:49:22.506] Timer tick, asking Buildbucket for the build status
[06:49:22.715] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:22.715] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:15:0) after 1m0s
[06:50:22.759] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:15:0)
[06:50:22.759] Timer tick, asking Buildbucket for the build status
[06:50:22.835] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:22.835] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:16:0) after 1m0s
[06:51:22.898] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:16:0)
[06:51:22.898] Timer tick, asking Buildbucket for the build status
[06:51:22.999] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:23.000] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:17:0) after 1m0s
[06:52:23.498] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:17:0)
[06:52:23.498] Timer tick, asking Buildbucket for the build status
[06:52:23.614] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:23.615] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:18:0) after 1m0s
[06:53:23.637] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:18:0)
[06:53:23.637] Timer tick, asking Buildbucket for the build status
[06:53:23.730] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:23.730] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:19:0) after 1m0s
[06:54:23.884] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:19:0)
[06:54:23.884] Timer tick, asking Buildbucket for the build status
[06:54:23.969] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:23.969] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:20:0) after 1m0s
[06:55:24.222] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:20:0)
[06:55:24.222] Timer tick, asking Buildbucket for the build status
[06:55:24.688] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:24.688] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:21:0) after 1m0s
[06:56:24.759] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:21:0)
[06:56:24.759] Timer tick, asking Buildbucket for the build status
[06:56:24.895] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:24.895] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:22:0) after 1m0s
[06:57:24.955] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:22:0)
[06:57:24.955] Timer tick, asking Buildbucket for the build status
[06:57:25.066] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:25.066] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:23:0) after 1m0s
[06:58:25.315] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:23:0)
[06:58:25.315] Timer tick, asking Buildbucket for the build status
[06:58:25.443] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:25.443] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:24:0) after 1m0s
[06:59:25.465] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:24:0)
[06:59:25.465] Timer tick, asking Buildbucket for the build status
[06:59:25.557] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:25.557] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:25:0) after 1m0s
[07:00:25.655] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:25:0)
[07:00:25.656] Timer tick, asking Buildbucket for the build status
[07:00:25.754] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:25.754] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:26:0) after 1m0s
[07:01:25.899] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:26:0)
[07:01:25.899] Timer tick, asking Buildbucket for the build status
[07:01:26.001] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:26.001] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:27:0) after 1m0s
[07:02:26.099] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:27:0)
[07:02:26.099] Timer tick, asking Buildbucket for the build status
[07:02:26.284] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:26.284] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:28:0) after 1m0s
[07:03:26.434] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:28:0)
[07:03:26.434] Timer tick, asking Buildbucket for the build status
[07:03:26.632] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:26.632] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:29:0) after 1m0s
[07:04:26.777] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:29:0)
[07:04:26.777] Timer tick, asking Buildbucket for the build status
[07:04:26.843] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:26.843] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:30:0) after 1m0s
[07:05:26.861] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:30:0)
[07:05:26.861] Timer tick, asking Buildbucket for the build status
[07:05:26.991] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:26.991] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:31:0) after 1m0s
[07:06:27.019] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:31:0)
[07:06:27.019] Timer tick, asking Buildbucket for the build status
[07:06:27.093] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:27.093] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:32:0) after 1m0s
[07:07:27.199] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:32:0)
[07:07:27.199] Timer tick, asking Buildbucket for the build status
[07:07:27.406] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:27.406] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:33:0) after 1m0s
[07:08:27.429] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:33:0)
[07:08:27.429] Timer tick, asking Buildbucket for the build status
[07:08:27.592] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:27.592] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:34:0) after 1m0s
[07:09:27.672] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:34:0)
[07:09:27.672] Timer tick, asking Buildbucket for the build status
[07:09:27.776] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:27.776] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:35:0) after 1m0s
[07:10:27.812] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:35:0)
[07:10:27.812] Timer tick, asking Buildbucket for the build status
[07:10:27.978] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:27.978] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:36:0) after 1m0s
[07:11:28.040] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:36:0)
[07:11:28.040] Timer tick, asking Buildbucket for the build status
[07:11:29.998] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:29.998] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:37:0) after 1m0s
[07:12:30.023] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:37:0)
[07:12:30.023] Timer tick, asking Buildbucket for the build status
[07:12:30.129] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:30.129] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:38:0) after 1m0s
[07:13:30.150] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:38:0)
[07:13:30.150] Timer tick, asking Buildbucket for the build status
[07:13:30.236] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:30.236] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:39:0) after 1m0s
[07:14:30.257] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:39:0)
[07:14:30.257] Timer tick, asking Buildbucket for the build status
[07:14:30.357] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:30.357] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:40:0) after 1m0s
[07:15:30.412] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:40:0)
[07:15:30.412] Timer tick, asking Buildbucket for the build status
[07:15:30.713] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:30.713] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:41:0) after 1m0s
[07:16:30.732] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:41:0)
[07:16:30.732] Timer tick, asking Buildbucket for the build status
[07:16:31.081] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:31.081] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:42:0) after 1m0s
[07:17:31.155] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:42:0)
[07:17:31.155] Timer tick, asking Buildbucket for the build status
[07:17:31.390] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:31.390] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:43:0) after 1m0s
[07:18:31.406] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:43:0)
[07:18:31.406] Timer tick, asking Buildbucket for the build status
[07:18:31.485] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:31.485] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:44:0) after 1m0s
[07:19:31.512] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:44:0)
[07:19:31.512] Timer tick, asking Buildbucket for the build status
[07:19:31.578] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:31.578] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:45:0) after 1m0s
[07:20:31.622] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:45:0)
[07:20:31.622] Timer tick, asking Buildbucket for the build status
[07:20:31.746] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:31.746] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:46:0) after 1m0s
[07:21:31.764] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:46:0)
[07:21:31.764] Timer tick, asking Buildbucket for the build status
[07:21:31.904] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:31.904] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:47:0) after 1m0s
[07:22:31.961] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:47:0)
[07:22:31.961] Timer tick, asking Buildbucket for the build status
[07:22:32.240] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:32.240] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:48:0) after 1m0s
[07:23:32.277] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:48:0)
[07:23:32.277] Timer tick, asking Buildbucket for the build status
[07:23:32.358] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:32.358] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:49:0) after 1m0s
[07:24:32.380] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:49:0)
[07:24:32.380] Timer tick, asking Buildbucket for the build status
[07:24:32.444] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:32.444] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:50:0) after 1m0s
[07:25:32.464] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:50:0)
[07:25:32.464] Timer tick, asking Buildbucket for the build status
[07:25:32.599] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:32.599] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:51:0) after 1m0s
[07:26:32.626] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:51:0)
[07:26:32.626] Timer tick, asking Buildbucket for the build status
[07:26:32.721] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:32.721] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:52:0) after 1m0s
[07:27:32.809] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:52:0)
[07:27:32.809] Timer tick, asking Buildbucket for the build status
[07:27:32.921] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:32.921] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:53:0) after 1m0s
[07:28:32.921] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:53:0)
[07:28:32.921] Timer tick, asking Buildbucket for the build status
[07:28:32.981] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:32.981] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:54:0) after 1m0s
[07:29:32.958] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:54:0)
[07:29:32.958] Timer tick, asking Buildbucket for the build status
[07:29:33.063] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:33.063] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:55:0) after 1m0s
[07:30:33.087] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:55:0)
[07:30:33.087] Timer tick, asking Buildbucket for the build status
[07:30:33.587] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:33.587] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:56:0) after 1m0s
[07:31:33.648] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:56:0)
[07:31:33.648] Timer tick, asking Buildbucket for the build status
[07:31:33.741] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:33.741] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:57:0) after 1m0s
[07:32:33.763] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:57:0)
[07:32:33.763] Timer tick, asking Buildbucket for the build status
[07:32:33.883] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:33.883] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:58:0) after 1m0s
[07:33:33.905] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:58:0)
[07:33:33.905] Timer tick, asking Buildbucket for the build status
[07:33:33.963] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:33.963] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:59:0) after 1m0s
[07:34:33.986] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:59:0)
[07:34:33.986] Timer tick, asking Buildbucket for the build status
[07:34:34.103] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:34.103] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:60:0) after 1m0s
[07:35:34.156] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:60:0)
[07:35:34.156] Timer tick, asking Buildbucket for the build status
[07:35:34.436] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:34.436] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:61:0) after 1m0s
[07:36:34.470] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:61:0)
[07:36:34.471] Timer tick, asking Buildbucket for the build status
[07:36:34.542] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:34.542] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:62:0) after 1m0s
[07:37:34.563] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:62:0)
[07:37:34.563] Timer tick, asking Buildbucket for the build status
[07:37:35.018] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:35.018] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:63:0) after 1m0s
[07:38:35.012] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:63:0)
[07:38:35.012] Timer tick, asking Buildbucket for the build status
[07:38:35.078] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:35.078] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:64:0) after 1m0s
[07:39:35.104] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:64:0)
[07:39:35.104] Timer tick, asking Buildbucket for the build status
[07:39:35.186] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:35.186] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:65:0) after 1m0s
[07:40:35.401] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:65:0)
[07:40:35.401] Timer tick, asking Buildbucket for the build status
[07:40:35.485] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:35.485] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:66:0) after 1m0s
[07:41:35.545] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:66:0)
[07:41:35.545] Timer tick, asking Buildbucket for the build status
[07:41:35.628] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:35.628] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:67:0) after 1m0s
[07:42:35.654] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:67:0)
[07:42:35.654] Timer tick, asking Buildbucket for the build status
[07:42:36.112] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:36.112] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:68:0) after 1m0s
[07:43:36.139] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:68:0)
[07:43:36.139] Timer tick, asking Buildbucket for the build status
[07:43:36.213] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:36.214] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:69:0) after 1m0s
[07:44:36.237] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:69:0)
[07:44:36.237] Timer tick, asking Buildbucket for the build status
[07:44:36.292] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:36.292] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:70:0) after 1m0s
[07:45:36.313] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:70:0)
[07:45:36.313] Timer tick, asking Buildbucket for the build status
[07:45:37.291] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:37.291] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:71:0) after 1m0s
[07:46:37.316] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:71:0)
[07:46:37.316] Timer tick, asking Buildbucket for the build status
[07:46:37.377] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:37.377] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:72:0) after 1m0s
[07:47:37.407] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:72:0)
[07:47:37.407] Timer tick, asking Buildbucket for the build status
[07:47:37.694] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:37.694] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:73:0) after 1m0s
[07:48:38.190] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:73:0)
[07:48:38.190] Timer tick, asking Buildbucket for the build status
[07:48:38.249] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:38.249] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:74:0) after 1m0s
[07:49:38.449] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:74:0)
[07:49:38.449] Timer tick, asking Buildbucket for the build status
[07:49:38.515] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:38.515] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:75:0) after 1m0s
[07:50:38.593] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:75:0)
[07:50:38.593] Timer tick, asking Buildbucket for the build status
[07:50:38.651] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:38.651] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:76:0) after 1m0s
[07:51:38.791] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:76:0)
[07:51:38.791] Timer tick, asking Buildbucket for the build status
[07:51:38.849] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:38.849] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:77:0) after 1m0s
[07:52:38.991] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:77:0)
[07:52:38.991] Timer tick, asking Buildbucket for the build status
[07:52:39.287] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:39.287] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:78:0) after 1m0s
[07:53:39.713] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:78:0)
[07:53:39.713] Timer tick, asking Buildbucket for the build status
[07:53:39.872] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:39.872] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:79:0) after 1m0s
[07:54:39.946] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:79:0)
[07:54:39.946] Timer tick, asking Buildbucket for the build status
[07:54:40.041] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:40.041] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:80:0) after 1m0s
[07:55:40.198] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:80:0)
[07:55:40.198] Timer tick, asking Buildbucket for the build status
[07:55:40.250] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:40.250] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:81:0) after 1m0s
[07:56:40.291] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:81:0)
[07:56:40.291] Timer tick, asking Buildbucket for the build status
[07:56:40.353] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:40.353] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:82:0) after 1m0s
[07:57:41.655] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:82:0)
[07:57:41.655] Timer tick, asking Buildbucket for the build status
[07:57:42.188] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:42.188] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:83:0) after 1m0s
[07:58:42.408] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:83:0)
[07:58:42.408] Timer tick, asking Buildbucket for the build status
[07:58:42.473] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:42.473] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:84:0) after 1m0s
[07:59:42.597] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:84:0)
[07:59:42.597] Timer tick, asking Buildbucket for the build status
[07:59:42.723] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:42.723] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:85:0) after 1m0s
[08:00:42.836] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:85:0)
[08:00:42.836] Timer tick, asking Buildbucket for the build status
[08:00:42.905] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:42.905] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:86:0) after 1m0s
[08:01:42.978] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:86:0)
[08:01:42.978] Timer tick, asking Buildbucket for the build status
[08:01:43.049] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:43.049] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:87:0) after 1m0s
[08:02:43.099] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:87:0)
[08:02:43.099] Timer tick, asking Buildbucket for the build status
[08:02:43.238] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:43.238] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:88:0) after 1m0s
[08:03:43.295] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:88:0)
[08:03:43.295] Timer tick, asking Buildbucket for the build status
[08:03:43.496] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:43.496] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:89:0) after 1m0s
[08:04:43.618] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:89:0)
[08:04:43.618] Timer tick, asking Buildbucket for the build status
[08:04:43.682] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:43.682] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:90:0) after 1m0s
[08:05:43.741] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:90:0)
[08:05:43.741] Timer tick, asking Buildbucket for the build status
[08:05:43.811] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:43.811] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:91:0) after 1m0s
[08:06:44.035] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:91:0)
[08:06:44.035] Timer tick, asking Buildbucket for the build status
[08:06:44.286] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:44.286] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:92:0) after 1m0s
[08:07:44.405] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:92:0)
[08:07:44.405] Timer tick, asking Buildbucket for the build status
[08:07:44.504] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:44.504] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:93:0) after 1m0s
[08:08:44.619] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:93:0)
[08:08:44.619] Timer tick, asking Buildbucket for the build status
[08:08:44.681] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:44.681] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:94:0) after 1m0s
[08:09:44.709] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:94:0)
[08:09:44.709] Timer tick, asking Buildbucket for the build status
[08:09:44.768] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:44.768] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:95:0) after 1m0s
[08:10:44.937] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:95:0)
[08:10:44.937] Timer tick, asking Buildbucket for the build status
[08:10:45.009] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:45.009] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:96:0) after 1m0s
[08:11:45.083] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:96:0)
[08:11:45.083] Timer tick, asking Buildbucket for the build status
[08:11:45.162] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:45.162] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:97:0) after 1m0s
[08:12:45.238] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:97:0)
[08:12:45.238] Timer tick, asking Buildbucket for the build status
[08:12:45.603] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:45.603] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:98:0) after 1m0s
[08:13:45.815] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:98:0)
[08:13:45.815] Timer tick, asking Buildbucket for the build status
[08:13:45.871] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:45.871] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:99:0) after 1m0s
[08:14:45.903] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:99:0)
[08:14:45.903] Timer tick, asking Buildbucket for the build status
[08:14:46.012] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:46.012] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:100:0) after 1m0s
[08:15:46.080] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:100:0)
[08:15:46.080] Timer tick, asking Buildbucket for the build status
[08:15:46.216] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:46.216] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:101:0) after 1m0s
[08:16:46.192] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:101:0)
[08:16:46.192] Timer tick, asking Buildbucket for the build status
[08:16:46.255] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:46.255] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:102:0) after 1m0s
[08:17:46.247] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:102:0)
[08:17:46.247] Timer tick, asking Buildbucket for the build status
[08:17:46.348] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:46.348] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:103:0) after 1m0s
[08:18:46.481] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:103:0)
[08:18:46.481] Timer tick, asking Buildbucket for the build status
[08:18:46.562] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:46.562] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:104:0) after 1m0s
[08:19:46.619] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:104:0)
[08:19:46.619] Timer tick, asking Buildbucket for the build status
[08:19:46.706] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:46.706] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:105:0) after 1m0s
[08:20:46.737] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:105:0)
[08:20:46.737] Timer tick, asking Buildbucket for the build status
[08:20:46.824] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:46.824] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:106:0) after 1m0s
[08:21:46.955] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:106:0)
[08:21:46.955] Timer tick, asking Buildbucket for the build status
[08:21:47.112] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:47.112] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:107:0) after 1m0s
[08:22:47.227] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:107:0)
[08:22:47.227] Timer tick, asking Buildbucket for the build status
[08:22:47.336] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:47.336] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:108:0) after 1m0s
[08:23:47.396] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:108:0)
[08:23:47.396] Timer tick, asking Buildbucket for the build status
[08:23:47.452] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:47.452] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:109:0) after 1m0s
[08:24:47.480] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:109:0)
[08:24:47.480] Timer tick, asking Buildbucket for the build status
[08:24:47.768] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:47.768] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:110:0) after 1m0s
[08:25:47.885] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:110:0)
[08:25:47.885] Timer tick, asking Buildbucket for the build status
[08:25:47.988] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:47.988] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:111:0) after 1m0s
[08:26:48.047] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:111:0)
[08:26:48.047] Timer tick, asking Buildbucket for the build status
[08:26:48.188] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:48.188] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:112:0) after 1m0s
[08:27:48.232] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:112:0)
[08:27:48.232] Timer tick, asking Buildbucket for the build status
[08:27:48.362] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:48.362] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:113:0) after 1m0s
[08:28:48.365] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:113:0)
[08:28:48.365] Timer tick, asking Buildbucket for the build status
[08:28:48.430] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:48.430] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:114:0) after 1m0s
[08:29:48.469] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:114:0)
[08:29:48.469] Timer tick, asking Buildbucket for the build status
[08:29:48.548] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:48.548] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:115:0) after 1m0s
[08:30:48.572] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:115:0)
[08:30:48.572] Timer tick, asking Buildbucket for the build status
[08:30:48.633] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:48.633] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:116:0) after 1m0s
[08:31:48.702] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:116:0)
[08:31:48.702] Timer tick, asking Buildbucket for the build status
[08:31:48.764] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:48.764] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:117:0) after 1m0s
[08:32:48.819] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:117:0)
[08:32:48.819] Timer tick, asking Buildbucket for the build status
[08:32:49.849] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:49.850] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:118:0) after 1m0s
[08:33:49.928] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:118:0)
[08:33:49.928] Timer tick, asking Buildbucket for the build status
[08:33:49.980] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:49.980] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:119:0) after 1m0s
[08:34:50.017] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:119:0)
[08:34:50.017] Timer tick, asking Buildbucket for the build status
[08:34:50.074] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:50.074] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:120:0) after 1m0s
[08:35:50.059] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:120:0)
[08:35:50.059] Timer tick, asking Buildbucket for the build status
[08:35:50.372] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:50.372] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:121:0) after 1m0s
[08:36:50.431] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:121:0)
[08:36:50.431] Timer tick, asking Buildbucket for the build status
[08:36:50.504] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:50.504] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:122:0) after 1m0s
[08:37:50.524] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:122:0)
[08:37:50.524] Timer tick, asking Buildbucket for the build status
[08:37:50.634] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:50.634] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:123:0) after 1m0s
[08:38:50.688] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:123:0)
[08:38:50.688] Timer tick, asking Buildbucket for the build status
[08:38:50.977] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:50.977] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:124:0) after 1m0s
[08:39:51.010] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:124:0)
[08:39:51.011] Timer tick, asking Buildbucket for the build status
[08:39:51.067] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:51.067] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:125:0) after 1m0s
[08:40:51.114] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:125:0)
[08:40:51.114] Timer tick, asking Buildbucket for the build status
[08:40:51.208] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:51.208] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:126:0) after 1m0s
[08:41:51.251] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:126:0)
[08:41:51.251] Timer tick, asking Buildbucket for the build status
[08:41:51.503] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:51.503] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:127:0) after 1m0s
[08:42:51.524] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:127:0)
[08:42:51.524] Timer tick, asking Buildbucket for the build status
[08:42:51.798] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:51.798] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:128:0) after 1m0s
[08:43:51.808] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:128:0)
[08:43:51.808] Timer tick, asking Buildbucket for the build status
[08:43:51.919] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:51.919] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:129:0) after 1m0s
[08:44:51.987] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:129:0)
[08:44:51.987] Timer tick, asking Buildbucket for the build status
[08:44:52.058] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:52.058] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:130:0) after 1m0s
[08:45:52.114] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:130:0)
[08:45:52.114] Timer tick, asking Buildbucket for the build status
[08:45:52.191] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:52.191] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:131:0) after 1m0s
[08:46:52.217] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:131:0)
[08:46:52.217] Timer tick, asking Buildbucket for the build status
[08:46:52.279] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:52.279] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:132:0) after 1m0s
[08:47:52.322] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:132:0)
[08:47:52.322] Timer tick, asking Buildbucket for the build status
[08:47:52.432] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:52.432] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:133:0) after 1m0s
[08:48:52.461] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:133:0)
[08:48:52.461] Timer tick, asking Buildbucket for the build status
[08:48:52.536] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:52.536] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:134:0) after 1m0s
[08:49:52.641] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:134:0)
[08:49:52.641] Timer tick, asking Buildbucket for the build status
[08:49:52.704] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:52.704] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:135:0) after 1m0s
[08:50:52.758] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:135:0)
[08:50:52.758] Timer tick, asking Buildbucket for the build status
[08:50:52.818] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:52.818] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:136:0) after 1m0s
[08:51:52.843] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:136:0)
[08:51:52.843] Timer tick, asking Buildbucket for the build status
[08:51:52.904] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:52.905] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:137:0) after 1m0s
[08:52:52.932] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:137:0)
[08:52:52.932] Timer tick, asking Buildbucket for the build status
[08:52:53.291] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:53.291] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:138:0) after 1m0s
[08:53:53.297] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:138:0)
[08:53:53.297] Timer tick, asking Buildbucket for the build status
[08:53:53.615] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:53.615] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:139:0) after 1m0s
[08:54:53.634] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:139:0)
[08:54:53.634] Timer tick, asking Buildbucket for the build status
[08:54:53.808] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:53.808] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:140:0) after 1m0s
[08:55:53.804] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:140:0)
[08:55:53.804] Timer tick, asking Buildbucket for the build status
[08:55:53.973] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:53.973] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:141:0) after 1m0s
[08:56:54.076] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:141:0)
[08:56:54.076] Timer tick, asking Buildbucket for the build status
[08:56:54.151] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:54.151] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:142:0) after 1m0s
[08:57:54.178] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:142:0)
[08:57:54.178] Timer tick, asking Buildbucket for the build status
[08:57:54.313] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:54.313] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:143:0) after 1m0s
[08:58:54.338] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:143:0)
[08:58:54.338] Timer tick, asking Buildbucket for the build status
[08:58:54.401] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:54.401] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:144:0) after 1m0s
[08:59:54.425] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:144:0)
[08:59:54.425] Timer tick, asking Buildbucket for the build status
[08:59:54.484] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:54.484] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:145:0) after 1m0s
[09:00:54.538] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:145:0)
[09:00:54.538] Timer tick, asking Buildbucket for the build status
[09:00:54.618] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:54.618] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:146:0) after 1m0s
[09:01:54.678] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:146:0)
[09:01:54.678] Timer tick, asking Buildbucket for the build status
[09:01:54.731] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:54.731] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:147:0) after 1m0s
[09:02:54.835] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:147:0)
[09:02:54.835] Timer tick, asking Buildbucket for the build status
[09:02:54.994] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:54.994] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:148:0) after 1m0s
[09:03:55.047] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:148:0)
[09:03:55.047] Timer tick, asking Buildbucket for the build status
[09:03:55.117] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:55.117] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:149:0) after 1m0s
[09:04:55.185] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:149:0)
[09:04:55.185] Timer tick, asking Buildbucket for the build status
[09:04:55.250] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:55.250] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:150:0) after 1m0s
[09:05:55.307] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:150:0)
[09:05:55.307] Timer tick, asking Buildbucket for the build status
[09:05:55.366] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:55.366] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:151:0) after 1m0s
[09:06:55.379] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:151:0)
[09:06:55.379] Timer tick, asking Buildbucket for the build status
[09:06:55.434] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:55.434] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:152:0) after 1m0s
[09:07:55.595] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:152:0)
[09:07:55.595] Timer tick, asking Buildbucket for the build status
[09:07:55.714] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:55.714] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:153:0) after 1m0s
[09:08:55.788] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:153:0)
[09:08:55.788] Timer tick, asking Buildbucket for the build status
[09:08:55.853] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:55.853] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:154:0) after 1m0s
[09:09:56.008] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:154:0)
[09:09:56.008] Timer tick, asking Buildbucket for the build status
[09:09:56.062] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:56.062] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:155:0) after 1m0s
[09:10:56.138] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:155:0)
[09:10:56.138] Timer tick, asking Buildbucket for the build status
[09:10:56.209] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:56.209] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:156:0) after 1m0s
[09:11:56.249] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:156:0)
[09:11:56.249] Timer tick, asking Buildbucket for the build status
[09:11:56.319] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:56.319] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:157:0) after 1m0s
[09:12:56.423] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:157:0)
[09:12:56.423] Timer tick, asking Buildbucket for the build status
[09:12:56.699] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:56.699] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:158:0) after 1m0s
[09:13:56.724] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:158:0)
[09:13:56.724] Timer tick, asking Buildbucket for the build status
[09:13:56.791] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:56.791] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:159:0) after 1m0s
[09:14:56.834] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:159:0)
[09:14:56.834] Timer tick, asking Buildbucket for the build status
[09:14:56.898] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:56.898] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:160:0) after 1m0s
[09:15:57.086] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:160:0)
[09:15:57.086] Timer tick, asking Buildbucket for the build status
[09:15:57.168] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:57.168] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:161:0) after 1m0s
[09:16:57.195] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:161:0)
[09:16:57.195] Timer tick, asking Buildbucket for the build status
[09:16:57.587] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:57.587] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:162:0) after 1m0s
[09:17:57.652] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:162:0)
[09:17:57.652] Timer tick, asking Buildbucket for the build status
[09:17:57.999] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:57.999] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:163:0) after 1m0s
[09:18:58.112] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:163:0)
[09:18:58.112] Timer tick, asking Buildbucket for the build status
[09:18:58.213] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:58.213] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:164:0) after 1m0s
[09:19:58.241] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:164:0)
[09:19:58.241] Timer tick, asking Buildbucket for the build status
[09:19:58.394] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:58.394] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:165:0) after 1m0s
[09:20:58.478] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:165:0)
[09:20:58.478] Timer tick, asking Buildbucket for the build status
[09:20:58.545] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:58.545] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:166:0) after 1m0s
[09:21:58.568] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:166:0)
[09:21:58.568] Timer tick, asking Buildbucket for the build status
[09:21:58.890] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:58.891] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:167:0) after 1m0s
[09:22:58.913] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:167:0)
[09:22:58.913] Timer tick, asking Buildbucket for the build status
[09:22:59.283] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:59.283] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:168:0) after 1m0s
[09:23:59.410] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:168:0)
[09:23:59.410] Timer tick, asking Buildbucket for the build status
[09:23:59.473] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:59.473] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:169:0) after 1m0s
[09:24:59.528] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:169:0)
[09:24:59.528] Timer tick, asking Buildbucket for the build status
[09:24:59.606] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:59.606] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:170:0) after 1m0s
[09:25:59.628] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:170:0)
[09:25:59.628] Timer tick, asking Buildbucket for the build status
[09:26:00.182] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:00.182] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:171:0) after 1m0s
[09:27:00.238] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:171:0)
[09:27:00.238] Timer tick, asking Buildbucket for the build status
[09:27:00.492] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:00.492] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:172:0) after 1m0s
[09:28:00.627] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:172:0)
[09:28:00.627] Timer tick, asking Buildbucket for the build status
[09:28:01.379] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:01.379] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:173:0) after 1m0s
[09:29:01.434] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:173:0)
[09:29:01.434] Timer tick, asking Buildbucket for the build status
[09:29:01.505] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:01.505] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:174:0) after 1m0s
[09:30:01.565] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:174:0)
[09:30:01.565] Timer tick, asking Buildbucket for the build status
[09:30:01.626] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:01.626] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:175:0) after 1m0s
[09:31:01.721] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:175:0)
[09:31:01.721] Timer tick, asking Buildbucket for the build status
[09:31:02.108] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:02.108] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:176:0) after 1m0s
[09:32:02.327] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:176:0)
[09:32:02.327] Timer tick, asking Buildbucket for the build status
[09:32:02.676] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:02.676] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:177:0) after 1m0s
[09:33:02.700] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:177:0)
[09:33:02.700] Timer tick, asking Buildbucket for the build status
[09:33:02.830] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:02.830] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:178:0) after 1m0s
[09:34:02.848] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:178:0)
[09:34:02.848] Timer tick, asking Buildbucket for the build status
[09:34:02.919] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:02.919] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:179:0) after 1m0s
[09:35:02.942] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:179:0)
[09:35:02.942] Timer tick, asking Buildbucket for the build status
[09:35:03.413] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:03.413] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:180:0) after 1m0s
[09:36:03.452] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:180:0)
[09:36:03.452] Timer tick, asking Buildbucket for the build status
[09:36:03.521] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:03.521] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:181:0) after 1m0s
[09:37:03.593] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:181:0)
[09:37:03.593] Timer tick, asking Buildbucket for the build status
[09:37:03.677] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:03.677] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:182:0) after 1m0s
[09:38:03.714] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:182:0)
[09:38:03.714] Timer tick, asking Buildbucket for the build status
[09:38:03.816] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:03.816] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:183:0) after 1m0s
[09:39:03.899] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:183:0)
[09:39:03.899] Timer tick, asking Buildbucket for the build status
[09:39:03.993] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:03.993] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:184:0) after 1m0s
[09:40:04.075] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:184:0)
[09:40:04.075] Timer tick, asking Buildbucket for the build status
[09:40:04.155] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:04.155] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:185:0) after 1m0s
[09:41:04.216] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:185:0)
[09:41:04.216] Timer tick, asking Buildbucket for the build status
[09:41:04.286] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:04.286] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:186:0) after 1m0s
[09:42:04.316] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:186:0)
[09:42:04.316] Timer tick, asking Buildbucket for the build status
[09:42:04.388] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:04.388] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:187:0) after 1m0s
[09:43:04.415] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:187:0)
[09:43:04.415] Timer tick, asking Buildbucket for the build status
[09:43:04.917] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:04.917] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:188:0) after 1m0s
[09:44:04.944] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:188:0)
[09:44:04.944] Timer tick, asking Buildbucket for the build status
[09:44:05.030] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:05.030] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:189:0) after 1m0s
[09:45:05.095] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:189:0)
[09:45:05.095] Timer tick, asking Buildbucket for the build status
[09:45:05.175] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:05.175] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:190:0) after 1m0s
[09:46:05.190] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:190:0)
[09:46:05.190] Timer tick, asking Buildbucket for the build status
[09:46:05.389] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:05.389] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:191:0) after 1m0s
[09:47:05.445] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:191:0)
[09:47:05.445] Timer tick, asking Buildbucket for the build status
[09:47:05.724] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:05.724] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:192:0) after 1m0s
[09:48:05.722] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:192:0)
[09:48:05.722] Timer tick, asking Buildbucket for the build status
[09:48:05.824] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:05.824] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:193:0) after 1m0s
[09:49:05.856] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:193:0)
[09:49:05.856] Timer tick, asking Buildbucket for the build status
[09:49:06.022] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:06.022] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:194:0) after 1m0s
[09:50:06.102] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:194:0)
[09:50:06.102] Timer tick, asking Buildbucket for the build status
[09:50:06.166] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:06.166] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:195:0) after 1m0s
[09:51:06.194] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:195:0)
[09:51:06.194] Timer tick, asking Buildbucket for the build status
[09:51:06.299] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:06.300] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:196:0) after 1m0s
[09:52:06.339] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:196:0)
[09:52:06.339] Timer tick, asking Buildbucket for the build status
[09:52:06.405] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:06.405] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:197:0) after 1m0s
[09:53:06.428] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:197:0)
[09:53:06.428] Timer tick, asking Buildbucket for the build status
[09:53:06.545] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:06.545] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:198:0) after 1m0s
[09:54:06.582] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:198:0)
[09:54:06.582] Timer tick, asking Buildbucket for the build status
[09:54:06.647] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:06.647] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:199:0) after 1m0s
[09:55:06.681] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:199:0)
[09:55:06.681] Timer tick, asking Buildbucket for the build status
[09:55:06.737] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:06.737] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:200:0) after 1m0s
[09:56:06.761] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:200:0)
[09:56:06.761] Timer tick, asking Buildbucket for the build status
[09:56:06.820] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:06.821] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:201:0) after 1m0s
[09:57:06.844] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:201:0)
[09:57:06.844] Timer tick, asking Buildbucket for the build status
[09:57:06.899] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:06.899] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:202:0) after 1m0s
[09:58:06.929] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:202:0)
[09:58:06.929] Timer tick, asking Buildbucket for the build status
[09:58:07.042] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:07.042] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:203:0) after 1m0s
[09:59:07.070] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:203:0)
[09:59:07.070] Timer tick, asking Buildbucket for the build status
[09:59:07.144] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:07.144] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:204:0) after 1m0s
[10:00:07.244] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:204:0)
[10:00:07.244] Timer tick, asking Buildbucket for the build status
[10:00:07.479] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:07.479] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:205:0) after 1m0s
[10:01:07.547] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:205:0)
[10:01:07.547] Timer tick, asking Buildbucket for the build status
[10:01:07.614] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:07.614] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:206:0) after 1m0s
[10:02:07.632] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:206:0)
[10:02:07.632] Timer tick, asking Buildbucket for the build status
[10:02:07.710] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:07.710] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:207:0) after 1m0s
[10:03:07.795] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:207:0)
[10:03:07.795] Timer tick, asking Buildbucket for the build status
[10:03:07.894] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:07.894] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:208:0) after 1m0s
[10:04:07.916] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:208:0)
[10:04:07.916] Timer tick, asking Buildbucket for the build status
[10:04:07.978] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:07.978] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:209:0) after 1m0s
[10:05:08.052] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:209:0)
[10:05:08.052] Timer tick, asking Buildbucket for the build status
[10:05:08.120] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:08.120] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:210:0) after 1m0s
[10:06:08.287] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:210:0)
[10:06:08.287] Timer tick, asking Buildbucket for the build status
[10:06:08.369] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:08.369] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:211:0) after 1m0s
[10:07:08.470] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:211:0)
[10:07:08.470] Timer tick, asking Buildbucket for the build status
[10:07:08.551] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:08.551] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:212:0) after 1m0s
[10:08:09.029] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:212:0)
[10:08:09.029] Timer tick, asking Buildbucket for the build status
[10:08:09.132] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:09.132] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:213:0) after 1m0s
[10:09:09.201] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:213:0)
[10:09:09.201] Timer tick, asking Buildbucket for the build status
[10:09:09.398] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:09.398] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:214:0) after 1m0s
[10:10:09.385] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:214:0)
[10:10:09.386] Timer tick, asking Buildbucket for the build status
[10:10:09.461] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:09.461] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:215:0) after 1m0s
[10:11:09.637] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:215:0)
[10:11:09.637] Timer tick, asking Buildbucket for the build status
[10:11:09.707] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:09.707] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:216:0) after 1m0s
[10:12:09.936] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:216:0)
[10:12:09.936] Timer tick, asking Buildbucket for the build status
[10:12:10.005] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:10.005] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:217:0) after 1m0s
[10:13:10.195] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:217:0)
[10:13:10.195] Timer tick, asking Buildbucket for the build status
[10:13:10.313] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:10.313] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:218:0) after 1m0s
[10:14:10.645] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:218:0)
[10:14:10.645] Timer tick, asking Buildbucket for the build status
[10:14:11.093] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:11.093] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:219:0) after 1m0s
[10:15:11.109] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:219:0)
[10:15:11.109] Timer tick, asking Buildbucket for the build status
[10:15:11.306] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:11.306] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:220:0) after 1m0s
[10:16:11.363] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:220:0)
[10:16:11.363] Timer tick, asking Buildbucket for the build status
[10:16:11.583] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:11.583] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:221:0) after 1m0s
[10:17:11.688] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:221:0)
[10:17:11.688] Timer tick, asking Buildbucket for the build status
[10:17:11.791] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:11.791] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:222:0) after 1m0s
[10:18:11.835] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:222:0)
[10:18:11.835] Timer tick, asking Buildbucket for the build status
[10:18:12.374] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:12.374] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:223:0) after 1m0s
[10:19:12.494] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:223:0)
[10:19:12.494] Timer tick, asking Buildbucket for the build status
[10:19:12.562] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:12.568] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:224:0) after 1m0s
[10:20:12.612] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:224:0)
[10:20:12.612] Timer tick, asking Buildbucket for the build status
[10:20:12.710] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:12.710] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:225:0) after 1m0s
[10:21:12.750] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:225:0)
[10:21:12.750] Timer tick, asking Buildbucket for the build status
[10:21:13.150] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:13.150] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:226:0) after 1m0s
[10:22:13.162] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:226:0)
[10:22:13.162] Timer tick, asking Buildbucket for the build status
[10:22:13.223] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:13.223] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:227:0) after 1m0s
[10:23:13.304] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:227:0)
[10:23:13.304] Timer tick, asking Buildbucket for the build status
[10:23:13.425] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:13.425] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:228:0) after 1m0s
[10:24:13.519] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:228:0)
[10:24:13.519] Timer tick, asking Buildbucket for the build status
[10:24:13.606] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:13.606] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:229:0) after 1m0s
[10:25:13.812] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:229:0)
[10:25:13.812] Timer tick, asking Buildbucket for the build status
[10:25:13.904] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:13.904] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:230:0) after 1m0s
[10:26:14.024] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:230:0)
[10:26:14.024] Timer tick, asking Buildbucket for the build status
[10:26:14.493] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:14.493] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:231:0) after 1m0s
[10:27:14.572] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:231:0)
[10:27:14.572] Timer tick, asking Buildbucket for the build status
[10:27:14.821] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:14.821] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:232:0) after 1m0s
[10:28:14.814] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:232:0)
[10:28:14.814] Timer tick, asking Buildbucket for the build status
[10:28:14.931] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:14.931] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:233:0) after 1m0s
[10:29:14.969] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:233:0)
[10:29:14.969] Timer tick, asking Buildbucket for the build status
[10:29:15.034] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:15.034] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:234:0) after 1m0s
[10:30:15.099] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:234:0)
[10:30:15.099] Timer tick, asking Buildbucket for the build status
[10:30:15.270] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:15.270] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:235:0) after 1m0s
[10:31:15.274] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:235:0)
[10:31:15.274] Timer tick, asking Buildbucket for the build status
[10:31:15.687] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:15.687] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:236:0) after 1m0s
[10:32:15.724] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:236:0)
[10:32:15.725] Timer tick, asking Buildbucket for the build status
[10:32:15.822] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:15.822] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:237:0) after 1m0s
[10:33:15.848] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:237:0)
[10:33:15.848] Timer tick, asking Buildbucket for the build status
[10:33:15.959] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:15.959] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:238:0) after 1m0s
[10:34:15.985] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:238:0)
[10:34:15.985] Timer tick, asking Buildbucket for the build status
[10:34:16.174] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:16.174] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:239:0) after 1m0s
[10:35:16.214] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:239:0)
[10:35:16.214] Timer tick, asking Buildbucket for the build status
[10:35:16.272] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:16.272] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:240:0) after 1m0s
[10:36:16.350] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:240:0)
[10:36:16.350] Timer tick, asking Buildbucket for the build status
[10:36:16.418] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:16.418] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:241:0) after 1m0s
[10:37:16.417] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:241:0)
[10:37:16.417] Timer tick, asking Buildbucket for the build status
[10:37:16.543] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:16.543] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:242:0) after 1m0s
[10:38:16.675] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:242:0)
[10:38:16.675] Timer tick, asking Buildbucket for the build status
[10:38:16.980] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:16.980] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:243:0) after 1m0s
[10:39:17.055] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:243:0)
[10:39:17.055] Timer tick, asking Buildbucket for the build status
[10:39:17.133] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:17.133] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:244:0) after 1m0s
[10:40:17.215] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:244:0)
[10:40:17.215] Timer tick, asking Buildbucket for the build status
[10:40:17.280] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:17.280] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:245:0) after 1m0s
[10:41:17.315] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:245:0)
[10:41:17.315] Timer tick, asking Buildbucket for the build status
[10:41:17.423] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:17.423] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:246:0) after 1m0s
[10:42:17.454] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:246:0)
[10:42:17.454] Timer tick, asking Buildbucket for the build status
[10:42:17.643] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:17.643] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:247:0) after 1m0s
[10:43:17.686] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:247:0)
[10:43:17.686] Timer tick, asking Buildbucket for the build status
[10:43:17.818] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:17.818] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:248:0) after 1m0s
[10:44:17.810] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:248:0)
[10:44:17.810] Timer tick, asking Buildbucket for the build status
[10:44:17.859] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:17.859] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:249:0) after 1m0s
[10:45:17.892] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:249:0)
[10:45:17.892] Timer tick, asking Buildbucket for the build status
[10:45:18.212] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:18.212] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:250:0) after 1m0s
[10:46:18.248] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:250:0)
[10:46:18.248] Timer tick, asking Buildbucket for the build status
[10:46:18.311] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:18.311] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:251:0) after 1m0s
[10:47:18.352] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:251:0)
[10:47:18.352] Timer tick, asking Buildbucket for the build status
[10:47:18.615] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:18.615] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:252:0) after 1m0s
[10:48:18.693] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:252:0)
[10:48:18.693] Timer tick, asking Buildbucket for the build status
[10:48:18.795] Build 8866757379167935744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:18.795] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032187441147575024:253:0) after 1m0s
[10:48:55.646] Received PubSub notification, asking Buildbucket for the build status
[10:48:55.783] Build 8866757379167935744: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:48:55.783] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1602413335045223",
"created_by": "project:chromium",
"created_ts": "1602398239889308",
"id": "8866757379167935744",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2a206a3e99bfa3d2741e7c372878f304ba8811be\"}}",
"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\": \"2a206a3e99bfa3d2741e7c372878f304ba8811be\", \"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-8-379q\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 788, \"got_angle_revision\": \"3345e5fdc5c4360c770ddad6260dd10f80dbd762\", \"got_dawn_revision\": \"1c25198384e7ecfebbd3ac84203d3b1d46a0e228\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"2a206a3e99bfa3d2741e7c372878f304ba8811be\", \"got_revision_cp\": \"refs/heads/master@{#815986}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"cca740fc48dfffbe24a5ee0bfe23ed1ec2b21580\", \"got_v8_revision\": \"07b0b1dcde4a99294b8028d83f4ea244885cc091\", \"got_v8_revision_cp\": \"refs/heads/8.8.62@{#1}\", \"got_webrtc_revision\": \"3326535126e435f1ba647885ce43a8f0f3d317eb\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32375}\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2a206a3e99bfa3d2741e7c372878f304ba8811be\"}, \"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\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-8-379q\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5570-fa4adf0\"], \"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": "1602398301608201",
"status": "COMPLETED",
"status_changed_ts": "1602413335300870",
"tags": [
"build_address:luci.chromium.ci/win-official/788",
"builder:win-official",
"buildset:commit/git/2a206a3e99bfa3d2741e7c372878f304ba8811be",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2a206a3e99bfa3d2741e7c372878f304ba8811be",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9032187441147575024",
"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/8866757379167935744/+/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:4f2f3247e6d5ef10",
"user_agent:luci-scheduler"
],
"updated_ts": "1602413335304891",
"url": "https://ci.chromium.org/b/8866757379167935744",
"utcnow_ts": "1602413335731455"
}
}
[10:48:55.783] Invocation finished in 4h11m37.164740865s with status SUCCEEDED