[10:46:57.603] New invocation is queued and will start shortly
[10:46:58.692] Starting the invocation (attempt 1)
[10:46:58.732] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:46:58.732] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:46:58.732] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027370095343203712",
"parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"81f43d4dcc92c4a79c2adb5d9b92cb84640daef4\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-official",
"scheduler_invocation_id:9027370095343203712",
"scheduler_job_id:chromium/win-official",
"user_agent:luci-scheduler",
"buildset:commit/git/81f43d4dcc92c4a79c2adb5d9b92cb84640daef4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/81f43d4dcc92c4a79c2adb5d9b92cb84640daef4",
"gitiles_ref:refs/heads/master"
]
}
[10:46:59.677] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606992418883460",
"id": "8861940033335166784",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"81f43d4dcc92c4a79c2adb5d9b92cb84640daef4\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606992419450250",
"tags": [
"build_address:luci.chromium.ci/win-official/1114",
"builder:win-official",
"buildset:commit/git/81f43d4dcc92c4a79c2adb5d9b92cb84640daef4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/81f43d4dcc92c4a79c2adb5d9b92cb84640daef4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027370095343203712",
"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/8861940033335166784/+/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": "1606992419450407",
"url": "https://ci.chromium.org/b/8861940033335166784",
"utcnow_ts": "1606992419665285"
}
}
[10:46:59.677] Task URL: https://ci.chromium.org/b/8861940033335166784
[10:46:59.677] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:2:0) after 1m0s
[10:47:59.699] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:2:0)
[10:47:59.699] Timer tick, asking Buildbucket for the build status
[10:47:59.827] Build 8861940033335166784: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:47:59.827] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:3:0) after 1m0s
[10:48:59.852] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:3:0)
[10:48:59.852] Timer tick, asking Buildbucket for the build status
[10:49:00.175] Build 8861940033335166784: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:49:00.175] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:4:0) after 1m0s
[10:50:00.219] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:4:0)
[10:50:00.219] Timer tick, asking Buildbucket for the build status
[10:50:00.368] Build 8861940033335166784: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:50:00.368] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:5:0) after 1m0s
[10:50:41.846] Received PubSub notification, asking Buildbucket for the build status
[10:50:42.231] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:02.278] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:5:0)
[10:51:02.278] Timer tick, asking Buildbucket for the build status
[10:51:02.386] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:02.386] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:7:0) after 1m0s
[10:52:03.203] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:7:0)
[10:52:03.203] Timer tick, asking Buildbucket for the build status
[10:52:03.342] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:03.342] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:8:0) after 1m0s
[10:53:03.726] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:8:0)
[10:53:03.726] Timer tick, asking Buildbucket for the build status
[10:53:03.833] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:03.834] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:9:0) after 1m0s
[10:54:04.103] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:9:0)
[10:54:04.103] Timer tick, asking Buildbucket for the build status
[10:54:04.172] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:04.172] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:10:0) after 1m0s
[10:55:04.218] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:10:0)
[10:55:04.218] Timer tick, asking Buildbucket for the build status
[10:55:04.313] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:04.313] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:11:0) after 1m0s
[10:56:05.141] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:11:0)
[10:56:05.141] Timer tick, asking Buildbucket for the build status
[10:56:05.332] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:05.332] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:12:0) after 1m0s
[10:57:05.500] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:12:0)
[10:57:05.500] Timer tick, asking Buildbucket for the build status
[10:57:05.717] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:05.717] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:13:0) after 1m0s
[10:58:05.965] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:13:0)
[10:58:05.965] Timer tick, asking Buildbucket for the build status
[10:58:06.087] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:06.087] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:14:0) after 1m0s
[10:59:06.321] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:14:0)
[10:59:06.321] Timer tick, asking Buildbucket for the build status
[10:59:06.602] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:06.602] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:15:0) after 1m0s
[11:00:06.694] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:15:0)
[11:00:06.694] Timer tick, asking Buildbucket for the build status
[11:00:07.067] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:07.067] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:16:0) after 1m0s
[11:01:08.012] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:16:0)
[11:01:08.012] Timer tick, asking Buildbucket for the build status
[11:01:08.127] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:08.127] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:17:0) after 1m0s
[11:02:08.261] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:17:0)
[11:02:08.261] Timer tick, asking Buildbucket for the build status
[11:02:08.493] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:08.493] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:18:0) after 1m0s
[11:03:08.611] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:18:0)
[11:03:08.611] Timer tick, asking Buildbucket for the build status
[11:03:08.754] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:08.754] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:19:0) after 1m0s
[11:04:08.820] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:19:0)
[11:04:08.820] Timer tick, asking Buildbucket for the build status
[11:04:09.056] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:09.056] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:20:0) after 1m0s
[11:05:09.143] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:20:0)
[11:05:09.143] Timer tick, asking Buildbucket for the build status
[11:05:09.239] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:09.239] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:21:0) after 1m0s
[11:06:09.313] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:21:0)
[11:06:09.313] Timer tick, asking Buildbucket for the build status
[11:06:09.403] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:09.403] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:22:0) after 1m0s
[11:07:09.433] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:22:0)
[11:07:09.433] Timer tick, asking Buildbucket for the build status
[11:07:12.630] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:12.630] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:23:0) after 1m0s
[11:08:12.703] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:23:0)
[11:08:12.703] Timer tick, asking Buildbucket for the build status
[11:08:12.961] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:12.961] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:24:0) after 1m0s
[11:09:13.034] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:24:0)
[11:09:13.034] Timer tick, asking Buildbucket for the build status
[11:09:13.204] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:13.204] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:25:0) after 1m0s
[11:10:13.265] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:25:0)
[11:10:13.265] Timer tick, asking Buildbucket for the build status
[11:10:13.410] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:13.410] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:26:0) after 1m0s
[11:11:13.527] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:26:0)
[11:11:13.527] Timer tick, asking Buildbucket for the build status
[11:11:13.850] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:13.850] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:27:0) after 1m0s
[11:12:13.905] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:27:0)
[11:12:13.905] Timer tick, asking Buildbucket for the build status
[11:12:14.032] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:14.032] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:28:0) after 1m0s
[11:13:14.067] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:28:0)
[11:13:14.067] Timer tick, asking Buildbucket for the build status
[11:13:14.637] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:14.637] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:29:0) after 1m0s
[11:14:14.620] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:29:0)
[11:14:14.620] Timer tick, asking Buildbucket for the build status
[11:14:14.702] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:14.702] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:30:0) after 1m0s
[11:15:14.745] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:30:0)
[11:15:14.745] Timer tick, asking Buildbucket for the build status
[11:15:15.025] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:15.025] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:31:0) after 1m0s
[11:16:15.119] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:31:0)
[11:16:15.119] Timer tick, asking Buildbucket for the build status
[11:16:15.212] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:15.214] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:32:0) after 1m0s
[11:17:15.312] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:32:0)
[11:17:15.312] Timer tick, asking Buildbucket for the build status
[11:17:15.889] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:15.889] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:33:0) after 1m0s
[11:18:15.924] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:33:0)
[11:18:15.924] Timer tick, asking Buildbucket for the build status
[11:18:16.285] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:16.285] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:34:0) after 1m0s
[11:19:16.309] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:34:0)
[11:19:16.309] Timer tick, asking Buildbucket for the build status
[11:19:16.415] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:16.415] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:35:0) after 1m0s
[11:20:16.518] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:35:0)
[11:20:16.518] Timer tick, asking Buildbucket for the build status
[11:20:16.976] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:16.976] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:36:0) after 1m0s
[11:21:17.046] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:36:0)
[11:21:17.046] Timer tick, asking Buildbucket for the build status
[11:21:17.231] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:17.231] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:37:0) after 1m0s
[11:22:17.325] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:37:0)
[11:22:17.325] Timer tick, asking Buildbucket for the build status
[11:22:17.529] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:17.529] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:38:0) after 1m0s
[11:23:17.684] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:38:0)
[11:23:17.684] Timer tick, asking Buildbucket for the build status
[11:23:17.923] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:17.923] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:39:0) after 1m0s
[11:24:18.023] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:39:0)
[11:24:18.023] Timer tick, asking Buildbucket for the build status
[11:24:18.093] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:18.093] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:40:0) after 1m0s
[11:25:18.107] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:40:0)
[11:25:18.107] Timer tick, asking Buildbucket for the build status
[11:25:18.215] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:18.215] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:41:0) after 1m0s
[11:26:18.260] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:41:0)
[11:26:18.260] Timer tick, asking Buildbucket for the build status
[11:26:18.328] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:18.328] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:42:0) after 1m0s
[11:27:18.362] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:42:0)
[11:27:18.362] Timer tick, asking Buildbucket for the build status
[11:27:18.457] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:18.457] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:43:0) after 1m0s
[11:28:18.510] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:43:0)
[11:28:18.510] Timer tick, asking Buildbucket for the build status
[11:28:18.581] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:18.582] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:44:0) after 1m0s
[11:29:18.606] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:44:0)
[11:29:18.606] Timer tick, asking Buildbucket for the build status
[11:29:19.086] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:19.086] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:45:0) after 1m0s
[11:30:19.076] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:45:0)
[11:30:19.076] Timer tick, asking Buildbucket for the build status
[11:30:19.183] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:19.183] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:46:0) after 1m0s
[11:31:19.326] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:46:0)
[11:31:19.326] Timer tick, asking Buildbucket for the build status
[11:31:19.484] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:19.484] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:47:0) after 1m0s
[11:32:19.561] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:47:0)
[11:32:19.561] Timer tick, asking Buildbucket for the build status
[11:32:20.026] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:20.026] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:48:0) after 1m0s
[11:33:20.073] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:48:0)
[11:33:20.073] Timer tick, asking Buildbucket for the build status
[11:33:20.506] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:20.506] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:49:0) after 1m0s
[11:34:20.531] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:49:0)
[11:34:20.531] Timer tick, asking Buildbucket for the build status
[11:34:20.659] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:20.660] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:50:0) after 1m0s
[11:35:20.716] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:50:0)
[11:35:20.716] Timer tick, asking Buildbucket for the build status
[11:35:20.890] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:20.891] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:51:0) after 1m0s
[11:36:20.914] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:51:0)
[11:36:20.914] Timer tick, asking Buildbucket for the build status
[11:36:21.288] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:21.288] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:52:0) after 1m0s
[11:37:21.312] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:52:0)
[11:37:21.312] Timer tick, asking Buildbucket for the build status
[11:37:21.641] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:21.641] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:53:0) after 1m0s
[11:38:21.714] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:53:0)
[11:38:21.714] Timer tick, asking Buildbucket for the build status
[11:38:22.088] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:22.088] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:54:0) after 1m0s
[11:39:22.098] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:54:0)
[11:39:22.098] Timer tick, asking Buildbucket for the build status
[11:39:22.163] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:22.163] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:55:0) after 1m0s
[11:40:22.204] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:55:0)
[11:40:22.205] Timer tick, asking Buildbucket for the build status
[11:40:22.282] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:22.282] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:56:0) after 1m0s
[11:41:22.308] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:56:0)
[11:41:22.308] Timer tick, asking Buildbucket for the build status
[11:41:22.376] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:22.376] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:57:0) after 1m0s
[11:42:22.436] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:57:0)
[11:42:22.436] Timer tick, asking Buildbucket for the build status
[11:42:23.120] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:23.120] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:58:0) after 1m0s
[11:43:23.133] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:58:0)
[11:43:23.133] Timer tick, asking Buildbucket for the build status
[11:43:23.431] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:23.431] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:59:0) after 1m0s
[11:44:23.461] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:59:0)
[11:44:23.461] Timer tick, asking Buildbucket for the build status
[11:44:23.736] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:23.736] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:60:0) after 1m0s
[11:45:23.764] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:60:0)
[11:45:23.764] Timer tick, asking Buildbucket for the build status
[11:45:23.870] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:23.870] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:61:0) after 1m0s
[11:46:23.891] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:61:0)
[11:46:23.891] Timer tick, asking Buildbucket for the build status
[11:46:24.051] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:24.051] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:62:0) after 1m0s
[11:47:24.073] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:62:0)
[11:47:24.073] Timer tick, asking Buildbucket for the build status
[11:47:24.199] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:24.199] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:63:0) after 1m0s
[11:48:24.232] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:63:0)
[11:48:24.232] Timer tick, asking Buildbucket for the build status
[11:48:24.373] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:24.373] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:64:0) after 1m0s
[11:49:24.455] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:64:0)
[11:49:24.455] Timer tick, asking Buildbucket for the build status
[11:49:24.568] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:24.568] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:65:0) after 1m0s
[11:50:24.649] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:65:0)
[11:50:24.649] Timer tick, asking Buildbucket for the build status
[11:50:25.288] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:25.288] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:66:0) after 1m0s
[11:51:25.345] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:66:0)
[11:51:25.345] Timer tick, asking Buildbucket for the build status
[11:51:25.633] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:25.633] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:67:0) after 1m0s
[11:52:25.657] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:67:0)
[11:52:25.657] Timer tick, asking Buildbucket for the build status
[11:52:25.753] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:25.753] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:68:0) after 1m0s
[11:53:25.821] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:68:0)
[11:53:25.821] Timer tick, asking Buildbucket for the build status
[11:53:25.973] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:25.973] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:69:0) after 1m0s
[11:54:25.987] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:69:0)
[11:54:25.987] Timer tick, asking Buildbucket for the build status
[11:54:26.348] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:26.348] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:70:0) after 1m0s
[11:55:26.406] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:70:0)
[11:55:26.406] Timer tick, asking Buildbucket for the build status
[11:55:26.511] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:26.511] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:71:0) after 1m0s
[11:56:26.581] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:71:0)
[11:56:26.581] Timer tick, asking Buildbucket for the build status
[11:56:26.663] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:26.663] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:72:0) after 1m0s
[11:57:26.849] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:72:0)
[11:57:26.849] Timer tick, asking Buildbucket for the build status
[11:57:27.004] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:27.004] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:73:0) after 1m0s
[11:58:27.182] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:73:0)
[11:58:27.182] Timer tick, asking Buildbucket for the build status
[11:58:27.284] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:27.284] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:74:0) after 1m0s
[11:59:27.407] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:74:0)
[11:59:27.407] Timer tick, asking Buildbucket for the build status
[11:59:27.473] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:27.473] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:75:0) after 1m0s
[12:00:27.603] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:75:0)
[12:00:27.603] Timer tick, asking Buildbucket for the build status
[12:00:28.314] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:28.314] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:76:0) after 1m0s
[12:01:28.479] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:76:0)
[12:01:28.479] Timer tick, asking Buildbucket for the build status
[12:01:28.597] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:28.597] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:77:0) after 1m0s
[12:02:28.847] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:77:0)
[12:02:28.847] Timer tick, asking Buildbucket for the build status
[12:02:29.146] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:29.146] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:78:0) after 1m0s
[12:03:29.256] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:78:0)
[12:03:29.256] Timer tick, asking Buildbucket for the build status
[12:03:29.350] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:29.350] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:79:0) after 1m0s
[12:04:29.612] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:79:0)
[12:04:29.612] Timer tick, asking Buildbucket for the build status
[12:04:29.760] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:29.760] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:80:0) after 1m0s
[12:05:29.862] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:80:0)
[12:05:29.862] Timer tick, asking Buildbucket for the build status
[12:05:29.943] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:29.943] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:81:0) after 1m0s
[12:06:30.123] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:81:0)
[12:06:30.123] Timer tick, asking Buildbucket for the build status
[12:06:31.246] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:31.246] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:82:0) after 1m0s
[12:07:31.499] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:82:0)
[12:07:31.499] Timer tick, asking Buildbucket for the build status
[12:07:32.539] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:32.539] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:83:0) after 1m0s
[12:08:32.583] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:83:0)
[12:08:32.583] Timer tick, asking Buildbucket for the build status
[12:08:33.315] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:33.315] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:84:0) after 1m0s
[12:09:33.353] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:84:0)
[12:09:33.353] Timer tick, asking Buildbucket for the build status
[12:09:33.443] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:33.443] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:85:0) after 1m0s
[12:10:33.475] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:85:0)
[12:10:33.475] Timer tick, asking Buildbucket for the build status
[12:10:33.584] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:33.584] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:86:0) after 1m0s
[12:11:33.613] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:86:0)
[12:11:33.613] Timer tick, asking Buildbucket for the build status
[12:11:33.826] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:33.826] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:87:0) after 1m0s
[12:12:33.859] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:87:0)
[12:12:33.859] Timer tick, asking Buildbucket for the build status
[12:12:33.984] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:33.984] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:88:0) after 1m0s
[12:13:34.072] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:88:0)
[12:13:34.072] Timer tick, asking Buildbucket for the build status
[12:13:34.394] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:34.394] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:89:0) after 1m0s
[12:14:34.515] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:89:0)
[12:14:34.515] Timer tick, asking Buildbucket for the build status
[12:14:34.776] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:34.776] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:90:0) after 1m0s
[12:15:34.871] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:90:0)
[12:15:34.871] Timer tick, asking Buildbucket for the build status
[12:15:34.985] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:34.985] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:91:0) after 1m0s
[12:16:34.992] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:91:0)
[12:16:34.992] Timer tick, asking Buildbucket for the build status
[12:16:35.120] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:35.120] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:92:0) after 1m0s
[12:17:35.213] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:92:0)
[12:17:35.213] Timer tick, asking Buildbucket for the build status
[12:17:35.342] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:35.342] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:93:0) after 1m0s
[12:18:35.389] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:93:0)
[12:18:35.389] Timer tick, asking Buildbucket for the build status
[12:18:35.463] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:35.463] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:94:0) after 1m0s
[12:19:35.724] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:94:0)
[12:19:35.724] Timer tick, asking Buildbucket for the build status
[12:19:36.334] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:36.334] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:95:0) after 1m0s
[12:20:36.331] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:95:0)
[12:20:36.331] Timer tick, asking Buildbucket for the build status
[12:20:36.627] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:36.627] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:96:0) after 1m0s
[12:21:36.695] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:96:0)
[12:21:36.695] Timer tick, asking Buildbucket for the build status
[12:21:36.992] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:36.992] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:97:0) after 1m0s
[12:22:37.016] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:97:0)
[12:22:37.016] Timer tick, asking Buildbucket for the build status
[12:22:37.443] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:37.443] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:98:0) after 1m0s
[12:23:37.517] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:98:0)
[12:23:37.517] Timer tick, asking Buildbucket for the build status
[12:23:39.732] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:39.732] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:99:0) after 1m0s
[12:24:39.760] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:99:0)
[12:24:39.760] Timer tick, asking Buildbucket for the build status
[12:24:39.833] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:39.833] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:100:0) after 1m0s
[12:25:39.888] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:100:0)
[12:25:39.888] Timer tick, asking Buildbucket for the build status
[12:25:40.014] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:40.015] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:101:0) after 1m0s
[12:26:40.042] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:101:0)
[12:26:40.042] Timer tick, asking Buildbucket for the build status
[12:26:40.126] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:40.126] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:102:0) after 1m0s
[12:27:40.269] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:102:0)
[12:27:40.269] Timer tick, asking Buildbucket for the build status
[12:27:42.220] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:42.220] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:103:0) after 1m0s
[12:28:42.307] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:103:0)
[12:28:42.307] Timer tick, asking Buildbucket for the build status
[12:28:43.965] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:43.965] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:104:0) after 1m0s
[12:29:44.003] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:104:0)
[12:29:44.003] Timer tick, asking Buildbucket for the build status
[12:29:44.099] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:44.099] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:105:0) after 1m0s
[12:30:44.285] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:105:0)
[12:30:44.285] Timer tick, asking Buildbucket for the build status
[12:30:44.988] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:44.988] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:106:0) after 1m0s
[12:31:45.177] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:106:0)
[12:31:45.177] Timer tick, asking Buildbucket for the build status
[12:31:45.272] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:45.272] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:107:0) after 1m0s
[12:32:45.355] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:107:0)
[12:32:45.355] Timer tick, asking Buildbucket for the build status
[12:32:45.801] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:45.801] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:108:0) after 1m0s
[12:33:45.988] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:108:0)
[12:33:45.988] Timer tick, asking Buildbucket for the build status
[12:33:46.249] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:46.249] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:109:0) after 1m0s
[12:34:46.431] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:109:0)
[12:34:46.431] Timer tick, asking Buildbucket for the build status
[12:34:46.617] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:46.617] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:110:0) after 1m0s
[12:35:46.748] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:110:0)
[12:35:46.748] Timer tick, asking Buildbucket for the build status
[12:35:47.009] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:47.009] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:111:0) after 1m0s
[12:36:46.996] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:111:0)
[12:36:46.996] Timer tick, asking Buildbucket for the build status
[12:36:47.130] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:47.130] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:112:0) after 1m0s
[12:37:47.245] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:112:0)
[12:37:47.245] Timer tick, asking Buildbucket for the build status
[12:37:47.558] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:47.558] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:113:0) after 1m0s
[12:38:47.697] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:113:0)
[12:38:47.697] Timer tick, asking Buildbucket for the build status
[12:38:49.075] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:49.075] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:114:0) after 1m0s
[12:39:49.126] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:114:0)
[12:39:49.126] Timer tick, asking Buildbucket for the build status
[12:39:49.244] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:49.244] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:115:0) after 1m0s
[12:40:49.357] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:115:0)
[12:40:49.357] Timer tick, asking Buildbucket for the build status
[12:40:50.385] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:50.385] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:116:0) after 1m0s
[12:41:50.406] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:116:0)
[12:41:50.406] Timer tick, asking Buildbucket for the build status
[12:41:50.538] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:50.538] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:117:0) after 1m0s
[12:42:50.563] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:117:0)
[12:42:50.563] Timer tick, asking Buildbucket for the build status
[12:42:50.679] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:50.679] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:118:0) after 1m0s
[12:43:50.815] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:118:0)
[12:43:50.815] Timer tick, asking Buildbucket for the build status
[12:43:50.902] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:50.902] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:119:0) after 1m0s
[12:44:50.997] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:119:0)
[12:44:50.997] Timer tick, asking Buildbucket for the build status
[12:44:51.169] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:51.169] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:120:0) after 1m0s
[12:45:51.270] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:120:0)
[12:45:51.270] Timer tick, asking Buildbucket for the build status
[12:45:51.333] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:51.333] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:121:0) after 1m0s
[12:46:51.421] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:121:0)
[12:46:51.421] Timer tick, asking Buildbucket for the build status
[12:46:51.590] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:51.590] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:122:0) after 1m0s
[12:47:51.615] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:122:0)
[12:47:51.615] Timer tick, asking Buildbucket for the build status
[12:47:51.791] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:51.791] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:123:0) after 1m0s
[12:48:51.882] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:123:0)
[12:48:51.882] Timer tick, asking Buildbucket for the build status
[12:48:53.475] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:53.475] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:124:0) after 1m0s
[12:49:53.528] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:124:0)
[12:49:53.528] Timer tick, asking Buildbucket for the build status
[12:49:53.848] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:53.848] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:125:0) after 1m0s
[12:50:54.305] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:125:0)
[12:50:54.305] Timer tick, asking Buildbucket for the build status
[12:50:54.468] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:54.468] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:126:0) after 1m0s
[12:51:54.516] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:126:0)
[12:51:54.516] Timer tick, asking Buildbucket for the build status
[12:51:54.727] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:54.727] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:127:0) after 1m0s
[12:52:54.704] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:127:0)
[12:52:54.704] Timer tick, asking Buildbucket for the build status
[12:52:56.286] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:56.286] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:128:0) after 1m0s
[12:53:56.514] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:128:0)
[12:53:56.514] Timer tick, asking Buildbucket for the build status
[12:53:56.596] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:56.596] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:129:0) after 1m0s
[12:54:56.679] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:129:0)
[12:54:56.679] Timer tick, asking Buildbucket for the build status
[12:54:56.759] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:56.759] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:130:0) after 1m0s
[12:55:56.874] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:130:0)
[12:55:56.874] Timer tick, asking Buildbucket for the build status
[12:55:57.076] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:57.076] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:131:0) after 1m0s
[12:56:57.291] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:131:0)
[12:56:57.291] Timer tick, asking Buildbucket for the build status
[12:56:57.500] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:57.500] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:132:0) after 1m0s
[12:57:57.772] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:132:0)
[12:57:57.772] Timer tick, asking Buildbucket for the build status
[12:57:58.130] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:58.130] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:133:0) after 1m0s
[12:58:58.234] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:133:0)
[12:58:58.234] Timer tick, asking Buildbucket for the build status
[12:58:58.945] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:58.945] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:134:0) after 1m0s
[12:59:58.945] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:134:0)
[12:59:58.945] Timer tick, asking Buildbucket for the build status
[12:59:59.938] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:59.938] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:135:0) after 1m0s
[13:00:59.993] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:135:0)
[13:00:59.993] Timer tick, asking Buildbucket for the build status
[13:01:00.274] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:00.274] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:136:0) after 1m0s
[13:02:00.360] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:136:0)
[13:02:00.360] Timer tick, asking Buildbucket for the build status
[13:02:01.352] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:01.352] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:137:0) after 1m0s
[13:03:02.830] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:137:0)
[13:03:02.830] Timer tick, asking Buildbucket for the build status
[13:03:03.156] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:03.156] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:138:0) after 1m0s
[13:04:03.196] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:138:0)
[13:04:03.196] Timer tick, asking Buildbucket for the build status
[13:04:04.022] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:04.022] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:139:0) after 1m0s
[13:05:04.068] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:139:0)
[13:05:04.068] Timer tick, asking Buildbucket for the build status
[13:05:04.156] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:04.156] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:140:0) after 1m0s
[13:06:04.320] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:140:0)
[13:06:04.320] Timer tick, asking Buildbucket for the build status
[13:06:04.593] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:04.593] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:141:0) after 1m0s
[13:07:04.856] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:141:0)
[13:07:04.856] Timer tick, asking Buildbucket for the build status
[13:07:05.371] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:05.371] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:142:0) after 1m0s
[13:08:05.527] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:142:0)
[13:08:05.527] Timer tick, asking Buildbucket for the build status
[13:08:05.805] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:05.805] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:143:0) after 1m0s
[13:09:05.974] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:143:0)
[13:09:05.974] Timer tick, asking Buildbucket for the build status
[13:09:06.358] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:06.358] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:144:0) after 1m0s
[13:10:06.563] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:144:0)
[13:10:06.563] Timer tick, asking Buildbucket for the build status
[13:10:06.695] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:06.695] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:145:0) after 1m0s
[13:11:06.905] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:145:0)
[13:11:06.905] Timer tick, asking Buildbucket for the build status
[13:11:06.982] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:06.982] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:146:0) after 1m0s
[13:12:07.229] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:146:0)
[13:12:07.229] Timer tick, asking Buildbucket for the build status
[13:12:07.379] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:07.379] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:147:0) after 1m0s
[13:13:07.372] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:147:0)
[13:13:07.372] Timer tick, asking Buildbucket for the build status
[13:13:07.679] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:07.679] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:148:0) after 1m0s
[13:14:07.845] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:148:0)
[13:14:07.845] Timer tick, asking Buildbucket for the build status
[13:14:08.048] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:08.048] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:149:0) after 1m0s
[13:15:08.177] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:149:0)
[13:15:08.177] Timer tick, asking Buildbucket for the build status
[13:15:08.358] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:08.358] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:150:0) after 1m0s
[13:16:08.395] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:150:0)
[13:16:08.395] Timer tick, asking Buildbucket for the build status
[13:16:09.501] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:09.501] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:151:0) after 1m0s
[13:17:09.534] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:151:0)
[13:17:09.534] Timer tick, asking Buildbucket for the build status
[13:17:14.171] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:14.171] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:152:0) after 1m0s
[13:18:14.242] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:152:0)
[13:18:14.242] Timer tick, asking Buildbucket for the build status
[13:18:14.417] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:14.417] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:153:0) after 1m0s
[13:19:14.482] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:153:0)
[13:19:14.482] Timer tick, asking Buildbucket for the build status
[13:19:14.710] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:14.710] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:154:0) after 1m0s
[13:20:14.912] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:154:0)
[13:20:14.912] Timer tick, asking Buildbucket for the build status
[13:20:16.707] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:16.707] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:155:0) after 1m0s
[13:21:16.825] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:155:0)
[13:21:16.825] Timer tick, asking Buildbucket for the build status
[13:21:17.121] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:17.121] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:156:0) after 1m0s
[13:22:17.169] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:156:0)
[13:22:17.169] Timer tick, asking Buildbucket for the build status
[13:22:17.237] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:17.237] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:157:0) after 1m0s
[13:23:17.337] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:157:0)
[13:23:17.338] Timer tick, asking Buildbucket for the build status
[13:23:18.599] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:18.599] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:158:0) after 1m0s
[13:24:18.765] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:158:0)
[13:24:18.765] Timer tick, asking Buildbucket for the build status
[13:24:19.072] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:19.073] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:159:0) after 1m0s
[13:25:19.060] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:159:0)
[13:25:19.060] Timer tick, asking Buildbucket for the build status
[13:25:19.243] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:19.243] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:160:0) after 1m0s
[13:26:19.343] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:160:0)
[13:26:19.343] Timer tick, asking Buildbucket for the build status
[13:26:19.676] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:19.676] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:161:0) after 1m0s
[13:27:19.883] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:161:0)
[13:27:19.883] Timer tick, asking Buildbucket for the build status
[13:27:19.966] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:19.966] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:162:0) after 1m0s
[13:28:20.115] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:162:0)
[13:28:20.115] Timer tick, asking Buildbucket for the build status
[13:28:20.267] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:20.267] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:163:0) after 1m0s
[13:29:20.330] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:163:0)
[13:29:20.330] Timer tick, asking Buildbucket for the build status
[13:29:20.620] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:20.620] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:164:0) after 1m0s
[13:30:20.715] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:164:0)
[13:30:20.715] Timer tick, asking Buildbucket for the build status
[13:30:20.877] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:20.877] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:165:0) after 1m0s
[13:31:21.012] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:165:0)
[13:31:21.012] Timer tick, asking Buildbucket for the build status
[13:31:21.202] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:21.202] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:166:0) after 1m0s
[13:32:21.328] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:166:0)
[13:32:21.328] Timer tick, asking Buildbucket for the build status
[13:32:22.245] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:22.245] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:167:0) after 1m0s
[13:33:22.277] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:167:0)
[13:33:22.277] Timer tick, asking Buildbucket for the build status
[13:33:22.968] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:22.968] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:168:0) after 1m0s
[13:34:23.046] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:168:0)
[13:34:23.046] Timer tick, asking Buildbucket for the build status
[13:34:23.127] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:23.127] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:169:0) after 1m0s
[13:35:23.183] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:169:0)
[13:35:23.183] Timer tick, asking Buildbucket for the build status
[13:35:23.258] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:23.258] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:170:0) after 1m0s
[13:36:23.960] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:170:0)
[13:36:23.960] Timer tick, asking Buildbucket for the build status
[13:36:24.123] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:24.123] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:171:0) after 1m0s
[13:37:24.197] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:171:0)
[13:37:24.197] Timer tick, asking Buildbucket for the build status
[13:37:25.068] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:25.068] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:172:0) after 1m0s
[13:38:25.073] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:172:0)
[13:38:25.073] Timer tick, asking Buildbucket for the build status
[13:38:25.162] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:25.162] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:173:0) after 1m0s
[13:39:25.275] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:173:0)
[13:39:25.275] Timer tick, asking Buildbucket for the build status
[13:39:25.645] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:25.645] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:174:0) after 1m0s
[13:40:25.811] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:174:0)
[13:40:25.811] Timer tick, asking Buildbucket for the build status
[13:40:26.028] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:26.028] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:175:0) after 1m0s
[13:41:26.649] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:175:0)
[13:41:26.649] Timer tick, asking Buildbucket for the build status
[13:41:27.900] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:27.900] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:176:0) after 1m0s
[13:42:27.932] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:176:0)
[13:42:27.932] Timer tick, asking Buildbucket for the build status
[13:42:28.921] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:28.921] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:177:0) after 1m0s
[13:43:28.972] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:177:0)
[13:43:28.972] Timer tick, asking Buildbucket for the build status
[13:43:29.346] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:29.346] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:178:0) after 1m0s
[13:44:29.426] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:178:0)
[13:44:29.426] Timer tick, asking Buildbucket for the build status
[13:44:29.505] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:29.505] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:179:0) after 1m0s
[13:45:29.505] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:179:0)
[13:45:29.505] Timer tick, asking Buildbucket for the build status
[13:45:32.849] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:32.849] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:180:0) after 1m0s
[13:46:32.846] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:180:0)
[13:46:32.846] Timer tick, asking Buildbucket for the build status
[13:46:32.966] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:32.966] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:181:0) after 1m0s
[13:47:32.994] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:181:0)
[13:47:32.994] Timer tick, asking Buildbucket for the build status
[13:47:33.153] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:33.153] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:182:0) after 1m0s
[13:48:33.185] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:182:0)
[13:48:33.185] Timer tick, asking Buildbucket for the build status
[13:48:33.513] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:33.513] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:183:0) after 1m0s
[13:49:33.620] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:183:0)
[13:49:33.620] Timer tick, asking Buildbucket for the build status
[13:49:33.725] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:33.725] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:184:0) after 1m0s
[13:50:33.894] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:184:0)
[13:50:33.894] Timer tick, asking Buildbucket for the build status
[13:50:34.123] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:34.123] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:185:0) after 1m0s
[13:51:34.309] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:185:0)
[13:51:34.309] Timer tick, asking Buildbucket for the build status
[13:51:34.621] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:34.621] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:186:0) after 1m0s
[13:52:34.728] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:186:0)
[13:52:34.728] Timer tick, asking Buildbucket for the build status
[13:52:34.844] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:34.844] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:187:0) after 1m0s
[13:53:34.892] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:187:0)
[13:53:34.892] Timer tick, asking Buildbucket for the build status
[13:53:34.967] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:34.967] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:188:0) after 1m0s
[13:54:35.041] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:188:0)
[13:54:35.041] Timer tick, asking Buildbucket for the build status
[13:54:36.267] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:36.267] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:189:0) after 1m0s
[13:55:36.395] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:189:0)
[13:55:36.395] Timer tick, asking Buildbucket for the build status
[13:55:36.461] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:36.461] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:190:0) after 1m0s
[13:56:36.567] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:190:0)
[13:56:36.567] Timer tick, asking Buildbucket for the build status
[13:56:36.708] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:36.708] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:191:0) after 1m0s
[13:57:36.742] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:191:0)
[13:57:36.742] Timer tick, asking Buildbucket for the build status
[13:57:36.890] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:36.890] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:192:0) after 1m0s
[13:58:36.920] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:192:0)
[13:58:36.920] Timer tick, asking Buildbucket for the build status
[13:58:37.114] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:37.114] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:193:0) after 1m0s
[13:59:37.184] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:193:0)
[13:59:37.184] Timer tick, asking Buildbucket for the build status
[13:59:37.250] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:37.250] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:194:0) after 1m0s
[14:00:37.403] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:194:0)
[14:00:37.403] Timer tick, asking Buildbucket for the build status
[14:00:37.601] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:37.601] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:195:0) after 1m0s
[14:01:37.710] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:195:0)
[14:01:37.710] Timer tick, asking Buildbucket for the build status
[14:01:37.923] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:37.923] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:196:0) after 1m0s
[14:02:37.958] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:196:0)
[14:02:37.958] Timer tick, asking Buildbucket for the build status
[14:02:38.141] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:38.141] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:197:0) after 1m0s
[14:03:38.218] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:197:0)
[14:03:38.218] Timer tick, asking Buildbucket for the build status
[14:03:38.378] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:38.378] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:198:0) after 1m0s
[14:04:38.429] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:198:0)
[14:04:38.429] Timer tick, asking Buildbucket for the build status
[14:04:38.920] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:38.920] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:199:0) after 1m0s
[14:05:38.946] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:199:0)
[14:05:38.946] Timer tick, asking Buildbucket for the build status
[14:05:39.473] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:39.473] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:200:0) after 1m0s
[14:06:39.520] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:200:0)
[14:06:39.520] Timer tick, asking Buildbucket for the build status
[14:06:39.588] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:39.588] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:201:0) after 1m0s
[14:07:39.631] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:201:0)
[14:07:39.631] Timer tick, asking Buildbucket for the build status
[14:07:39.768] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:39.768] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:202:0) after 1m0s
[14:08:39.796] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:202:0)
[14:08:39.796] Timer tick, asking Buildbucket for the build status
[14:08:40.247] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:40.247] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:203:0) after 1m0s
[14:09:40.284] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:203:0)
[14:09:40.284] Timer tick, asking Buildbucket for the build status
[14:09:41.092] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:41.092] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:204:0) after 1m0s
[14:10:41.139] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:204:0)
[14:10:41.139] Timer tick, asking Buildbucket for the build status
[14:10:41.476] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:41.476] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:205:0) after 1m0s
[14:11:41.537] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:205:0)
[14:11:41.537] Timer tick, asking Buildbucket for the build status
[14:11:41.799] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:41.799] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:206:0) after 1m0s
[14:12:41.876] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:206:0)
[14:12:41.876] Timer tick, asking Buildbucket for the build status
[14:12:42.036] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:42.036] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:207:0) after 1m0s
[14:13:42.081] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:207:0)
[14:13:42.081] Timer tick, asking Buildbucket for the build status
[14:13:42.305] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:42.305] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:208:0) after 1m0s
[14:14:42.363] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:208:0)
[14:14:42.363] Timer tick, asking Buildbucket for the build status
[14:14:42.428] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:42.428] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:209:0) after 1m0s
[14:15:42.456] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:209:0)
[14:15:42.456] Timer tick, asking Buildbucket for the build status
[14:15:42.509] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:42.509] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:210:0) after 1m0s
[14:16:42.539] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:210:0)
[14:16:42.539] Timer tick, asking Buildbucket for the build status
[14:16:42.608] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:42.608] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:211:0) after 1m0s
[14:17:42.645] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:211:0)
[14:17:42.645] Timer tick, asking Buildbucket for the build status
[14:17:43.745] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:43.745] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:212:0) after 1m0s
[14:18:43.777] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:212:0)
[14:18:43.777] Timer tick, asking Buildbucket for the build status
[14:18:43.860] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:43.860] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:213:0) after 1m0s
[14:19:43.888] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:213:0)
[14:19:43.888] Timer tick, asking Buildbucket for the build status
[14:19:45.165] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:45.165] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:214:0) after 1m0s
[14:20:45.316] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:214:0)
[14:20:45.316] Timer tick, asking Buildbucket for the build status
[14:20:45.477] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:45.477] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:215:0) after 1m0s
[14:21:45.479] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:215:0)
[14:21:45.479] Timer tick, asking Buildbucket for the build status
[14:21:45.701] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:45.702] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:216:0) after 1m0s
[14:22:45.742] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:216:0)
[14:22:45.742] Timer tick, asking Buildbucket for the build status
[14:22:47.887] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:47.887] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:217:0) after 1m0s
[14:23:48.008] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:217:0)
[14:23:48.008] Timer tick, asking Buildbucket for the build status
[14:23:48.523] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:48.523] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:218:0) after 1m0s
[14:24:48.544] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:218:0)
[14:24:48.544] Timer tick, asking Buildbucket for the build status
[14:24:49.426] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:49.426] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:219:0) after 1m0s
[14:25:49.597] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:219:0)
[14:25:49.597] Timer tick, asking Buildbucket for the build status
[14:25:49.657] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:49.657] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:220:0) after 1m0s
[14:26:49.763] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:220:0)
[14:26:49.763] Timer tick, asking Buildbucket for the build status
[14:26:49.837] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:49.837] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:221:0) after 1m0s
[14:27:49.899] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:221:0)
[14:27:49.899] Timer tick, asking Buildbucket for the build status
[14:27:50.013] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:50.013] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:222:0) after 1m0s
[14:28:50.038] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:222:0)
[14:28:50.038] Timer tick, asking Buildbucket for the build status
[14:28:50.411] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:50.411] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:223:0) after 1m0s
[14:29:50.602] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:223:0)
[14:29:50.602] Timer tick, asking Buildbucket for the build status
[14:29:50.824] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:50.824] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:224:0) after 1m0s
[14:30:50.960] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:224:0)
[14:30:50.960] Timer tick, asking Buildbucket for the build status
[14:30:51.117] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:51.117] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:225:0) after 1m0s
[14:31:51.148] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:225:0)
[14:31:51.148] Timer tick, asking Buildbucket for the build status
[14:31:51.432] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:51.432] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:226:0) after 1m0s
[14:32:51.474] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:226:0)
[14:32:51.474] Timer tick, asking Buildbucket for the build status
[14:32:52.099] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:52.099] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:227:0) after 1m0s
[14:33:52.088] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:227:0)
[14:33:52.088] Timer tick, asking Buildbucket for the build status
[14:33:52.425] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:52.425] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:228:0) after 1m0s
[14:34:52.430] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:228:0)
[14:34:52.430] Timer tick, asking Buildbucket for the build status
[14:34:53.114] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:53.114] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:229:0) after 1m0s
[14:35:53.165] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:229:0)
[14:35:53.165] Timer tick, asking Buildbucket for the build status
[14:35:53.223] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:53.223] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:230:0) after 1m0s
[14:36:53.287] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:230:0)
[14:36:53.287] Timer tick, asking Buildbucket for the build status
[14:36:53.352] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:53.352] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:231:0) after 1m0s
[14:37:53.369] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:231:0)
[14:37:53.369] Timer tick, asking Buildbucket for the build status
[14:37:56.022] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:56.022] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:232:0) after 1m0s
[14:38:56.061] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:232:0)
[14:38:56.061] Timer tick, asking Buildbucket for the build status
[14:38:56.153] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:56.153] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:233:0) after 1m0s
[14:39:56.242] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:233:0)
[14:39:56.242] Timer tick, asking Buildbucket for the build status
[14:39:56.308] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:56.308] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:234:0) after 1m0s
[14:40:56.345] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:234:0)
[14:40:56.345] Timer tick, asking Buildbucket for the build status
[14:40:56.510] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:56.510] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:235:0) after 1m0s
[14:41:56.541] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:235:0)
[14:41:56.541] Timer tick, asking Buildbucket for the build status
[14:41:56.719] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:56.719] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:236:0) after 1m0s
[14:42:56.752] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:236:0)
[14:42:56.752] Timer tick, asking Buildbucket for the build status
[14:42:56.916] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:56.916] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:237:0) after 1m0s
[14:43:56.949] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:237:0)
[14:43:56.949] Timer tick, asking Buildbucket for the build status
[14:43:57.019] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:57.019] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:238:0) after 1m0s
[14:44:57.052] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:238:0)
[14:44:57.052] Timer tick, asking Buildbucket for the build status
[14:44:57.164] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:57.164] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:239:0) after 1m0s
[14:45:57.275] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:239:0)
[14:45:57.275] Timer tick, asking Buildbucket for the build status
[14:45:57.404] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:57.404] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:240:0) after 1m0s
[14:46:57.458] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:240:0)
[14:46:57.458] Timer tick, asking Buildbucket for the build status
[14:46:57.646] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:57.646] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:241:0) after 1m0s
[14:47:57.721] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:241:0)
[14:47:57.721] Timer tick, asking Buildbucket for the build status
[14:47:57.879] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:57.879] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:242:0) after 1m0s
[14:48:58.086] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:242:0)
[14:48:58.086] Timer tick, asking Buildbucket for the build status
[14:48:58.453] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:58.453] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:243:0) after 1m0s
[14:49:58.560] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:243:0)
[14:49:58.560] Timer tick, asking Buildbucket for the build status
[14:49:58.723] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:58.723] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:244:0) after 1m0s
[14:50:58.969] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:244:0)
[14:50:58.969] Timer tick, asking Buildbucket for the build status
[14:50:59.078] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:59.078] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:245:0) after 1m0s
[14:51:59.115] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:245:0)
[14:51:59.115] Timer tick, asking Buildbucket for the build status
[14:51:59.179] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:59.180] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:246:0) after 1m0s
[14:52:59.258] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:246:0)
[14:52:59.258] Timer tick, asking Buildbucket for the build status
[14:52:59.367] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:59.367] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:247:0) after 1m0s
[14:53:59.386] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:247:0)
[14:53:59.386] Timer tick, asking Buildbucket for the build status
[14:53:59.463] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:59.463] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:248:0) after 1m0s
[14:54:59.518] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:248:0)
[14:54:59.518] Timer tick, asking Buildbucket for the build status
[14:54:59.631] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:59.631] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:249:0) after 1m0s
[14:55:59.700] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:249:0)
[14:55:59.700] Timer tick, asking Buildbucket for the build status
[14:55:59.761] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:59.761] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:250:0) after 1m0s
[14:56:59.810] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:250:0)
[14:56:59.810] Timer tick, asking Buildbucket for the build status
[14:56:59.876] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:59.876] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:251:0) after 1m0s
[14:58:00.044] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:251:0)
[14:58:00.044] Timer tick, asking Buildbucket for the build status
[14:58:00.293] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:00.293] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:252:0) after 1m0s
[14:59:00.293] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:252:0)
[14:59:00.293] Timer tick, asking Buildbucket for the build status
[14:59:00.466] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:00.466] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:253:0) after 1m0s
[15:00:00.527] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:253:0)
[15:00:00.527] Timer tick, asking Buildbucket for the build status
[15:00:00.724] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:00.724] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:254:0) after 1m0s
[15:01:02.152] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:254:0)
[15:01:02.152] Timer tick, asking Buildbucket for the build status
[15:01:04.266] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:04.266] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:255:0) after 1m0s
[15:02:04.343] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:255:0)
[15:02:04.343] Timer tick, asking Buildbucket for the build status
[15:02:04.433] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:04.433] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:256:0) after 1m0s
[15:03:04.512] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:256:0)
[15:03:04.512] Timer tick, asking Buildbucket for the build status
[15:03:04.635] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:04.635] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:257:0) after 1m0s
[15:04:04.667] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:257:0)
[15:04:04.667] Timer tick, asking Buildbucket for the build status
[15:04:05.097] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:05.097] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:258:0) after 1m0s
[15:05:05.255] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:258:0)
[15:05:05.255] Timer tick, asking Buildbucket for the build status
[15:05:05.514] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:05.514] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:259:0) after 1m0s
[15:06:05.571] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:259:0)
[15:06:05.571] Timer tick, asking Buildbucket for the build status
[15:06:09.635] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:09.635] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:260:0) after 1m0s
[15:07:09.737] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:260:0)
[15:07:09.737] Timer tick, asking Buildbucket for the build status
[15:07:10.004] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:10.004] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:261:0) after 1m0s
[15:08:10.042] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:261:0)
[15:08:10.043] Timer tick, asking Buildbucket for the build status
[15:08:10.290] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:10.291] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:262:0) after 1m0s
[15:09:10.334] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:262:0)
[15:09:10.334] Timer tick, asking Buildbucket for the build status
[15:09:11.590] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:11.590] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:263:0) after 1m0s
[15:10:11.658] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:263:0)
[15:10:11.658] Timer tick, asking Buildbucket for the build status
[15:10:11.897] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:11.897] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:264:0) after 1m0s
[15:11:11.932] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:264:0)
[15:11:11.932] Timer tick, asking Buildbucket for the build status
[15:11:12.066] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:12.066] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:265:0) after 1m0s
[15:12:12.119] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:265:0)
[15:12:12.119] Timer tick, asking Buildbucket for the build status
[15:12:12.203] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:12.203] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:266:0) after 1m0s
[15:13:12.259] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:266:0)
[15:13:12.259] Timer tick, asking Buildbucket for the build status
[15:13:12.435] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:12.435] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:267:0) after 1m0s
[15:14:12.508] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:267:0)
[15:14:12.508] Timer tick, asking Buildbucket for the build status
[15:14:12.585] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:12.585] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:268:0) after 1m0s
[15:15:12.657] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:268:0)
[15:15:12.657] Timer tick, asking Buildbucket for the build status
[15:15:13.264] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:13.264] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:269:0) after 1m0s
[15:16:13.309] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:269:0)
[15:16:13.309] Timer tick, asking Buildbucket for the build status
[15:16:13.553] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:13.553] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:270:0) after 1m0s
[15:17:13.615] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:270:0)
[15:17:13.615] Timer tick, asking Buildbucket for the build status
[15:17:13.744] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:13.744] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:271:0) after 1m0s
[15:18:13.932] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:271:0)
[15:18:13.932] Timer tick, asking Buildbucket for the build status
[15:18:14.025] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:14.025] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:272:0) after 1m0s
[15:19:14.119] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:272:0)
[15:19:14.119] Timer tick, asking Buildbucket for the build status
[15:19:14.320] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:14.320] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:273:0) after 1m0s
[15:20:14.434] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:273:0)
[15:20:14.434] Timer tick, asking Buildbucket for the build status
[15:20:14.631] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:14.631] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:274:0) after 1m0s
[15:21:14.665] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:274:0)
[15:21:14.665] Timer tick, asking Buildbucket for the build status
[15:21:14.829] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:14.829] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:275:0) after 1m0s
[15:22:14.904] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:275:0)
[15:22:14.904] Timer tick, asking Buildbucket for the build status
[15:22:14.972] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:14.972] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:276:0) after 1m0s
[15:23:15.107] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:276:0)
[15:23:15.107] Timer tick, asking Buildbucket for the build status
[15:23:15.687] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:15.687] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:277:0) after 1m0s
[15:24:15.854] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:277:0)
[15:24:15.854] Timer tick, asking Buildbucket for the build status
[15:24:15.964] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:15.964] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:278:0) after 1m0s
[15:25:16.119] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:278:0)
[15:25:16.119] Timer tick, asking Buildbucket for the build status
[15:25:16.190] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:16.190] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:279:0) after 1m0s
[15:26:16.376] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:279:0)
[15:26:16.376] Timer tick, asking Buildbucket for the build status
[15:26:16.440] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:16.440] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:280:0) after 1m0s
[15:27:16.622] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:280:0)
[15:27:16.622] Timer tick, asking Buildbucket for the build status
[15:27:16.771] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:16.771] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:281:0) after 1m0s
[15:28:17.066] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:281:0)
[15:28:17.066] Timer tick, asking Buildbucket for the build status
[15:28:17.459] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:17.460] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:282:0) after 1m0s
[15:29:17.539] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:282:0)
[15:29:17.540] Timer tick, asking Buildbucket for the build status
[15:29:17.613] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:17.613] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:283:0) after 1m0s
[15:30:17.649] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:283:0)
[15:30:17.649] Timer tick, asking Buildbucket for the build status
[15:30:18.775] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:18.775] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:284:0) after 1m0s
[15:31:19.010] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:284:0)
[15:31:19.017] Timer tick, asking Buildbucket for the build status
[15:31:19.096] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:19.096] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:285:0) after 1m0s
[15:32:19.216] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:285:0)
[15:32:19.216] Timer tick, asking Buildbucket for the build status
[15:32:19.273] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:19.273] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:286:0) after 1m0s
[15:33:19.294] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:286:0)
[15:33:19.294] Timer tick, asking Buildbucket for the build status
[15:33:19.636] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:19.636] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:287:0) after 1m0s
[15:34:19.667] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:287:0)
[15:34:19.667] Timer tick, asking Buildbucket for the build status
[15:34:20.038] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:20.038] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:288:0) after 1m0s
[15:35:20.857] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:288:0)
[15:35:20.857] Timer tick, asking Buildbucket for the build status
[15:35:21.428] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:21.428] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:289:0) after 1m0s
[15:36:21.856] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:289:0)
[15:36:21.856] Timer tick, asking Buildbucket for the build status
[15:36:21.949] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:21.949] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:290:0) after 1m0s
[15:37:22.238] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:290:0)
[15:37:22.238] Timer tick, asking Buildbucket for the build status
[15:37:22.340] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:22.340] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:291:0) after 1m0s
[15:38:22.455] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:291:0)
[15:38:22.455] Timer tick, asking Buildbucket for the build status
[15:38:22.567] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:22.567] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:292:0) after 1m0s
[15:39:22.679] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:292:0)
[15:39:22.679] Timer tick, asking Buildbucket for the build status
[15:39:22.818] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:22.818] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:293:0) after 1m0s
[15:40:22.922] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:293:0)
[15:40:22.922] Timer tick, asking Buildbucket for the build status
[15:40:22.979] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:22.979] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:294:0) after 1m0s
[15:41:23.092] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:294:0)
[15:41:23.092] Timer tick, asking Buildbucket for the build status
[15:41:23.150] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:23.150] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:295:0) after 1m0s
[15:42:23.398] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:295:0)
[15:42:23.398] Timer tick, asking Buildbucket for the build status
[15:42:23.476] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:23.476] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:296:0) after 1m0s
[15:43:23.764] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:296:0)
[15:43:23.764] Timer tick, asking Buildbucket for the build status
[15:43:23.921] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:23.921] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:297:0) after 1m0s
[15:44:24.025] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:297:0)
[15:44:24.025] Timer tick, asking Buildbucket for the build status
[15:44:24.171] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:24.171] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:298:0) after 1m0s
[15:45:24.332] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:298:0)
[15:45:24.332] Timer tick, asking Buildbucket for the build status
[15:45:25.671] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:25.671] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:299:0) after 1m0s
[15:46:25.869] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:299:0)
[15:46:25.869] Timer tick, asking Buildbucket for the build status
[15:46:25.991] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:25.991] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:300:0) after 1m0s
[15:47:26.023] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:300:0)
[15:47:26.023] Timer tick, asking Buildbucket for the build status
[15:47:26.155] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:26.155] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:301:0) after 1m0s
[15:48:26.183] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:301:0)
[15:48:26.183] Timer tick, asking Buildbucket for the build status
[15:48:26.277] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:26.277] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:302:0) after 1m0s
[15:49:26.364] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:302:0)
[15:49:26.364] Timer tick, asking Buildbucket for the build status
[15:49:26.554] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:26.554] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:303:0) after 1m0s
[15:50:26.645] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:303:0)
[15:50:26.645] Timer tick, asking Buildbucket for the build status
[15:50:26.779] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:26.779] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:304:0) after 1m0s
[15:51:26.824] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:304:0)
[15:51:26.824] Timer tick, asking Buildbucket for the build status
[15:51:26.892] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:26.892] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:305:0) after 1m0s
[15:52:26.925] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:305:0)
[15:52:26.925] Timer tick, asking Buildbucket for the build status
[15:52:27.105] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:27.105] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:306:0) after 1m0s
[15:53:27.135] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:306:0)
[15:53:27.135] Timer tick, asking Buildbucket for the build status
[15:53:27.443] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:27.443] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:307:0) after 1m0s
[15:54:27.480] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:307:0)
[15:54:27.480] Timer tick, asking Buildbucket for the build status
[15:54:27.722] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:27.722] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:308:0) after 1m0s
[15:55:27.831] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:308:0)
[15:55:27.831] Timer tick, asking Buildbucket for the build status
[15:55:27.908] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:27.908] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:309:0) after 1m0s
[15:56:28.036] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:309:0)
[15:56:28.036] Timer tick, asking Buildbucket for the build status
[15:56:28.263] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:28.263] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:310:0) after 1m0s
[15:57:28.333] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:310:0)
[15:57:28.333] Timer tick, asking Buildbucket for the build status
[15:57:28.405] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:28.405] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:311:0) after 1m0s
[15:58:28.446] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:311:0)
[15:58:28.446] Timer tick, asking Buildbucket for the build status
[15:58:28.656] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:28.656] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:312:0) after 1m0s
[15:59:28.665] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:312:0)
[15:59:28.665] Timer tick, asking Buildbucket for the build status
[15:59:28.854] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:28.855] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:313:0) after 1m0s
[16:00:28.910] Handling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:313:0)
[16:00:28.910] Timer tick, asking Buildbucket for the build status
[16:00:29.843] Build 8861940033335166784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:29.843] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9027370095343203712:314:0) after 1m0s
[16:00:36.850] Received PubSub notification, asking Buildbucket for the build status
[16:00:37.132] Build 8861940033335166784: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:00:37.132] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1607011228802028",
"created_by": "project:chromium",
"created_ts": "1606992418883460",
"id": "8861940033335166784",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"81f43d4dcc92c4a79c2adb5d9b92cb84640daef4\"}}",
"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\": \"81f43d4dcc92c4a79c2adb5d9b92cb84640daef4\", \"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-exn0\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 1114, \"got_angle_revision\": \"8670d6183a8439622e5f4527e4971bafb1a9ffa7\", \"got_dawn_revision\": \"3668d352bc5fe13af27dc178d203f67032537a7f\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"81f43d4dcc92c4a79c2adb5d9b92cb84640daef4\", \"got_revision_cp\": \"refs/heads/master@{#833241}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"bae138de13ac876cbca0e30a40b89dc808e2b29d\", \"got_v8_revision\": \"2c0399211ca667c8af5cd5e98bee65b180e356a2\", \"got_v8_revision_cp\": \"refs/heads/8.9.89@{#1}\", \"got_webrtc_revision\": \"6e7167456b5eba36c7985d6a74f1d191958d4e0f\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32749}\", \"mirrored_builders\": [\"tryserver.chromium:win-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"81f43d4dcc92c4a79c2adb5d9b92cb84640daef4\"}, \"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-exn0\"], \"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\": [\"5640-d0eb544\"], \"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": "1606992640745866",
"status": "COMPLETED",
"status_changed_ts": "1607011236324954",
"tags": [
"build_address:luci.chromium.ci/win-official/1114",
"builder:win-official",
"buildset:commit/git/81f43d4dcc92c4a79c2adb5d9b92cb84640daef4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/81f43d4dcc92c4a79c2adb5d9b92cb84640daef4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027370095343203712",
"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/8861940033335166784/+/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:504107e6e6019410",
"user_agent:luci-scheduler"
],
"updated_ts": "1607011236347833",
"url": "https://ci.chromium.org/b/8861940033335166784",
"utcnow_ts": "1607011237101044"
}
}
[16:00:37.132] Invocation finished in 5h13m39.546886374s with status SUCCEEDED