[08:22:09.011] New invocation is queued and will start shortly
[08:22:10.172] Starting the invocation (attempt 1)
[08:22:10.219] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:22:10.219] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:22:10.219] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022668163746703328",
"parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"4e5c7ce07d279fa1b01c0c23895e8e4234fbeb88\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-official",
"scheduler_invocation_id:9022668163746703328",
"scheduler_job_id:chromium/win-official",
"user_agent:luci-scheduler",
"buildset:commit/git/4e5c7ce07d279fa1b01c0c23895e8e4234fbeb88",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4e5c7ce07d279fa1b01c0c23895e8e4234fbeb88",
"gitiles_ref:refs/heads/master"
]
}
[08:22:12.046] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611476530345112",
"id": "8857238101675281616",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4e5c7ce07d279fa1b01c0c23895e8e4234fbeb88\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611476531719045",
"tags": [
"build_address:luci.chromium.ci/win-official/1451",
"builder:win-official",
"buildset:commit/git/4e5c7ce07d279fa1b01c0c23895e8e4234fbeb88",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4e5c7ce07d279fa1b01c0c23895e8e4234fbeb88",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022668163746703328",
"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/8857238101675281616/+/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": "1611476531719157",
"url": "https://ci.chromium.org/b/8857238101675281616",
"utcnow_ts": "1611476532031202"
}
}
[08:22:12.046] Task URL: https://ci.chromium.org/b/8857238101675281616
[08:22:12.046] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:2:0) after 1m0s
[08:22:49.868] Received PubSub notification, asking Buildbucket for the build status
[08:22:49.929] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:12.083] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:2:0)
[08:23:12.083] Timer tick, asking Buildbucket for the build status
[08:23:12.208] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:12.208] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:4:0) after 1m0s
[08:24:12.297] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:4:0)
[08:24:12.297] Timer tick, asking Buildbucket for the build status
[08:24:12.400] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:12.400] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:5:0) after 1m0s
[08:25:12.406] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:5:0)
[08:25:12.406] Timer tick, asking Buildbucket for the build status
[08:25:12.564] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:12.564] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:6:0) after 1m0s
[08:26:12.582] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:6:0)
[08:26:12.582] Timer tick, asking Buildbucket for the build status
[08:26:12.672] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:12.672] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:7:0) after 1m0s
[08:27:12.696] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:7:0)
[08:27:12.696] Timer tick, asking Buildbucket for the build status
[08:27:12.785] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:12.785] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:8:0) after 1m0s
[08:28:12.836] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:8:0)
[08:28:12.836] Timer tick, asking Buildbucket for the build status
[08:28:12.904] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:12.904] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:9:0) after 1m0s
[08:29:12.895] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:9:0)
[08:29:12.895] Timer tick, asking Buildbucket for the build status
[08:29:12.977] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:12.977] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:10:0) after 1m0s
[08:30:13.006] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:10:0)
[08:30:13.006] Timer tick, asking Buildbucket for the build status
[08:30:13.107] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:13.107] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:11:0) after 1m0s
[08:31:13.147] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:11:0)
[08:31:13.147] Timer tick, asking Buildbucket for the build status
[08:31:13.326] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:13.326] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:12:0) after 1m0s
[08:32:13.420] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:12:0)
[08:32:13.420] Timer tick, asking Buildbucket for the build status
[08:32:13.865] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:13.865] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:13:0) after 1m0s
[08:33:13.972] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:13:0)
[08:33:13.972] Timer tick, asking Buildbucket for the build status
[08:33:14.042] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:14.042] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:14:0) after 1m0s
[08:34:14.052] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:14:0)
[08:34:14.052] Timer tick, asking Buildbucket for the build status
[08:34:14.176] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:14.176] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:15:0) after 1m0s
[08:35:14.193] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:15:0)
[08:35:14.193] Timer tick, asking Buildbucket for the build status
[08:35:14.305] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:14.305] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:16:0) after 1m0s
[08:36:14.357] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:16:0)
[08:36:14.357] Timer tick, asking Buildbucket for the build status
[08:36:14.417] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:14.417] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:17:0) after 1m0s
[08:37:14.470] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:17:0)
[08:37:14.470] Timer tick, asking Buildbucket for the build status
[08:37:14.579] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:14.579] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:18:0) after 1m0s
[08:38:14.605] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:18:0)
[08:38:14.605] Timer tick, asking Buildbucket for the build status
[08:38:14.666] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:14.666] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:19:0) after 1m0s
[08:39:14.723] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:19:0)
[08:39:14.723] Timer tick, asking Buildbucket for the build status
[08:39:14.778] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:14.778] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:20:0) after 1m0s
[08:40:14.793] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:20:0)
[08:40:14.793] Timer tick, asking Buildbucket for the build status
[08:40:14.861] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:14.861] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:21:0) after 1m0s
[08:41:14.921] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:21:0)
[08:41:14.921] Timer tick, asking Buildbucket for the build status
[08:41:15.191] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:15.191] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:22:0) after 1m0s
[08:42:15.216] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:22:0)
[08:42:15.216] Timer tick, asking Buildbucket for the build status
[08:42:15.346] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:15.346] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:23:0) after 1m0s
[08:43:15.391] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:23:0)
[08:43:15.391] Timer tick, asking Buildbucket for the build status
[08:43:15.448] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:15.448] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:24:0) after 1m0s
[08:44:15.510] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:24:0)
[08:44:15.510] Timer tick, asking Buildbucket for the build status
[08:44:15.605] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:15.605] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:25:0) after 1m0s
[08:45:15.624] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:25:0)
[08:45:15.624] Timer tick, asking Buildbucket for the build status
[08:45:15.754] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:15.754] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:26:0) after 1m0s
[08:46:15.792] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:26:0)
[08:46:15.792] Timer tick, asking Buildbucket for the build status
[08:46:15.857] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:15.857] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:27:0) after 1m0s
[08:47:15.914] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:27:0)
[08:47:15.914] Timer tick, asking Buildbucket for the build status
[08:47:16.017] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:16.017] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:28:0) after 1m0s
[08:48:16.107] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:28:0)
[08:48:16.107] Timer tick, asking Buildbucket for the build status
[08:48:16.443] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:16.443] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:29:0) after 1m0s
[08:49:16.490] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:29:0)
[08:49:16.490] Timer tick, asking Buildbucket for the build status
[08:49:16.699] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:16.699] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:30:0) after 1m0s
[08:50:16.735] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:30:0)
[08:50:16.735] Timer tick, asking Buildbucket for the build status
[08:50:16.788] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:16.788] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:31:0) after 1m0s
[08:51:16.815] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:31:0)
[08:51:16.815] Timer tick, asking Buildbucket for the build status
[08:51:16.875] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:16.877] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:32:0) after 1m0s
[08:52:16.958] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:32:0)
[08:52:16.958] Timer tick, asking Buildbucket for the build status
[08:52:17.066] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:17.066] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:33:0) after 1m0s
[08:53:17.039] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:33:0)
[08:53:17.039] Timer tick, asking Buildbucket for the build status
[08:53:17.101] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:17.101] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:34:0) after 1m0s
[08:54:17.105] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:34:0)
[08:54:17.105] Timer tick, asking Buildbucket for the build status
[08:54:17.188] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:17.188] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:35:0) after 1m0s
[08:55:17.278] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:35:0)
[08:55:17.278] Timer tick, asking Buildbucket for the build status
[08:55:17.703] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:17.703] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:36:0) after 1m0s
[08:56:17.801] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:36:0)
[08:56:17.801] Timer tick, asking Buildbucket for the build status
[08:56:17.964] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:17.964] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:37:0) after 1m0s
[08:57:17.984] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:37:0)
[08:57:17.984] Timer tick, asking Buildbucket for the build status
[08:57:18.068] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:18.068] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:38:0) after 1m0s
[08:58:18.102] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:38:0)
[08:58:18.102] Timer tick, asking Buildbucket for the build status
[08:58:18.188] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:18.188] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:39:0) after 1m0s
[08:59:18.206] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:39:0)
[08:59:18.206] Timer tick, asking Buildbucket for the build status
[08:59:18.335] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:18.335] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:40:0) after 1m0s
[09:00:18.362] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:40:0)
[09:00:18.362] Timer tick, asking Buildbucket for the build status
[09:00:18.468] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:18.469] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:41:0) after 1m0s
[09:01:18.518] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:41:0)
[09:01:18.518] Timer tick, asking Buildbucket for the build status
[09:01:19.225] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:19.225] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:42:0) after 1m0s
[09:02:19.251] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:42:0)
[09:02:19.251] Timer tick, asking Buildbucket for the build status
[09:02:19.546] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:19.546] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:43:0) after 1m0s
[09:03:19.538] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:43:0)
[09:03:19.538] Timer tick, asking Buildbucket for the build status
[09:03:19.604] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:19.604] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:44:0) after 1m0s
[09:04:19.610] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:44:0)
[09:04:19.610] Timer tick, asking Buildbucket for the build status
[09:04:19.812] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:19.812] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:45:0) after 1m0s
[09:05:19.840] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:45:0)
[09:05:19.840] Timer tick, asking Buildbucket for the build status
[09:05:20.142] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:20.142] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:46:0) after 1m0s
[09:06:20.206] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:46:0)
[09:06:20.206] Timer tick, asking Buildbucket for the build status
[09:06:20.502] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:20.502] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:47:0) after 1m0s
[09:07:20.521] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:47:0)
[09:07:20.521] Timer tick, asking Buildbucket for the build status
[09:07:20.961] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:20.961] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:48:0) after 1m0s
[09:08:20.976] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:48:0)
[09:08:20.976] Timer tick, asking Buildbucket for the build status
[09:08:21.047] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:21.047] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:49:0) after 1m0s
[09:09:21.050] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:49:0)
[09:09:21.050] Timer tick, asking Buildbucket for the build status
[09:09:21.230] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:21.230] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:50:0) after 1m0s
[09:10:21.301] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:50:0)
[09:10:21.301] Timer tick, asking Buildbucket for the build status
[09:10:21.357] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:21.357] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:51:0) after 1m0s
[09:11:21.410] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:51:0)
[09:11:21.410] Timer tick, asking Buildbucket for the build status
[09:11:21.595] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:21.595] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:52:0) after 1m0s
[09:12:21.617] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:52:0)
[09:12:21.617] Timer tick, asking Buildbucket for the build status
[09:12:21.710] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:21.710] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:53:0) after 1m0s
[09:13:21.738] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:53:0)
[09:13:21.738] Timer tick, asking Buildbucket for the build status
[09:13:21.805] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:21.805] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:54:0) after 1m0s
[09:14:21.823] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:54:0)
[09:14:21.823] Timer tick, asking Buildbucket for the build status
[09:14:21.902] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:21.902] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:55:0) after 1m0s
[09:15:21.920] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:55:0)
[09:15:21.920] Timer tick, asking Buildbucket for the build status
[09:15:21.974] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:21.974] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:56:0) after 1m0s
[09:16:21.992] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:56:0)
[09:16:21.992] Timer tick, asking Buildbucket for the build status
[09:16:22.041] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:22.041] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:57:0) after 1m0s
[09:17:22.065] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:57:0)
[09:17:22.065] Timer tick, asking Buildbucket for the build status
[09:17:22.154] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:22.154] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:58:0) after 1m0s
[09:18:22.259] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:58:0)
[09:18:22.259] Timer tick, asking Buildbucket for the build status
[09:18:22.347] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:22.347] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:59:0) after 1m0s
[09:19:22.417] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:59:0)
[09:19:22.417] Timer tick, asking Buildbucket for the build status
[09:19:22.476] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:22.476] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:60:0) after 1m0s
[09:20:22.580] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:60:0)
[09:20:22.580] Timer tick, asking Buildbucket for the build status
[09:20:22.647] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:22.647] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:61:0) after 1m0s
[09:21:22.717] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:61:0)
[09:21:22.717] Timer tick, asking Buildbucket for the build status
[09:21:22.807] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:22.807] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:62:0) after 1m0s
[09:22:22.784] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:62:0)
[09:22:22.784] Timer tick, asking Buildbucket for the build status
[09:22:23.118] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:23.118] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:63:0) after 1m0s
[09:23:23.215] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:63:0)
[09:23:23.215] Timer tick, asking Buildbucket for the build status
[09:23:23.270] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:23.270] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:64:0) after 1m0s
[09:24:23.387] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:64:0)
[09:24:23.387] Timer tick, asking Buildbucket for the build status
[09:24:23.447] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:23.447] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:65:0) after 1m0s
[09:25:23.493] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:65:0)
[09:25:23.493] Timer tick, asking Buildbucket for the build status
[09:25:23.544] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:23.544] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:66:0) after 1m0s
[09:26:23.655] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:66:0)
[09:26:23.655] Timer tick, asking Buildbucket for the build status
[09:26:23.842] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:23.842] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:67:0) after 1m0s
[09:27:23.869] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:67:0)
[09:27:23.869] Timer tick, asking Buildbucket for the build status
[09:27:23.955] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:23.955] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:68:0) after 1m0s
[09:28:24.003] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:68:0)
[09:28:24.003] Timer tick, asking Buildbucket for the build status
[09:28:24.058] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:24.058] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:69:0) after 1m0s
[09:29:24.345] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:69:0)
[09:29:24.345] Timer tick, asking Buildbucket for the build status
[09:29:24.451] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:24.451] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:70:0) after 1m0s
[09:30:24.629] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:70:0)
[09:30:24.629] Timer tick, asking Buildbucket for the build status
[09:30:24.699] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:24.699] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:71:0) after 1m0s
[09:31:24.879] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:71:0)
[09:31:24.879] Timer tick, asking Buildbucket for the build status
[09:31:24.940] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:24.941] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:72:0) after 1m0s
[09:32:25.061] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:72:0)
[09:32:25.061] Timer tick, asking Buildbucket for the build status
[09:32:25.173] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:25.173] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:73:0) after 1m0s
[09:33:25.201] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:73:0)
[09:33:25.201] Timer tick, asking Buildbucket for the build status
[09:33:25.283] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:25.283] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:74:0) after 1m0s
[09:34:25.322] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:74:0)
[09:34:25.322] Timer tick, asking Buildbucket for the build status
[09:34:25.627] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:25.627] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:75:0) after 1m0s
[09:35:25.736] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:75:0)
[09:35:25.736] Timer tick, asking Buildbucket for the build status
[09:35:26.050] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:26.050] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:76:0) after 1m0s
[09:36:26.081] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:76:0)
[09:36:26.081] Timer tick, asking Buildbucket for the build status
[09:36:26.382] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:26.382] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:77:0) after 1m0s
[09:37:26.376] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:77:0)
[09:37:26.376] Timer tick, asking Buildbucket for the build status
[09:37:26.968] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:26.968] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:78:0) after 1m0s
[09:38:26.998] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:78:0)
[09:38:26.998] Timer tick, asking Buildbucket for the build status
[09:38:27.049] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:27.049] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:79:0) after 1m0s
[09:39:27.077] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:79:0)
[09:39:27.077] Timer tick, asking Buildbucket for the build status
[09:39:27.158] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:27.158] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:80:0) after 1m0s
[09:40:27.183] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:80:0)
[09:40:27.183] Timer tick, asking Buildbucket for the build status
[09:40:27.446] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:27.446] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:81:0) after 1m0s
[09:41:27.583] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:81:0)
[09:41:27.583] Timer tick, asking Buildbucket for the build status
[09:41:27.936] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:27.936] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:82:0) after 1m0s
[09:42:27.986] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:82:0)
[09:42:27.986] Timer tick, asking Buildbucket for the build status
[09:42:28.091] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:28.091] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:83:0) after 1m0s
[09:43:28.133] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:83:0)
[09:43:28.133] Timer tick, asking Buildbucket for the build status
[09:43:28.291] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:28.291] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:84:0) after 1m0s
[09:44:28.321] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:84:0)
[09:44:28.321] Timer tick, asking Buildbucket for the build status
[09:44:28.384] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:28.384] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:85:0) after 1m0s
[09:45:28.418] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:85:0)
[09:45:28.418] Timer tick, asking Buildbucket for the build status
[09:45:28.513] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:28.513] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:86:0) after 1m0s
[09:46:28.534] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:86:0)
[09:46:28.534] Timer tick, asking Buildbucket for the build status
[09:46:28.623] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:28.623] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:87:0) after 1m0s
[09:47:28.651] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:87:0)
[09:47:28.651] Timer tick, asking Buildbucket for the build status
[09:47:28.727] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:28.727] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:88:0) after 1m0s
[09:48:28.811] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:88:0)
[09:48:28.811] Timer tick, asking Buildbucket for the build status
[09:48:28.908] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:28.908] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:89:0) after 1m0s
[09:49:29.009] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:89:0)
[09:49:29.009] Timer tick, asking Buildbucket for the build status
[09:49:29.096] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:29.096] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:90:0) after 1m0s
[09:50:29.191] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:90:0)
[09:50:29.191] Timer tick, asking Buildbucket for the build status
[09:50:29.268] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:29.268] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:91:0) after 1m0s
[09:51:29.306] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:91:0)
[09:51:29.306] Timer tick, asking Buildbucket for the build status
[09:51:29.614] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:29.614] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:92:0) after 1m0s
[09:52:29.671] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:92:0)
[09:52:29.671] Timer tick, asking Buildbucket for the build status
[09:52:29.765] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:29.765] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:93:0) after 1m0s
[09:53:29.835] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:93:0)
[09:53:29.835] Timer tick, asking Buildbucket for the build status
[09:53:29.892] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:29.892] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:94:0) after 1m0s
[09:54:29.947] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:94:0)
[09:54:29.947] Timer tick, asking Buildbucket for the build status
[09:54:30.043] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:30.043] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:95:0) after 1m0s
[09:55:30.122] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:95:0)
[09:55:30.122] Timer tick, asking Buildbucket for the build status
[09:55:30.390] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:30.390] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:96:0) after 1m0s
[09:56:30.447] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:96:0)
[09:56:30.447] Timer tick, asking Buildbucket for the build status
[09:56:30.624] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:30.624] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:97:0) after 1m0s
[09:57:30.674] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:97:0)
[09:57:30.674] Timer tick, asking Buildbucket for the build status
[09:57:30.793] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:30.793] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:98:0) after 1m0s
[09:58:30.864] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:98:0)
[09:58:30.864] Timer tick, asking Buildbucket for the build status
[09:58:31.001] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:31.001] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:99:0) after 1m0s
[09:59:31.080] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:99:0)
[09:59:31.080] Timer tick, asking Buildbucket for the build status
[09:59:31.137] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:31.137] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:100:0) after 1m0s
[10:00:31.225] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:100:0)
[10:00:31.225] Timer tick, asking Buildbucket for the build status
[10:00:31.308] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:31.308] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:101:0) after 1m0s
[10:01:31.334] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:101:0)
[10:01:31.334] Timer tick, asking Buildbucket for the build status
[10:01:31.841] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:31.841] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:102:0) after 1m0s
[10:02:31.829] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:102:0)
[10:02:31.829] Timer tick, asking Buildbucket for the build status
[10:02:31.927] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:31.927] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:103:0) after 1m0s
[10:03:31.957] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:103:0)
[10:03:31.957] Timer tick, asking Buildbucket for the build status
[10:03:32.015] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:32.015] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:104:0) after 1m0s
[10:04:32.095] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:104:0)
[10:04:32.095] Timer tick, asking Buildbucket for the build status
[10:04:32.145] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:32.145] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:105:0) after 1m0s
[10:05:32.230] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:105:0)
[10:05:32.230] Timer tick, asking Buildbucket for the build status
[10:05:32.282] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:32.282] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:106:0) after 1m0s
[10:06:32.461] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:106:0)
[10:06:32.461] Timer tick, asking Buildbucket for the build status
[10:06:32.522] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:32.522] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:107:0) after 1m0s
[10:07:32.843] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:107:0)
[10:07:32.843] Timer tick, asking Buildbucket for the build status
[10:07:33.004] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:33.004] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:108:0) after 1m0s
[10:08:33.035] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:108:0)
[10:08:33.035] Timer tick, asking Buildbucket for the build status
[10:08:33.315] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:33.315] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:109:0) after 1m0s
[10:09:33.298] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:109:0)
[10:09:33.298] Timer tick, asking Buildbucket for the build status
[10:09:33.353] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:33.353] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:110:0) after 1m0s
[10:10:33.388] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:110:0)
[10:10:33.388] Timer tick, asking Buildbucket for the build status
[10:10:33.466] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:33.466] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:111:0) after 1m0s
[10:11:33.488] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:111:0)
[10:11:33.488] Timer tick, asking Buildbucket for the build status
[10:11:33.539] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:33.539] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:112:0) after 1m0s
[10:12:33.637] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:112:0)
[10:12:33.637] Timer tick, asking Buildbucket for the build status
[10:12:33.727] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:33.727] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:113:0) after 1m0s
[10:13:33.773] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:113:0)
[10:13:33.773] Timer tick, asking Buildbucket for the build status
[10:13:33.848] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:33.848] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:114:0) after 1m0s
[10:14:33.852] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:114:0)
[10:14:33.852] Timer tick, asking Buildbucket for the build status
[10:14:33.952] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:33.952] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:115:0) after 1m0s
[10:15:33.955] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:115:0)
[10:15:33.955] Timer tick, asking Buildbucket for the build status
[10:15:34.050] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:34.050] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:116:0) after 1m0s
[10:16:34.086] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:116:0)
[10:16:34.086] Timer tick, asking Buildbucket for the build status
[10:16:34.142] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:34.142] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:117:0) after 1m0s
[10:17:34.158] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:117:0)
[10:17:34.158] Timer tick, asking Buildbucket for the build status
[10:17:34.299] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:34.299] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:118:0) after 1m0s
[10:18:34.436] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:118:0)
[10:18:34.436] Timer tick, asking Buildbucket for the build status
[10:18:34.626] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:34.626] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:119:0) after 1m0s
[10:19:34.852] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:119:0)
[10:19:34.852] Timer tick, asking Buildbucket for the build status
[10:19:34.927] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:34.927] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:120:0) after 1m0s
[10:20:35.044] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:120:0)
[10:20:35.044] Timer tick, asking Buildbucket for the build status
[10:20:35.322] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:35.322] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:121:0) after 1m0s
[10:21:35.406] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:121:0)
[10:21:35.406] Timer tick, asking Buildbucket for the build status
[10:21:35.487] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:35.487] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:122:0) after 1m0s
[10:22:35.553] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:122:0)
[10:22:35.553] Timer tick, asking Buildbucket for the build status
[10:22:35.714] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:35.714] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:123:0) after 1m0s
[10:23:35.736] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:123:0)
[10:23:35.736] Timer tick, asking Buildbucket for the build status
[10:23:35.809] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:35.809] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:124:0) after 1m0s
[10:24:35.834] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:124:0)
[10:24:35.834] Timer tick, asking Buildbucket for the build status
[10:24:35.885] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:35.885] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:125:0) after 1m0s
[10:25:35.921] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:125:0)
[10:25:35.921] Timer tick, asking Buildbucket for the build status
[10:25:36.072] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:36.072] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:126:0) after 1m0s
[10:26:36.157] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:126:0)
[10:26:36.157] Timer tick, asking Buildbucket for the build status
[10:26:36.328] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:36.328] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:127:0) after 1m0s
[10:27:36.377] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:127:0)
[10:27:36.377] Timer tick, asking Buildbucket for the build status
[10:27:36.485] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:36.485] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:128:0) after 1m0s
[10:28:36.506] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:128:0)
[10:28:36.506] Timer tick, asking Buildbucket for the build status
[10:28:36.731] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:36.731] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:129:0) after 1m0s
[10:29:36.709] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:129:0)
[10:29:36.709] Timer tick, asking Buildbucket for the build status
[10:29:36.961] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:36.961] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:130:0) after 1m0s
[10:30:37.047] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:130:0)
[10:30:37.047] Timer tick, asking Buildbucket for the build status
[10:30:37.111] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:37.111] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:131:0) after 1m0s
[10:31:37.236] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:131:0)
[10:31:37.236] Timer tick, asking Buildbucket for the build status
[10:31:37.297] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:37.297] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:132:0) after 1m0s
[10:32:37.366] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:132:0)
[10:32:37.366] Timer tick, asking Buildbucket for the build status
[10:32:37.458] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:37.458] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:133:0) after 1m0s
[10:33:37.532] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:133:0)
[10:33:37.532] Timer tick, asking Buildbucket for the build status
[10:33:37.606] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:37.606] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:134:0) after 1m0s
[10:34:37.722] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:134:0)
[10:34:37.722] Timer tick, asking Buildbucket for the build status
[10:34:37.785] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:37.785] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:135:0) after 1m0s
[10:35:38.213] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:135:0)
[10:35:38.213] Timer tick, asking Buildbucket for the build status
[10:35:38.272] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:38.272] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:136:0) after 1m0s
[10:36:38.467] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:136:0)
[10:36:38.467] Timer tick, asking Buildbucket for the build status
[10:36:38.519] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:38.519] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:137:0) after 1m0s
[10:37:38.657] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:137:0)
[10:37:38.657] Timer tick, asking Buildbucket for the build status
[10:37:38.794] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:38.794] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:138:0) after 1m0s
[10:38:38.845] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:138:0)
[10:38:38.845] Timer tick, asking Buildbucket for the build status
[10:38:38.900] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:38.900] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:139:0) after 1m0s
[10:39:38.977] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:139:0)
[10:39:38.977] Timer tick, asking Buildbucket for the build status
[10:39:39.034] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:39.034] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:140:0) after 1m0s
[10:40:39.072] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:140:0)
[10:40:39.072] Timer tick, asking Buildbucket for the build status
[10:40:39.133] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:39.133] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:141:0) after 1m0s
[10:41:39.187] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:141:0)
[10:41:39.187] Timer tick, asking Buildbucket for the build status
[10:41:39.266] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:39.266] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:142:0) after 1m0s
[10:42:39.254] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:142:0)
[10:42:39.254] Timer tick, asking Buildbucket for the build status
[10:42:39.372] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:39.372] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:143:0) after 1m0s
[10:43:39.431] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:143:0)
[10:43:39.431] Timer tick, asking Buildbucket for the build status
[10:43:39.517] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:39.517] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:144:0) after 1m0s
[10:44:39.695] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:144:0)
[10:44:39.695] Timer tick, asking Buildbucket for the build status
[10:44:39.929] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:39.929] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:145:0) after 1m0s
[10:45:39.974] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:145:0)
[10:45:39.974] Timer tick, asking Buildbucket for the build status
[10:45:40.033] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:40.033] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:146:0) after 1m0s
[10:46:40.104] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:146:0)
[10:46:40.104] Timer tick, asking Buildbucket for the build status
[10:46:40.157] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:40.157] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:147:0) after 1m0s
[10:47:40.161] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:147:0)
[10:47:40.161] Timer tick, asking Buildbucket for the build status
[10:47:40.263] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:40.263] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:148:0) after 1m0s
[10:48:40.359] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:148:0)
[10:48:40.359] Timer tick, asking Buildbucket for the build status
[10:48:40.411] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:40.411] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:149:0) after 1m0s
[10:49:40.512] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:149:0)
[10:49:40.512] Timer tick, asking Buildbucket for the build status
[10:49:40.590] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:40.590] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:150:0) after 1m0s
[10:50:40.650] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:150:0)
[10:50:40.650] Timer tick, asking Buildbucket for the build status
[10:50:40.709] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:40.709] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:151:0) after 1m0s
[10:51:40.742] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:151:0)
[10:51:40.742] Timer tick, asking Buildbucket for the build status
[10:51:40.812] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:40.812] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:152:0) after 1m0s
[10:52:40.873] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:152:0)
[10:52:40.873] Timer tick, asking Buildbucket for the build status
[10:52:41.031] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:41.031] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:153:0) after 1m0s
[10:53:41.109] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:153:0)
[10:53:41.109] Timer tick, asking Buildbucket for the build status
[10:53:41.187] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:41.187] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:154:0) after 1m0s
[10:54:41.208] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:154:0)
[10:54:41.208] Timer tick, asking Buildbucket for the build status
[10:54:41.270] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:41.271] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:155:0) after 1m0s
[10:55:41.322] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:155:0)
[10:55:41.322] Timer tick, asking Buildbucket for the build status
[10:55:41.420] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:41.420] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:156:0) after 1m0s
[10:56:41.431] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:156:0)
[10:56:41.431] Timer tick, asking Buildbucket for the build status
[10:56:41.485] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:41.485] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:157:0) after 1m0s
[10:57:41.523] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:157:0)
[10:57:41.523] Timer tick, asking Buildbucket for the build status
[10:57:41.635] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:41.635] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:158:0) after 1m0s
[10:58:41.713] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:158:0)
[10:58:41.714] Timer tick, asking Buildbucket for the build status
[10:58:41.783] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:41.783] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:159:0) after 1m0s
[10:59:41.825] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:159:0)
[10:59:41.825] Timer tick, asking Buildbucket for the build status
[10:59:41.878] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:41.878] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:160:0) after 1m0s
[11:00:42.022] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:160:0)
[11:00:42.022] Timer tick, asking Buildbucket for the build status
[11:00:42.615] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:42.615] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:161:0) after 1m0s
[11:01:42.673] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:161:0)
[11:01:42.673] Timer tick, asking Buildbucket for the build status
[11:01:42.739] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:42.739] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:162:0) after 1m0s
[11:02:42.792] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:162:0)
[11:02:42.792] Timer tick, asking Buildbucket for the build status
[11:02:42.900] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:42.900] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:163:0) after 1m0s
[11:03:43.019] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:163:0)
[11:03:43.019] Timer tick, asking Buildbucket for the build status
[11:03:43.118] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:43.118] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:164:0) after 1m0s
[11:04:43.159] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:164:0)
[11:04:43.159] Timer tick, asking Buildbucket for the build status
[11:04:43.238] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:43.238] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:165:0) after 1m0s
[11:05:43.263] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:165:0)
[11:05:43.263] Timer tick, asking Buildbucket for the build status
[11:05:43.354] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:43.354] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:166:0) after 1m0s
[11:06:43.405] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:166:0)
[11:06:43.405] Timer tick, asking Buildbucket for the build status
[11:06:43.478] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:43.478] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:167:0) after 1m0s
[11:07:43.527] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:167:0)
[11:07:43.527] Timer tick, asking Buildbucket for the build status
[11:07:43.630] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:43.630] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:168:0) after 1m0s
[11:08:43.727] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:168:0)
[11:08:43.727] Timer tick, asking Buildbucket for the build status
[11:08:43.843] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:43.843] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:169:0) after 1m0s
[11:09:43.892] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:169:0)
[11:09:43.892] Timer tick, asking Buildbucket for the build status
[11:09:44.019] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:44.019] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:170:0) after 1m0s
[11:10:44.179] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:170:0)
[11:10:44.179] Timer tick, asking Buildbucket for the build status
[11:10:44.546] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:44.546] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:171:0) after 1m0s
[11:11:44.563] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:171:0)
[11:11:44.563] Timer tick, asking Buildbucket for the build status
[11:11:44.673] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:44.673] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:172:0) after 1m0s
[11:12:44.819] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:172:0)
[11:12:44.819] Timer tick, asking Buildbucket for the build status
[11:12:44.913] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:44.913] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:173:0) after 1m0s
[11:13:45.080] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:173:0)
[11:13:45.080] Timer tick, asking Buildbucket for the build status
[11:13:45.325] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:45.325] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:174:0) after 1m0s
[11:14:45.359] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:174:0)
[11:14:45.359] Timer tick, asking Buildbucket for the build status
[11:14:45.454] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:45.454] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:175:0) after 1m0s
[11:15:45.489] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:175:0)
[11:15:45.489] Timer tick, asking Buildbucket for the build status
[11:15:45.548] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:45.548] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:176:0) after 1m0s
[11:16:45.649] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:176:0)
[11:16:45.649] Timer tick, asking Buildbucket for the build status
[11:16:45.711] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:45.711] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:177:0) after 1m0s
[11:17:45.973] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:177:0)
[11:17:45.973] Timer tick, asking Buildbucket for the build status
[11:17:46.176] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:46.176] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:178:0) after 1m0s
[11:18:46.755] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:178:0)
[11:18:46.755] Timer tick, asking Buildbucket for the build status
[11:18:46.822] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:46.822] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:179:0) after 1m0s
[11:19:47.874] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:179:0)
[11:19:47.874] Timer tick, asking Buildbucket for the build status
[11:19:47.976] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:47.976] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:180:0) after 1m0s
[11:20:48.116] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:180:0)
[11:20:48.116] Timer tick, asking Buildbucket for the build status
[11:20:48.414] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:48.414] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:181:0) after 1m0s
[11:21:48.629] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:181:0)
[11:21:48.629] Timer tick, asking Buildbucket for the build status
[11:21:48.892] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:48.892] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:182:0) after 1m0s
[11:22:48.917] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:182:0)
[11:22:48.917] Timer tick, asking Buildbucket for the build status
[11:22:49.423] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:49.423] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:183:0) after 1m0s
[11:23:49.660] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:183:0)
[11:23:49.660] Timer tick, asking Buildbucket for the build status
[11:23:49.720] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:49.720] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:184:0) after 1m0s
[11:24:49.938] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:184:0)
[11:24:49.938] Timer tick, asking Buildbucket for the build status
[11:24:50.242] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:50.242] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:185:0) after 1m0s
[11:25:50.309] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:185:0)
[11:25:50.309] Timer tick, asking Buildbucket for the build status
[11:25:50.383] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:50.383] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:186:0) after 1m0s
[11:26:50.562] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:186:0)
[11:26:50.562] Timer tick, asking Buildbucket for the build status
[11:26:50.628] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:50.628] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:187:0) after 1m0s
[11:27:51.193] Handling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:187:0)
[11:27:51.193] Timer tick, asking Buildbucket for the build status
[11:27:51.294] Build 8857238101675281616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:51.294] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9022668163746703328:188:0) after 1m0s
[11:28:18.712] Received PubSub notification, asking Buildbucket for the build status
[11:28:18.803] Build 8857238101675281616: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:28:18.803] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611487697701470",
"created_by": "project:chromium",
"created_ts": "1611476530345112",
"id": "8857238101675281616",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4e5c7ce07d279fa1b01c0c23895e8e4234fbeb88\"}}",
"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\": \"4e5c7ce07d279fa1b01c0c23895e8e4234fbeb88\", \"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-fqoc\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 1451, \"got_angle_revision\": \"3c3b82abcf0a5c18b4d97ae49726045ce6d3b832\", \"got_dawn_revision\": \"f1f8394de04ea9532de763dfb2f968fc9610683b\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"4e5c7ce07d279fa1b01c0c23895e8e4234fbeb88\", \"got_revision_cp\": \"refs/heads/master@{#846569}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"413f7cb17c77c95e4cc3ba141f3c0f049ac2ecb2\", \"got_v8_revision\": \"f2b2f28304b332e59226ee6c0688307ed9982884\", \"got_v8_revision_cp\": \"refs/heads/9.0.57@{#1}\", \"got_webrtc_revision\": \"90776cb0ef72d437983c8d29e5a7f2ac264c107d\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33064}\", \"mirrored_builders\": [\"tryserver.chromium:win-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4e5c7ce07d279fa1b01c0c23895e8e4234fbeb88\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_9b3ebe5fd1c5be87380c40d216747346a59b28cf26de183f0e8e2b32e944d3c8_v2\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-8-fqoc\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"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\": [\"5671-1d9dea8\"], \"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": "1611476569162764",
"status": "COMPLETED",
"status_changed_ts": "1611487698271307",
"tags": [
"build_address:luci.chromium.ci/win-official/1451",
"builder:win-official",
"buildset:commit/git/4e5c7ce07d279fa1b01c0c23895e8e4234fbeb88",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4e5c7ce07d279fa1b01c0c23895e8e4234fbeb88",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022668163746703328",
"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/8857238101675281616/+/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:514c4e03b612b110",
"user_agent:luci-scheduler"
],
"updated_ts": "1611487698289917",
"url": "https://ci.chromium.org/b/8857238101675281616",
"utcnow_ts": "1611487698782102"
}
}
[11:28:18.803] Invocation finished in 3h6m9.816669141s with status SUCCEEDED