[14:53:34.172] New invocation is queued and will start shortly
[14:53:35.325] Starting the invocation (attempt 1)
[14:53:35.363] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:53:35.364] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:53:35.364] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9032246816203834864",
"parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"c98f04d845668e4e1af41a27115ac289c06d73cd\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-official",
"scheduler_invocation_id:9032246816203834864",
"scheduler_job_id:chromium/win-official",
"user_agent:luci-scheduler",
"buildset:commit/git/c98f04d845668e4e1af41a27115ac289c06d73cd",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c98f04d845668e4e1af41a27115ac289c06d73cd",
"gitiles_ref:refs/heads/master"
]
}
[14:53:36.223] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1602341615442087",
"id": "8866816754204538784",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c98f04d845668e4e1af41a27115ac289c06d73cd\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1602341616005021",
"tags": [
"build_address:luci.chromium.ci/win-official/784",
"builder:win-official",
"buildset:commit/git/c98f04d845668e4e1af41a27115ac289c06d73cd",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c98f04d845668e4e1af41a27115ac289c06d73cd",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9032246816203834864",
"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/8866816754204538784/+/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": "1602341616005195",
"url": "https://ci.chromium.org/b/8866816754204538784",
"utcnow_ts": "1602341616216584"
}
}
[14:53:36.223] Task URL: https://ci.chromium.org/b/8866816754204538784
[14:53:36.223] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:2:0) after 1m0s
[14:54:36.259] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:2:0)
[14:54:36.259] Timer tick, asking Buildbucket for the build status
[14:54:36.414] Build 8866816754204538784: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:54:36.414] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:3:0) after 1m0s
[14:55:36.400] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:3:0)
[14:55:36.400] Timer tick, asking Buildbucket for the build status
[14:55:36.665] Build 8866816754204538784: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:55:36.665] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:4:0) after 1m0s
[14:56:36.730] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:4:0)
[14:56:36.730] Timer tick, asking Buildbucket for the build status
[14:56:37.003] Build 8866816754204538784: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:56:37.003] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:5:0) after 1m0s
[14:57:37.024] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:5:0)
[14:57:37.024] Timer tick, asking Buildbucket for the build status
[14:57:37.103] Build 8866816754204538784: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:57:37.103] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:6:0) after 1m0s
[14:58:10.321] Received PubSub notification, asking Buildbucket for the build status
[14:58:10.486] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:37.133] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:6:0)
[14:58:37.133] Timer tick, asking Buildbucket for the build status
[14:58:37.310] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:37.310] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:8:0) after 1m0s
[14:59:37.411] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:8:0)
[14:59:37.412] Timer tick, asking Buildbucket for the build status
[14:59:37.533] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:37.533] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:9:0) after 1m0s
[15:00:37.583] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:9:0)
[15:00:37.583] Timer tick, asking Buildbucket for the build status
[15:00:37.851] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:37.851] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:10:0) after 1m0s
[15:01:37.847] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:10:0)
[15:01:37.848] Timer tick, asking Buildbucket for the build status
[15:01:38.014] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:38.014] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:11:0) after 1m0s
[15:02:38.032] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:11:0)
[15:02:38.032] Timer tick, asking Buildbucket for the build status
[15:02:38.176] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:38.176] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:12:0) after 1m0s
[15:03:38.196] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:12:0)
[15:03:38.196] Timer tick, asking Buildbucket for the build status
[15:03:38.279] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:38.279] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:13:0) after 1m0s
[15:04:38.299] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:13:0)
[15:04:38.299] Timer tick, asking Buildbucket for the build status
[15:04:38.397] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:38.397] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:14:0) after 1m0s
[15:05:38.394] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:14:0)
[15:05:38.394] Timer tick, asking Buildbucket for the build status
[15:05:38.849] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:38.849] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:15:0) after 1m0s
[15:06:38.823] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:15:0)
[15:06:38.823] Timer tick, asking Buildbucket for the build status
[15:06:38.924] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:38.924] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:16:0) after 1m0s
[15:07:38.945] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:16:0)
[15:07:38.945] Timer tick, asking Buildbucket for the build status
[15:07:39.048] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:39.048] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:17:0) after 1m0s
[15:08:39.070] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:17:0)
[15:08:39.070] Timer tick, asking Buildbucket for the build status
[15:08:39.187] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:39.187] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:18:0) after 1m0s
[15:09:39.209] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:18:0)
[15:09:39.209] Timer tick, asking Buildbucket for the build status
[15:09:39.279] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:39.279] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:19:0) after 1m0s
[15:10:39.300] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:19:0)
[15:10:39.301] Timer tick, asking Buildbucket for the build status
[15:10:39.373] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:39.373] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:20:0) after 1m0s
[15:11:39.395] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:20:0)
[15:11:39.395] Timer tick, asking Buildbucket for the build status
[15:11:39.476] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:39.476] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:21:0) after 1m0s
[15:12:39.528] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:21:0)
[15:12:39.528] Timer tick, asking Buildbucket for the build status
[15:12:39.677] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:39.677] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:22:0) after 1m0s
[15:13:39.844] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:22:0)
[15:13:39.844] Timer tick, asking Buildbucket for the build status
[15:13:39.985] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:39.985] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:23:0) after 1m0s
[15:14:39.960] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:23:0)
[15:14:39.960] Timer tick, asking Buildbucket for the build status
[15:14:40.019] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:40.019] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:24:0) after 1m0s
[15:15:40.046] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:24:0)
[15:15:40.046] Timer tick, asking Buildbucket for the build status
[15:15:40.162] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:40.162] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:25:0) after 1m0s
[15:16:40.324] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:25:0)
[15:16:40.324] Timer tick, asking Buildbucket for the build status
[15:16:40.693] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:40.693] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:26:0) after 1m0s
[15:17:40.723] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:26:0)
[15:17:40.723] Timer tick, asking Buildbucket for the build status
[15:17:40.924] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:40.924] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:27:0) after 1m0s
[15:18:40.997] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:27:0)
[15:18:40.997] Timer tick, asking Buildbucket for the build status
[15:18:41.113] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:41.113] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:28:0) after 1m0s
[15:19:41.147] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:28:0)
[15:19:41.147] Timer tick, asking Buildbucket for the build status
[15:19:41.212] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:41.212] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:29:0) after 1m0s
[15:20:41.321] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:29:0)
[15:20:41.321] Timer tick, asking Buildbucket for the build status
[15:20:41.397] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:41.397] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:30:0) after 1m0s
[15:21:41.530] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:30:0)
[15:21:41.530] Timer tick, asking Buildbucket for the build status
[15:21:41.902] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:41.902] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:31:0) after 1m0s
[15:22:41.980] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:31:0)
[15:22:41.980] Timer tick, asking Buildbucket for the build status
[15:22:42.092] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:42.092] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:32:0) after 1m0s
[15:23:42.146] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:32:0)
[15:23:42.146] Timer tick, asking Buildbucket for the build status
[15:23:42.521] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:42.521] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:33:0) after 1m0s
[15:24:42.535] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:33:0)
[15:24:42.535] Timer tick, asking Buildbucket for the build status
[15:24:42.600] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:42.600] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:34:0) after 1m0s
[15:25:42.622] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:34:0)
[15:25:42.622] Timer tick, asking Buildbucket for the build status
[15:25:42.683] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:42.683] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:35:0) after 1m0s
[15:26:42.705] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:35:0)
[15:26:42.705] Timer tick, asking Buildbucket for the build status
[15:26:42.769] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:42.769] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:36:0) after 1m0s
[15:27:42.805] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:36:0)
[15:27:42.805] Timer tick, asking Buildbucket for the build status
[15:27:42.898] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:42.898] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:37:0) after 1m0s
[15:28:43.005] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:37:0)
[15:28:43.005] Timer tick, asking Buildbucket for the build status
[15:28:43.122] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:43.122] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:38:0) after 1m0s
[15:29:43.106] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:38:0)
[15:29:43.106] Timer tick, asking Buildbucket for the build status
[15:29:43.468] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:43.468] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:39:0) after 1m0s
[15:30:43.471] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:39:0)
[15:30:43.471] Timer tick, asking Buildbucket for the build status
[15:30:43.669] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:43.669] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:40:0) after 1m0s
[15:31:43.776] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:40:0)
[15:31:43.776] Timer tick, asking Buildbucket for the build status
[15:31:43.843] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:43.843] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:41:0) after 1m0s
[15:32:43.914] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:41:0)
[15:32:43.914] Timer tick, asking Buildbucket for the build status
[15:32:43.980] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:43.980] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:42:0) after 1m0s
[15:33:44.065] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:42:0)
[15:33:44.065] Timer tick, asking Buildbucket for the build status
[15:33:44.246] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:44.246] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:43:0) after 1m0s
[15:34:44.282] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:43:0)
[15:34:44.282] Timer tick, asking Buildbucket for the build status
[15:34:44.504] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:44.505] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:44:0) after 1m0s
[15:35:44.552] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:44:0)
[15:35:44.552] Timer tick, asking Buildbucket for the build status
[15:35:44.686] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:44.686] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:45:0) after 1m0s
[15:36:44.758] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:45:0)
[15:36:44.758] Timer tick, asking Buildbucket for the build status
[15:36:44.825] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:44.825] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:46:0) after 1m0s
[15:37:44.805] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:46:0)
[15:37:44.805] Timer tick, asking Buildbucket for the build status
[15:37:44.871] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:44.871] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:47:0) after 1m0s
[15:38:44.932] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:47:0)
[15:38:44.932] Timer tick, asking Buildbucket for the build status
[15:38:45.305] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:45.305] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:48:0) after 1m0s
[15:39:45.584] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:48:0)
[15:39:45.584] Timer tick, asking Buildbucket for the build status
[15:39:45.891] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:45.891] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:49:0) after 1m0s
[15:40:46.056] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:49:0)
[15:40:46.056] Timer tick, asking Buildbucket for the build status
[15:40:46.154] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:46.154] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:50:0) after 1m0s
[15:41:46.268] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:50:0)
[15:41:46.268] Timer tick, asking Buildbucket for the build status
[15:41:46.348] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:46.348] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:51:0) after 1m0s
[15:42:46.476] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:51:0)
[15:42:46.476] Timer tick, asking Buildbucket for the build status
[15:42:46.615] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:46.615] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:52:0) after 1m0s
[15:43:46.666] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:52:0)
[15:43:46.666] Timer tick, asking Buildbucket for the build status
[15:43:46.765] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:46.765] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:53:0) after 1m0s
[15:44:46.887] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:53:0)
[15:44:46.887] Timer tick, asking Buildbucket for the build status
[15:44:46.943] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:46.943] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:54:0) after 1m0s
[15:45:46.983] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:54:0)
[15:45:46.983] Timer tick, asking Buildbucket for the build status
[15:45:47.306] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:47.306] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:55:0) after 1m0s
[15:46:47.366] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:55:0)
[15:46:47.366] Timer tick, asking Buildbucket for the build status
[15:46:47.527] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:47.527] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:56:0) after 1m0s
[15:47:47.628] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:56:0)
[15:47:47.628] Timer tick, asking Buildbucket for the build status
[15:47:47.802] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:47.802] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:57:0) after 1m0s
[15:48:47.960] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:57:0)
[15:48:47.960] Timer tick, asking Buildbucket for the build status
[15:48:48.092] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:48.092] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:58:0) after 1m0s
[15:49:48.164] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:58:0)
[15:49:48.164] Timer tick, asking Buildbucket for the build status
[15:49:48.238] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:48.238] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:59:0) after 1m0s
[15:50:48.372] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:59:0)
[15:50:48.372] Timer tick, asking Buildbucket for the build status
[15:50:48.486] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:48.486] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:60:0) after 1m0s
[15:51:48.814] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:60:0)
[15:51:48.814] Timer tick, asking Buildbucket for the build status
[15:51:48.878] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:48.878] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:61:0) after 1m0s
[15:52:49.003] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:61:0)
[15:52:49.003] Timer tick, asking Buildbucket for the build status
[15:52:49.307] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:49.307] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:62:0) after 1m0s
[15:53:49.537] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:62:0)
[15:53:49.537] Timer tick, asking Buildbucket for the build status
[15:53:49.721] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:49.721] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:63:0) after 1m0s
[15:54:49.721] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:63:0)
[15:54:49.721] Timer tick, asking Buildbucket for the build status
[15:54:49.775] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:49.775] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:64:0) after 1m0s
[15:55:49.772] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:64:0)
[15:55:49.772] Timer tick, asking Buildbucket for the build status
[15:55:49.892] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:49.892] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:65:0) after 1m0s
[15:56:50.143] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:65:0)
[15:56:50.143] Timer tick, asking Buildbucket for the build status
[15:56:50.390] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:50.390] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:66:0) after 1m0s
[15:57:50.608] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:66:0)
[15:57:50.608] Timer tick, asking Buildbucket for the build status
[15:57:51.387] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:51.387] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:67:0) after 1m0s
[15:58:51.669] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:67:0)
[15:58:51.669] Timer tick, asking Buildbucket for the build status
[15:58:51.793] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:51.793] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:68:0) after 1m0s
[15:59:56.125] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:68:0)
[15:59:56.125] Timer tick, asking Buildbucket for the build status
[15:59:56.197] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:56.197] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:69:0) after 1m0s
[16:00:56.227] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:69:0)
[16:00:56.227] Timer tick, asking Buildbucket for the build status
[16:00:56.295] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:56.295] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:70:0) after 1m0s
[16:01:56.317] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:70:0)
[16:01:56.317] Timer tick, asking Buildbucket for the build status
[16:01:56.391] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:56.391] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:71:0) after 1m0s
[16:02:56.403] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:71:0)
[16:02:56.403] Timer tick, asking Buildbucket for the build status
[16:02:56.470] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:56.470] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:72:0) after 1m0s
[16:03:56.584] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:72:0)
[16:03:56.584] Timer tick, asking Buildbucket for the build status
[16:03:56.795] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:56.795] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:73:0) after 1m0s
[16:04:56.816] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:73:0)
[16:04:56.816] Timer tick, asking Buildbucket for the build status
[16:04:56.886] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:56.886] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:74:0) after 1m0s
[16:05:56.965] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:74:0)
[16:05:56.965] Timer tick, asking Buildbucket for the build status
[16:05:57.093] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:57.093] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:75:0) after 1m0s
[16:06:57.135] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:75:0)
[16:06:57.135] Timer tick, asking Buildbucket for the build status
[16:06:57.210] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:57.210] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:76:0) after 1m0s
[16:07:57.328] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:76:0)
[16:07:57.328] Timer tick, asking Buildbucket for the build status
[16:07:57.405] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:57.405] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:77:0) after 1m0s
[16:08:57.500] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:77:0)
[16:08:57.500] Timer tick, asking Buildbucket for the build status
[16:08:57.640] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:57.640] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:78:0) after 1m0s
[16:09:57.785] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:78:0)
[16:09:57.785] Timer tick, asking Buildbucket for the build status
[16:09:57.862] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:57.862] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:79:0) after 1m0s
[16:10:57.906] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:79:0)
[16:10:57.906] Timer tick, asking Buildbucket for the build status
[16:10:58.368] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:58.368] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:80:0) after 1m0s
[16:11:58.457] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:80:0)
[16:11:58.457] Timer tick, asking Buildbucket for the build status
[16:11:58.621] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:58.621] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:81:0) after 1m0s
[16:12:58.710] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:81:0)
[16:12:58.710] Timer tick, asking Buildbucket for the build status
[16:12:58.781] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:58.781] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:82:0) after 1m0s
[16:13:58.803] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:82:0)
[16:13:58.803] Timer tick, asking Buildbucket for the build status
[16:13:58.958] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:58.958] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:83:0) after 1m0s
[16:14:59.042] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:83:0)
[16:14:59.042] Timer tick, asking Buildbucket for the build status
[16:14:59.128] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:59.128] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:84:0) after 1m0s
[16:15:59.106] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:84:0)
[16:15:59.106] Timer tick, asking Buildbucket for the build status
[16:15:59.172] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:59.172] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:85:0) after 1m0s
[16:16:59.230] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:85:0)
[16:16:59.230] Timer tick, asking Buildbucket for the build status
[16:16:59.683] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:59.683] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:86:0) after 1m0s
[16:17:59.750] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:86:0)
[16:17:59.750] Timer tick, asking Buildbucket for the build status
[16:17:59.908] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:59.908] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:87:0) after 1m0s
[16:19:00.402] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:87:0)
[16:19:00.402] Timer tick, asking Buildbucket for the build status
[16:19:00.530] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:00.530] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:88:0) after 1m0s
[16:20:00.557] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:88:0)
[16:20:00.557] Timer tick, asking Buildbucket for the build status
[16:20:00.632] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:00.632] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:89:0) after 1m0s
[16:21:01.618] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:89:0)
[16:21:01.618] Timer tick, asking Buildbucket for the build status
[16:21:01.688] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:01.688] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:90:0) after 1m0s
[16:22:01.781] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:90:0)
[16:22:01.781] Timer tick, asking Buildbucket for the build status
[16:22:02.075] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:02.075] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:91:0) after 1m0s
[16:23:02.101] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:91:0)
[16:23:02.101] Timer tick, asking Buildbucket for the build status
[16:23:02.374] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:02.374] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:92:0) after 1m0s
[16:24:02.408] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:92:0)
[16:24:02.408] Timer tick, asking Buildbucket for the build status
[16:24:02.554] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:02.554] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:93:0) after 1m0s
[16:25:03.184] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:93:0)
[16:25:03.184] Timer tick, asking Buildbucket for the build status
[16:25:03.386] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:03.386] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:94:0) after 1m0s
[16:26:03.529] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:94:0)
[16:26:03.529] Timer tick, asking Buildbucket for the build status
[16:26:03.606] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:03.606] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:95:0) after 1m0s
[16:27:03.836] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:95:0)
[16:27:03.836] Timer tick, asking Buildbucket for the build status
[16:27:03.953] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:03.953] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:96:0) after 1m0s
[16:28:04.032] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:96:0)
[16:28:04.032] Timer tick, asking Buildbucket for the build status
[16:28:04.305] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:04.305] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:97:0) after 1m0s
[16:29:04.512] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:97:0)
[16:29:04.512] Timer tick, asking Buildbucket for the build status
[16:29:04.613] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:04.613] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:98:0) after 1m0s
[16:30:04.703] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:98:0)
[16:30:04.703] Timer tick, asking Buildbucket for the build status
[16:30:04.790] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:04.790] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:99:0) after 1m0s
[16:31:04.810] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:99:0)
[16:31:04.810] Timer tick, asking Buildbucket for the build status
[16:31:04.871] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:04.871] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:100:0) after 1m0s
[16:32:04.954] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:100:0)
[16:32:04.954] Timer tick, asking Buildbucket for the build status
[16:32:05.034] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:05.035] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:101:0) after 1m0s
[16:33:05.150] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:101:0)
[16:33:05.150] Timer tick, asking Buildbucket for the build status
[16:33:05.404] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:05.404] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:102:0) after 1m0s
[16:34:05.480] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:102:0)
[16:34:05.480] Timer tick, asking Buildbucket for the build status
[16:34:05.594] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:05.594] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:103:0) after 1m0s
[16:35:05.608] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:103:0)
[16:35:05.608] Timer tick, asking Buildbucket for the build status
[16:35:05.675] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:05.675] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:104:0) after 1m0s
[16:36:05.700] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:104:0)
[16:36:05.700] Timer tick, asking Buildbucket for the build status
[16:36:05.767] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:05.767] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:105:0) after 1m0s
[16:37:05.788] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:105:0)
[16:37:05.788] Timer tick, asking Buildbucket for the build status
[16:37:05.904] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:05.904] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:106:0) after 1m0s
[16:38:05.931] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:106:0)
[16:38:05.931] Timer tick, asking Buildbucket for the build status
[16:38:06.017] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:06.017] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:107:0) after 1m0s
[16:39:06.043] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:107:0)
[16:39:06.043] Timer tick, asking Buildbucket for the build status
[16:39:06.411] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:06.411] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:108:0) after 1m0s
[16:40:06.465] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:108:0)
[16:40:06.465] Timer tick, asking Buildbucket for the build status
[16:40:06.526] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:06.526] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:109:0) after 1m0s
[16:41:06.558] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:109:0)
[16:41:06.559] Timer tick, asking Buildbucket for the build status
[16:41:06.652] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:06.652] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:110:0) after 1m0s
[16:42:06.673] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:110:0)
[16:42:06.673] Timer tick, asking Buildbucket for the build status
[16:42:07.121] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:07.121] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:111:0) after 1m0s
[16:43:07.251] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:111:0)
[16:43:07.251] Timer tick, asking Buildbucket for the build status
[16:43:07.385] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:07.385] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:112:0) after 1m0s
[16:44:07.484] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:112:0)
[16:44:07.484] Timer tick, asking Buildbucket for the build status
[16:44:07.576] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:07.576] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:113:0) after 1m0s
[16:45:07.598] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:113:0)
[16:45:07.598] Timer tick, asking Buildbucket for the build status
[16:45:07.791] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:07.791] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:114:0) after 1m0s
[16:46:07.865] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:114:0)
[16:46:07.865] Timer tick, asking Buildbucket for the build status
[16:46:08.295] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:08.295] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:115:0) after 1m0s
[16:47:08.356] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:115:0)
[16:47:08.356] Timer tick, asking Buildbucket for the build status
[16:47:09.744] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:09.744] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:116:0) after 1m0s
[16:48:09.780] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:116:0)
[16:48:09.780] Timer tick, asking Buildbucket for the build status
[16:48:09.841] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:09.841] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:117:0) after 1m0s
[16:49:09.859] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:117:0)
[16:49:09.859] Timer tick, asking Buildbucket for the build status
[16:49:09.975] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:09.975] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:118:0) after 1m0s
[16:50:09.965] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:118:0)
[16:50:09.965] Timer tick, asking Buildbucket for the build status
[16:50:10.046] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:10.046] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:119:0) after 1m0s
[16:51:10.123] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:119:0)
[16:51:10.123] Timer tick, asking Buildbucket for the build status
[16:51:10.192] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:10.192] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:120:0) after 1m0s
[16:52:10.290] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:120:0)
[16:52:10.290] Timer tick, asking Buildbucket for the build status
[16:52:10.407] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:10.407] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:121:0) after 1m0s
[16:53:10.455] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:121:0)
[16:53:10.455] Timer tick, asking Buildbucket for the build status
[16:53:10.538] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:10.539] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:122:0) after 1m0s
[16:54:10.572] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:122:0)
[16:54:10.572] Timer tick, asking Buildbucket for the build status
[16:54:10.705] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:10.705] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:123:0) after 1m0s
[16:55:10.719] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:123:0)
[16:55:10.719] Timer tick, asking Buildbucket for the build status
[16:55:10.901] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:10.901] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:124:0) after 1m0s
[16:56:10.944] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:124:0)
[16:56:10.944] Timer tick, asking Buildbucket for the build status
[16:56:11.018] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:11.018] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:125:0) after 1m0s
[16:57:11.064] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:125:0)
[16:57:11.064] Timer tick, asking Buildbucket for the build status
[16:57:11.131] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:11.131] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:126:0) after 1m0s
[16:58:11.162] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:126:0)
[16:58:11.162] Timer tick, asking Buildbucket for the build status
[16:58:11.304] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:11.304] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:127:0) after 1m0s
[16:59:11.398] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:127:0)
[16:59:11.398] Timer tick, asking Buildbucket for the build status
[16:59:11.763] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:11.763] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:128:0) after 1m0s
[17:00:11.794] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:128:0)
[17:00:11.794] Timer tick, asking Buildbucket for the build status
[17:00:11.916] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:11.916] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:129:0) after 1m0s
[17:01:11.952] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:129:0)
[17:01:11.953] Timer tick, asking Buildbucket for the build status
[17:01:12.026] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:12.026] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:130:0) after 1m0s
[17:02:12.077] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:130:0)
[17:02:12.077] Timer tick, asking Buildbucket for the build status
[17:02:12.148] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:12.148] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:131:0) after 1m0s
[17:03:12.192] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:131:0)
[17:03:12.192] Timer tick, asking Buildbucket for the build status
[17:03:12.259] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:12.259] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:132:0) after 1m0s
[17:04:12.307] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:132:0)
[17:04:12.307] Timer tick, asking Buildbucket for the build status
[17:04:12.685] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:12.686] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:133:0) after 1m0s
[17:05:16.479] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:133:0)
[17:05:16.479] Timer tick, asking Buildbucket for the build status
[17:05:16.550] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:16.550] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:134:0) after 1m0s
[17:06:16.666] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:134:0)
[17:06:16.666] Timer tick, asking Buildbucket for the build status
[17:06:17.251] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:17.251] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:135:0) after 1m0s
[17:07:17.255] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:135:0)
[17:07:17.255] Timer tick, asking Buildbucket for the build status
[17:07:17.322] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:17.322] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:136:0) after 1m0s
[17:08:17.471] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:136:0)
[17:08:17.471] Timer tick, asking Buildbucket for the build status
[17:08:17.563] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:17.563] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:137:0) after 1m0s
[17:09:17.623] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:137:0)
[17:09:17.623] Timer tick, asking Buildbucket for the build status
[17:09:17.977] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:17.977] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:138:0) after 1m0s
[17:10:18.044] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:138:0)
[17:10:18.044] Timer tick, asking Buildbucket for the build status
[17:10:18.110] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:18.110] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:139:0) after 1m0s
[17:11:18.119] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:139:0)
[17:11:18.119] Timer tick, asking Buildbucket for the build status
[17:11:18.591] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:18.591] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:140:0) after 1m0s
[17:12:18.616] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:140:0)
[17:12:18.616] Timer tick, asking Buildbucket for the build status
[17:12:18.800] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:18.800] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:141:0) after 1m0s
[17:13:18.831] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:141:0)
[17:13:18.831] Timer tick, asking Buildbucket for the build status
[17:13:18.921] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:18.921] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:142:0) after 1m0s
[17:14:18.972] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:142:0)
[17:14:18.972] Timer tick, asking Buildbucket for the build status
[17:14:19.152] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:19.152] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:143:0) after 1m0s
[17:15:19.290] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:143:0)
[17:15:19.290] Timer tick, asking Buildbucket for the build status
[17:15:19.354] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:19.354] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:144:0) after 1m0s
[17:16:19.481] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:144:0)
[17:16:19.481] Timer tick, asking Buildbucket for the build status
[17:16:21.351] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:21.351] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:145:0) after 1m0s
[17:17:21.825] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:145:0)
[17:17:21.825] Timer tick, asking Buildbucket for the build status
[17:17:21.992] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:21.992] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:146:0) after 1m0s
[17:18:22.102] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:146:0)
[17:18:22.102] Timer tick, asking Buildbucket for the build status
[17:18:22.172] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:22.172] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:147:0) after 1m0s
[17:19:22.272] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:147:0)
[17:19:22.272] Timer tick, asking Buildbucket for the build status
[17:19:22.394] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:22.394] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:148:0) after 1m0s
[17:20:22.566] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:148:0)
[17:20:22.566] Timer tick, asking Buildbucket for the build status
[17:20:22.633] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:22.633] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:149:0) after 1m0s
[17:21:22.871] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:149:0)
[17:21:22.871] Timer tick, asking Buildbucket for the build status
[17:21:22.957] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:22.957] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:150:0) after 1m0s
[17:22:23.061] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:150:0)
[17:22:23.061] Timer tick, asking Buildbucket for the build status
[17:22:23.389] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:23.389] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:151:0) after 1m0s
[17:23:23.636] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:151:0)
[17:23:23.636] Timer tick, asking Buildbucket for the build status
[17:23:23.701] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:23.701] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:152:0) after 1m0s
[17:24:23.739] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:152:0)
[17:24:23.739] Timer tick, asking Buildbucket for the build status
[17:24:23.938] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:23.938] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:153:0) after 1m0s
[17:25:23.917] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:153:0)
[17:25:23.917] Timer tick, asking Buildbucket for the build status
[17:25:23.971] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:23.971] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:154:0) after 1m0s
[17:26:24.081] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:154:0)
[17:26:24.081] Timer tick, asking Buildbucket for the build status
[17:26:24.163] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:24.163] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:155:0) after 1m0s
[17:27:24.254] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:155:0)
[17:27:24.254] Timer tick, asking Buildbucket for the build status
[17:27:24.399] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:24.399] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:156:0) after 1m0s
[17:28:24.419] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:156:0)
[17:28:24.419] Timer tick, asking Buildbucket for the build status
[17:28:24.498] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:24.498] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:157:0) after 1m0s
[17:29:24.505] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:157:0)
[17:29:24.505] Timer tick, asking Buildbucket for the build status
[17:29:24.606] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:24.606] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:158:0) after 1m0s
[17:30:24.681] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:158:0)
[17:30:24.681] Timer tick, asking Buildbucket for the build status
[17:30:24.833] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:24.833] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:159:0) after 1m0s
[17:31:24.874] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:159:0)
[17:31:24.874] Timer tick, asking Buildbucket for the build status
[17:31:25.007] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:25.007] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:160:0) after 1m0s
[17:32:25.085] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:160:0)
[17:32:25.085] Timer tick, asking Buildbucket for the build status
[17:32:25.151] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:25.151] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:161:0) after 1m0s
[17:33:25.247] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:161:0)
[17:33:25.247] Timer tick, asking Buildbucket for the build status
[17:33:25.340] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:25.340] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:162:0) after 1m0s
[17:34:25.480] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:162:0)
[17:34:25.480] Timer tick, asking Buildbucket for the build status
[17:34:25.588] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:25.588] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:163:0) after 1m0s
[17:35:25.719] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:163:0)
[17:35:25.719] Timer tick, asking Buildbucket for the build status
[17:35:25.786] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:25.786] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:164:0) after 1m0s
[17:36:25.858] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:164:0)
[17:36:25.858] Timer tick, asking Buildbucket for the build status
[17:36:26.012] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:26.012] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:165:0) after 1m0s
[17:37:26.112] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:165:0)
[17:37:26.112] Timer tick, asking Buildbucket for the build status
[17:37:26.190] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:26.190] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:166:0) after 1m0s
[17:38:26.255] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:166:0)
[17:38:26.255] Timer tick, asking Buildbucket for the build status
[17:38:26.483] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:26.483] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:167:0) after 1m0s
[17:39:26.604] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:167:0)
[17:39:26.604] Timer tick, asking Buildbucket for the build status
[17:39:26.766] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:26.766] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:168:0) after 1m0s
[17:40:26.837] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:168:0)
[17:40:26.837] Timer tick, asking Buildbucket for the build status
[17:40:26.911] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:26.911] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:169:0) after 1m0s
[17:41:26.979] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:169:0)
[17:41:26.980] Timer tick, asking Buildbucket for the build status
[17:41:27.075] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:27.075] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:170:0) after 1m0s
[17:42:27.077] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:170:0)
[17:42:27.077] Timer tick, asking Buildbucket for the build status
[17:42:27.473] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:27.473] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:171:0) after 1m0s
[17:43:27.537] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:171:0)
[17:43:27.537] Timer tick, asking Buildbucket for the build status
[17:43:27.608] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:27.608] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:172:0) after 1m0s
[17:44:27.615] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:172:0)
[17:44:27.615] Timer tick, asking Buildbucket for the build status
[17:44:27.727] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:27.727] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:173:0) after 1m0s
[17:45:28.482] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:173:0)
[17:45:28.482] Timer tick, asking Buildbucket for the build status
[17:45:28.568] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:28.568] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:174:0) after 1m0s
[17:46:28.834] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:174:0)
[17:46:28.834] Timer tick, asking Buildbucket for the build status
[17:46:28.894] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:28.894] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:175:0) after 1m0s
[17:47:28.949] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:175:0)
[17:47:28.949] Timer tick, asking Buildbucket for the build status
[17:47:29.016] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:29.016] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:176:0) after 1m0s
[17:48:29.466] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:176:0)
[17:48:29.466] Timer tick, asking Buildbucket for the build status
[17:48:29.606] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:29.606] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:177:0) after 1m0s
[17:49:29.598] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:177:0)
[17:49:29.598] Timer tick, asking Buildbucket for the build status
[17:49:29.745] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:29.745] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:178:0) after 1m0s
[17:50:29.819] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:178:0)
[17:50:29.819] Timer tick, asking Buildbucket for the build status
[17:50:29.876] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:29.876] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:179:0) after 1m0s
[17:51:30.036] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:179:0)
[17:51:30.036] Timer tick, asking Buildbucket for the build status
[17:51:30.624] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:30.624] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:180:0) after 1m0s
[17:52:30.691] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:180:0)
[17:52:30.691] Timer tick, asking Buildbucket for the build status
[17:52:30.749] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:30.749] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:181:0) after 1m0s
[17:53:30.903] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:181:0)
[17:53:30.903] Timer tick, asking Buildbucket for the build status
[17:53:31.019] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:31.019] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:182:0) after 1m0s
[17:54:31.145] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:182:0)
[17:54:31.145] Timer tick, asking Buildbucket for the build status
[17:54:31.319] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:31.319] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:183:0) after 1m0s
[17:55:31.416] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:183:0)
[17:55:31.416] Timer tick, asking Buildbucket for the build status
[17:55:31.604] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:31.604] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:184:0) after 1m0s
[17:56:31.639] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:184:0)
[17:56:31.639] Timer tick, asking Buildbucket for the build status
[17:56:31.702] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:31.702] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:185:0) after 1m0s
[17:57:31.749] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:185:0)
[17:57:31.749] Timer tick, asking Buildbucket for the build status
[17:57:31.858] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:31.858] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:186:0) after 1m0s
[17:58:31.990] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:186:0)
[17:58:31.990] Timer tick, asking Buildbucket for the build status
[17:58:32.062] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:32.062] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:187:0) after 1m0s
[17:59:32.171] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:187:0)
[17:59:32.172] Timer tick, asking Buildbucket for the build status
[17:59:32.588] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:32.588] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:188:0) after 1m0s
[18:00:32.635] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:188:0)
[18:00:32.635] Timer tick, asking Buildbucket for the build status
[18:00:32.719] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:32.719] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:189:0) after 1m0s
[18:01:32.744] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:189:0)
[18:01:32.744] Timer tick, asking Buildbucket for the build status
[18:01:33.078] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:33.079] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:190:0) after 1m0s
[18:02:33.108] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:190:0)
[18:02:33.108] Timer tick, asking Buildbucket for the build status
[18:02:33.237] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:33.237] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:191:0) after 1m0s
[18:03:33.273] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:191:0)
[18:03:33.273] Timer tick, asking Buildbucket for the build status
[18:03:33.574] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:33.574] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:192:0) after 1m0s
[18:04:33.612] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:192:0)
[18:04:33.612] Timer tick, asking Buildbucket for the build status
[18:04:33.715] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:33.715] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:193:0) after 1m0s
[18:05:33.742] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:193:0)
[18:05:33.742] Timer tick, asking Buildbucket for the build status
[18:05:33.888] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:33.888] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:194:0) after 1m0s
[18:06:34.526] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:194:0)
[18:06:34.526] Timer tick, asking Buildbucket for the build status
[18:06:34.778] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:34.779] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:195:0) after 1m0s
[18:07:34.844] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:195:0)
[18:07:34.844] Timer tick, asking Buildbucket for the build status
[18:07:34.893] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:34.894] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:196:0) after 1m0s
[18:08:34.950] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:196:0)
[18:08:34.950] Timer tick, asking Buildbucket for the build status
[18:08:35.012] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:35.012] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:197:0) after 1m0s
[18:09:35.122] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:197:0)
[18:09:35.122] Timer tick, asking Buildbucket for the build status
[18:09:35.258] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:35.258] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:198:0) after 1m0s
[18:10:35.284] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:198:0)
[18:10:35.284] Timer tick, asking Buildbucket for the build status
[18:10:35.371] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:35.371] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:199:0) after 1m0s
[18:11:35.501] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:199:0)
[18:11:35.501] Timer tick, asking Buildbucket for the build status
[18:11:35.560] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:35.561] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:200:0) after 1m0s
[18:12:35.611] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:200:0)
[18:12:35.611] Timer tick, asking Buildbucket for the build status
[18:12:35.984] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:35.984] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:201:0) after 1m0s
[18:13:36.165] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:201:0)
[18:13:36.165] Timer tick, asking Buildbucket for the build status
[18:13:36.232] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:36.233] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:202:0) after 1m0s
[18:14:36.289] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:202:0)
[18:14:36.289] Timer tick, asking Buildbucket for the build status
[18:14:36.675] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:36.675] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:203:0) after 1m0s
[18:15:36.857] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:203:0)
[18:15:36.857] Timer tick, asking Buildbucket for the build status
[18:15:37.128] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:37.128] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:204:0) after 1m0s
[18:16:37.206] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:204:0)
[18:16:37.206] Timer tick, asking Buildbucket for the build status
[18:16:37.269] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:37.269] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:205:0) after 1m0s
[18:17:37.403] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:205:0)
[18:17:37.403] Timer tick, asking Buildbucket for the build status
[18:17:37.477] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:37.477] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:206:0) after 1m0s
[18:18:37.566] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:206:0)
[18:18:37.566] Timer tick, asking Buildbucket for the build status
[18:18:37.640] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:37.640] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:207:0) after 1m0s
[18:19:37.803] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:207:0)
[18:19:37.803] Timer tick, asking Buildbucket for the build status
[18:19:38.099] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:38.099] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:208:0) after 1m0s
[18:20:38.192] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:208:0)
[18:20:38.192] Timer tick, asking Buildbucket for the build status
[18:20:38.403] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:38.403] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:209:0) after 1m0s
[18:21:38.512] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:209:0)
[18:21:38.512] Timer tick, asking Buildbucket for the build status
[18:21:39.096] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:39.096] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:210:0) after 1m0s
[18:22:39.132] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:210:0)
[18:22:39.132] Timer tick, asking Buildbucket for the build status
[18:22:39.357] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:39.357] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:211:0) after 1m0s
[18:23:39.389] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:211:0)
[18:23:39.389] Timer tick, asking Buildbucket for the build status
[18:23:39.446] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:39.446] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:212:0) after 1m0s
[18:24:39.584] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:212:0)
[18:24:39.584] Timer tick, asking Buildbucket for the build status
[18:24:41.489] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:41.489] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:213:0) after 1m0s
[18:25:41.599] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:213:0)
[18:25:41.599] Timer tick, asking Buildbucket for the build status
[18:25:41.717] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:41.717] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:214:0) after 1m0s
[18:26:41.747] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:214:0)
[18:26:41.747] Timer tick, asking Buildbucket for the build status
[18:26:42.046] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:42.046] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:215:0) after 1m0s
[18:27:42.086] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:215:0)
[18:27:42.086] Timer tick, asking Buildbucket for the build status
[18:27:42.214] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:42.214] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:216:0) after 1m0s
[18:28:42.334] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:216:0)
[18:28:42.334] Timer tick, asking Buildbucket for the build status
[18:28:42.475] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:42.475] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:217:0) after 1m0s
[18:29:42.484] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:217:0)
[18:29:42.484] Timer tick, asking Buildbucket for the build status
[18:29:43.003] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:43.003] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:218:0) after 1m0s
[18:30:43.090] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:218:0)
[18:30:43.090] Timer tick, asking Buildbucket for the build status
[18:30:43.412] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:43.412] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:219:0) after 1m0s
[18:31:43.439] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:219:0)
[18:31:43.439] Timer tick, asking Buildbucket for the build status
[18:31:43.515] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:43.515] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:220:0) after 1m0s
[18:32:43.554] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:220:0)
[18:32:43.554] Timer tick, asking Buildbucket for the build status
[18:32:43.704] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:43.704] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:221:0) after 1m0s
[18:33:43.784] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:221:0)
[18:33:43.784] Timer tick, asking Buildbucket for the build status
[18:33:43.882] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:43.882] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:222:0) after 1m0s
[18:34:43.912] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:222:0)
[18:34:43.912] Timer tick, asking Buildbucket for the build status
[18:34:44.049] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:44.049] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:223:0) after 1m0s
[18:35:44.127] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:223:0)
[18:35:44.127] Timer tick, asking Buildbucket for the build status
[18:35:44.203] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:44.203] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:224:0) after 1m0s
[18:36:44.277] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:224:0)
[18:36:44.277] Timer tick, asking Buildbucket for the build status
[18:36:44.348] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:44.348] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:225:0) after 1m0s
[18:37:44.463] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:225:0)
[18:37:44.463] Timer tick, asking Buildbucket for the build status
[18:37:44.521] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:44.521] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:226:0) after 1m0s
[18:38:44.651] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:226:0)
[18:38:44.651] Timer tick, asking Buildbucket for the build status
[18:38:44.730] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:44.730] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:227:0) after 1m0s
[18:39:44.815] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:227:0)
[18:39:44.815] Timer tick, asking Buildbucket for the build status
[18:39:44.914] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:44.914] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:228:0) after 1m0s
[18:40:44.944] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:228:0)
[18:40:44.944] Timer tick, asking Buildbucket for the build status
[18:40:45.056] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:45.056] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:229:0) after 1m0s
[18:41:45.085] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:229:0)
[18:41:45.085] Timer tick, asking Buildbucket for the build status
[18:41:45.276] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:45.276] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:230:0) after 1m0s
[18:42:45.346] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:230:0)
[18:42:45.346] Timer tick, asking Buildbucket for the build status
[18:42:45.769] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:45.769] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:231:0) after 1m0s
[18:43:45.796] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:231:0)
[18:43:45.796] Timer tick, asking Buildbucket for the build status
[18:43:45.932] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:45.932] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:232:0) after 1m0s
[18:44:45.961] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:232:0)
[18:44:45.961] Timer tick, asking Buildbucket for the build status
[18:44:46.125] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:46.125] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:233:0) after 1m0s
[18:45:46.152] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:233:0)
[18:45:46.152] Timer tick, asking Buildbucket for the build status
[18:45:46.210] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:46.210] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:234:0) after 1m0s
[18:46:46.246] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:234:0)
[18:46:46.246] Timer tick, asking Buildbucket for the build status
[18:46:46.325] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:46.325] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:235:0) after 1m0s
[18:47:46.354] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:235:0)
[18:47:46.354] Timer tick, asking Buildbucket for the build status
[18:47:46.585] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:46.585] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:236:0) after 1m0s
[18:48:46.614] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:236:0)
[18:48:46.614] Timer tick, asking Buildbucket for the build status
[18:48:46.767] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:46.767] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:237:0) after 1m0s
[18:49:46.792] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:237:0)
[18:49:46.792] Timer tick, asking Buildbucket for the build status
[18:49:47.383] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:47.383] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:238:0) after 1m0s
[18:50:47.410] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:238:0)
[18:50:47.410] Timer tick, asking Buildbucket for the build status
[18:50:47.485] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:47.485] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:239:0) after 1m0s
[18:51:47.512] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:239:0)
[18:51:47.512] Timer tick, asking Buildbucket for the build status
[18:51:47.582] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:47.582] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:240:0) after 1m0s
[18:52:47.611] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:240:0)
[18:52:47.611] Timer tick, asking Buildbucket for the build status
[18:52:47.729] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:47.729] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:241:0) after 1m0s
[18:53:47.757] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:241:0)
[18:53:47.757] Timer tick, asking Buildbucket for the build status
[18:53:47.820] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:47.820] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:242:0) after 1m0s
[18:54:47.879] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:242:0)
[18:54:47.879] Timer tick, asking Buildbucket for the build status
[18:54:47.991] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:47.991] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:243:0) after 1m0s
[18:55:48.457] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:243:0)
[18:55:48.457] Timer tick, asking Buildbucket for the build status
[18:55:48.690] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:48.690] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:244:0) after 1m0s
[18:56:48.883] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:244:0)
[18:56:48.883] Timer tick, asking Buildbucket for the build status
[18:56:48.957] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:48.957] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:245:0) after 1m0s
[18:57:49.308] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:245:0)
[18:57:49.308] Timer tick, asking Buildbucket for the build status
[18:57:49.430] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:49.430] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:246:0) after 1m0s
[18:58:49.557] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:246:0)
[18:58:49.557] Timer tick, asking Buildbucket for the build status
[18:58:49.672] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:49.672] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:247:0) after 1m0s
[18:59:49.915] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:247:0)
[18:59:49.915] Timer tick, asking Buildbucket for the build status
[18:59:50.042] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:50.042] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:248:0) after 1m0s
[19:00:50.140] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:248:0)
[19:00:50.140] Timer tick, asking Buildbucket for the build status
[19:00:50.228] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:50.228] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:249:0) after 1m0s
[19:01:50.318] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:249:0)
[19:01:50.318] Timer tick, asking Buildbucket for the build status
[19:01:50.727] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:50.727] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:250:0) after 1m0s
[19:02:51.016] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:250:0)
[19:02:51.016] Timer tick, asking Buildbucket for the build status
[19:02:51.085] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:51.085] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:251:0) after 1m0s
[19:03:51.203] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:251:0)
[19:03:51.203] Timer tick, asking Buildbucket for the build status
[19:03:51.316] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:51.317] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:252:0) after 1m0s
[19:04:51.453] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:252:0)
[19:04:51.453] Timer tick, asking Buildbucket for the build status
[19:04:51.521] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:51.521] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:253:0) after 1m0s
[19:05:51.778] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:253:0)
[19:05:51.778] Timer tick, asking Buildbucket for the build status
[19:05:51.839] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:51.839] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:254:0) after 1m0s
[19:06:52.084] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:254:0)
[19:06:52.084] Timer tick, asking Buildbucket for the build status
[19:06:52.146] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:52.146] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:255:0) after 1m0s
[19:07:52.227] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:255:0)
[19:07:52.227] Timer tick, asking Buildbucket for the build status
[19:07:52.335] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:52.336] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:256:0) after 1m0s
[19:08:52.419] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:256:0)
[19:08:52.419] Timer tick, asking Buildbucket for the build status
[19:08:52.545] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:52.545] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:257:0) after 1m0s
[19:09:52.648] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:257:0)
[19:09:52.648] Timer tick, asking Buildbucket for the build status
[19:09:52.733] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:52.733] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:258:0) after 1m0s
[19:10:52.796] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:258:0)
[19:10:52.796] Timer tick, asking Buildbucket for the build status
[19:10:52.856] Build 8866816754204538784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:52.856] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032246816203834864:259:0) after 1m0s
[19:11:31.544] Received PubSub notification, asking Buildbucket for the build status
[19:11:31.698] Build 8866816754204538784: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:11:31.698] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1602357091004310",
"created_by": "project:chromium",
"created_ts": "1602341615442087",
"id": "8866816754204538784",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c98f04d845668e4e1af41a27115ac289c06d73cd\"}}",
"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\": \"c98f04d845668e4e1af41a27115ac289c06d73cd\", \"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-1-fh8d\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 784, \"got_angle_revision\": \"b2ff69f856d98312bbfe14f80d084b7d8795281f\", \"got_dawn_revision\": \"1c25198384e7ecfebbd3ac84203d3b1d46a0e228\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"c98f04d845668e4e1af41a27115ac289c06d73cd\", \"got_revision_cp\": \"refs/heads/master@{#815946}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"139f5c351e1ff62e465526d4d2f40d3b08a27169\", \"got_v8_revision\": \"07b0b1dcde4a99294b8028d83f4ea244885cc091\", \"got_v8_revision_cp\": \"refs/heads/8.8.62@{#1}\", \"got_webrtc_revision\": \"3326535126e435f1ba647885ce43a8f0f3d317eb\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32375}\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c98f04d845668e4e1af41a27115ac289c06d73cd\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_f2b006d1778b1676853cdf5ef47b6b4ca966a5d1d64c9da204abd3981f53b685_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-1-fh8d\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5570-fa4adf0\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1602341888272762",
"status": "COMPLETED",
"status_changed_ts": "1602357091239985",
"tags": [
"build_address:luci.chromium.ci/win-official/784",
"builder:win-official",
"buildset:commit/git/c98f04d845668e4e1af41a27115ac289c06d73cd",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c98f04d845668e4e1af41a27115ac289c06d73cd",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9032246816203834864",
"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/8866816754204538784/+/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:4f2bd247457d0010",
"user_agent:luci-scheduler"
],
"updated_ts": "1602357091244426",
"url": "https://ci.chromium.org/b/8866816754204538784",
"utcnow_ts": "1602357091687137"
}
}
[19:11:31.698] Invocation finished in 4h17m57.546725473s with status SUCCEEDED