[18:26:02.300] New invocation is queued and will start shortly
[18:26:04.022] Starting the invocation (attempt 1)
[18:26:04.055] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:26:04.055] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:26:04.055] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018734500822074032",
"parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"7f2e1d80cf5d3886dfe31ed9936f4ab57b14745d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-official",
"scheduler_invocation_id:9018734500822074032",
"scheduler_job_id:chromium/win-official",
"user_agent:luci-scheduler",
"buildset:commit/git/7f2e1d80cf5d3886dfe31ed9936f4ab57b14745d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7f2e1d80cf5d3886dfe31ed9936f4ab57b14745d",
"gitiles_ref:refs/heads/master"
]
}
[18:26:04.713] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615227964135484",
"id": "8853304438237341200",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7f2e1d80cf5d3886dfe31ed9936f4ab57b14745d\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615227964585636",
"tags": [
"build_address:luci.chromium.ci/win-official/1715",
"builder:win-official",
"buildset:commit/git/7f2e1d80cf5d3886dfe31ed9936f4ab57b14745d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7f2e1d80cf5d3886dfe31ed9936f4ab57b14745d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018734500822074032",
"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/8853304438237341200/+/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": "1615227964585746",
"url": "https://ci.chromium.org/b/8853304438237341200",
"utcnow_ts": "1615227964695798"
}
}
[18:26:04.713] Task URL: https://ci.chromium.org/b/8853304438237341200
[18:26:04.713] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:2:0) after 1m0s
[18:27:04.814] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:2:0)
[18:27:04.814] Timer tick, asking Buildbucket for the build status
[18:27:04.891] Build 8853304438237341200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:27:04.891] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:3:0) after 1m0s
[18:28:04.909] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:3:0)
[18:28:04.909] Timer tick, asking Buildbucket for the build status
[18:28:05.146] Build 8853304438237341200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:28:05.146] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:4:0) after 1m0s
[18:28:14.271] Received PubSub notification, asking Buildbucket for the build status
[18:28:14.338] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:05.176] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:4:0)
[18:29:05.176] Timer tick, asking Buildbucket for the build status
[18:29:05.430] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:05.430] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:6:0) after 1m0s
[18:30:05.463] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:6:0)
[18:30:05.463] Timer tick, asking Buildbucket for the build status
[18:30:05.543] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:05.543] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:7:0) after 1m0s
[18:31:05.524] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:7:0)
[18:31:05.524] Timer tick, asking Buildbucket for the build status
[18:31:05.646] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:05.646] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:8:0) after 1m0s
[18:32:05.883] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:8:0)
[18:32:05.883] Timer tick, asking Buildbucket for the build status
[18:32:06.005] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:06.005] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:9:0) after 1m0s
[18:33:06.133] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:9:0)
[18:33:06.133] Timer tick, asking Buildbucket for the build status
[18:33:06.235] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:06.235] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:10:0) after 1m0s
[18:34:06.276] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:10:0)
[18:34:06.276] Timer tick, asking Buildbucket for the build status
[18:34:06.343] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:06.343] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:11:0) after 1m0s
[18:35:06.563] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:11:0)
[18:35:06.563] Timer tick, asking Buildbucket for the build status
[18:35:06.643] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:06.643] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:12:0) after 1m0s
[18:36:06.710] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:12:0)
[18:36:06.710] Timer tick, asking Buildbucket for the build status
[18:36:06.786] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:06.786] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:13:0) after 1m0s
[18:37:06.818] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:13:0)
[18:37:06.818] Timer tick, asking Buildbucket for the build status
[18:37:06.945] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:06.945] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:14:0) after 1m0s
[18:38:06.982] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:14:0)
[18:38:06.982] Timer tick, asking Buildbucket for the build status
[18:38:07.110] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:07.110] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:15:0) after 1m0s
[18:39:07.128] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:15:0)
[18:39:07.128] Timer tick, asking Buildbucket for the build status
[18:39:07.200] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:07.200] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:16:0) after 1m0s
[18:40:07.240] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:16:0)
[18:40:07.240] Timer tick, asking Buildbucket for the build status
[18:40:07.742] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:07.742] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:17:0) after 1m0s
[18:41:07.748] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:17:0)
[18:41:07.748] Timer tick, asking Buildbucket for the build status
[18:41:08.113] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:08.113] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:18:0) after 1m0s
[18:42:08.132] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:18:0)
[18:42:08.133] Timer tick, asking Buildbucket for the build status
[18:42:08.251] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:08.251] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:19:0) after 1m0s
[18:43:08.293] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:19:0)
[18:43:08.293] Timer tick, asking Buildbucket for the build status
[18:43:08.470] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:08.470] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:20:0) after 1m0s
[18:44:08.488] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:20:0)
[18:44:08.488] Timer tick, asking Buildbucket for the build status
[18:44:08.555] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:08.555] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:21:0) after 1m0s
[18:45:08.581] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:21:0)
[18:45:08.581] Timer tick, asking Buildbucket for the build status
[18:45:10.231] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:10.231] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:22:0) after 1m0s
[18:46:10.276] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:22:0)
[18:46:10.276] Timer tick, asking Buildbucket for the build status
[18:46:10.729] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:10.729] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:23:0) after 1m0s
[18:47:10.749] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:23:0)
[18:47:10.749] Timer tick, asking Buildbucket for the build status
[18:47:10.858] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:10.858] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:24:0) after 1m0s
[18:48:10.831] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:24:0)
[18:48:10.831] Timer tick, asking Buildbucket for the build status
[18:48:12.021] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:12.021] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:25:0) after 1m0s
[18:49:12.034] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:25:0)
[18:49:12.034] Timer tick, asking Buildbucket for the build status
[18:49:12.153] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:12.153] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:26:0) after 1m0s
[18:50:12.176] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:26:0)
[18:50:12.176] Timer tick, asking Buildbucket for the build status
[18:50:12.267] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:12.267] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:27:0) after 1m0s
[18:51:12.338] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:27:0)
[18:51:12.338] Timer tick, asking Buildbucket for the build status
[18:51:12.977] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:12.977] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:28:0) after 1m0s
[18:52:12.994] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:28:0)
[18:52:12.994] Timer tick, asking Buildbucket for the build status
[18:52:13.143] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:13.143] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:29:0) after 1m0s
[18:53:13.153] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:29:0)
[18:53:13.153] Timer tick, asking Buildbucket for the build status
[18:53:13.233] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:13.233] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:30:0) after 1m0s
[18:54:13.281] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:30:0)
[18:54:13.281] Timer tick, asking Buildbucket for the build status
[18:54:13.737] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:13.737] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:31:0) after 1m0s
[18:55:13.843] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:31:0)
[18:55:13.843] Timer tick, asking Buildbucket for the build status
[18:55:13.913] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:13.913] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:32:0) after 1m0s
[18:56:13.943] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:32:0)
[18:56:13.943] Timer tick, asking Buildbucket for the build status
[18:56:14.042] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:14.042] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:33:0) after 1m0s
[18:57:14.058] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:33:0)
[18:57:14.058] Timer tick, asking Buildbucket for the build status
[18:57:14.151] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:14.151] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:34:0) after 1m0s
[18:58:14.188] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:34:0)
[18:58:14.188] Timer tick, asking Buildbucket for the build status
[18:58:14.276] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:14.276] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:35:0) after 1m0s
[18:59:14.502] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:35:0)
[18:59:14.502] Timer tick, asking Buildbucket for the build status
[18:59:14.582] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:14.582] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:36:0) after 1m0s
[19:00:14.787] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:36:0)
[19:00:14.787] Timer tick, asking Buildbucket for the build status
[19:00:16.231] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:16.231] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:37:0) after 1m0s
[19:01:16.260] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:37:0)
[19:01:16.260] Timer tick, asking Buildbucket for the build status
[19:01:16.356] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:16.356] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:38:0) after 1m0s
[19:02:16.397] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:38:0)
[19:02:16.397] Timer tick, asking Buildbucket for the build status
[19:02:16.487] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:16.487] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:39:0) after 1m0s
[19:03:16.498] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:39:0)
[19:03:16.498] Timer tick, asking Buildbucket for the build status
[19:03:16.734] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:16.734] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:40:0) after 1m0s
[19:04:16.765] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:40:0)
[19:04:16.765] Timer tick, asking Buildbucket for the build status
[19:04:16.831] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:16.831] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:41:0) after 1m0s
[19:05:17.203] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:41:0)
[19:05:17.203] Timer tick, asking Buildbucket for the build status
[19:05:17.293] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:17.293] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:42:0) after 1m0s
[19:06:17.448] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:42:0)
[19:06:17.448] Timer tick, asking Buildbucket for the build status
[19:06:17.753] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:17.753] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:43:0) after 1m0s
[19:07:18.071] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:43:0)
[19:07:18.071] Timer tick, asking Buildbucket for the build status
[19:07:18.164] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:18.164] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:44:0) after 1m0s
[19:08:18.564] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:44:0)
[19:08:18.564] Timer tick, asking Buildbucket for the build status
[19:08:18.655] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:18.655] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:45:0) after 1m0s
[19:09:19.197] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:45:0)
[19:09:19.197] Timer tick, asking Buildbucket for the build status
[19:09:20.543] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:20.543] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:46:0) after 1m0s
[19:10:20.547] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:46:0)
[19:10:20.547] Timer tick, asking Buildbucket for the build status
[19:10:20.834] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:20.834] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:47:0) after 1m0s
[19:11:20.847] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:47:0)
[19:11:20.847] Timer tick, asking Buildbucket for the build status
[19:11:21.792] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:21.792] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:48:0) after 1m0s
[19:12:21.964] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:48:0)
[19:12:21.964] Timer tick, asking Buildbucket for the build status
[19:12:22.032] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:22.032] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:49:0) after 1m0s
[19:13:22.196] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:49:0)
[19:13:22.196] Timer tick, asking Buildbucket for the build status
[19:13:22.258] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:22.258] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:50:0) after 1m0s
[19:14:22.387] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:50:0)
[19:14:22.387] Timer tick, asking Buildbucket for the build status
[19:14:22.504] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:22.504] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:51:0) after 1m0s
[19:15:22.713] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:51:0)
[19:15:22.713] Timer tick, asking Buildbucket for the build status
[19:15:23.083] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:23.083] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:52:0) after 1m0s
[19:16:23.281] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:52:0)
[19:16:23.281] Timer tick, asking Buildbucket for the build status
[19:16:23.376] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:23.376] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:53:0) after 1m0s
[19:17:23.975] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:53:0)
[19:17:23.975] Timer tick, asking Buildbucket for the build status
[19:17:24.094] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:24.094] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:54:0) after 1m0s
[19:18:24.541] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:54:0)
[19:18:24.541] Timer tick, asking Buildbucket for the build status
[19:18:24.659] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:24.659] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:55:0) after 1m0s
[19:19:24.778] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:55:0)
[19:19:24.778] Timer tick, asking Buildbucket for the build status
[19:19:24.856] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:24.857] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:56:0) after 1m0s
[19:20:25.029] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:56:0)
[19:20:25.029] Timer tick, asking Buildbucket for the build status
[19:20:25.106] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:25.106] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:57:0) after 1m0s
[19:21:25.233] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:57:0)
[19:21:25.234] Timer tick, asking Buildbucket for the build status
[19:21:25.315] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:25.315] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:58:0) after 1m0s
[19:22:25.654] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:58:0)
[19:22:25.654] Timer tick, asking Buildbucket for the build status
[19:22:25.717] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:25.717] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:59:0) after 1m0s
[19:23:25.825] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:59:0)
[19:23:25.825] Timer tick, asking Buildbucket for the build status
[19:23:25.896] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:25.896] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:60:0) after 1m0s
[19:24:25.950] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:60:0)
[19:24:25.950] Timer tick, asking Buildbucket for the build status
[19:24:26.024] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:26.024] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:61:0) after 1m0s
[19:25:26.033] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:61:0)
[19:25:26.033] Timer tick, asking Buildbucket for the build status
[19:25:26.273] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:26.273] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:62:0) after 1m0s
[19:26:26.322] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:62:0)
[19:26:26.322] Timer tick, asking Buildbucket for the build status
[19:26:26.443] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:26.443] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:63:0) after 1m0s
[19:27:26.462] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:63:0)
[19:27:26.462] Timer tick, asking Buildbucket for the build status
[19:27:27.576] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:27.576] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:64:0) after 1m0s
[19:28:27.651] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:64:0)
[19:28:27.651] Timer tick, asking Buildbucket for the build status
[19:28:27.930] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:27.930] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:65:0) after 1m0s
[19:29:27.956] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:65:0)
[19:29:27.956] Timer tick, asking Buildbucket for the build status
[19:29:28.234] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:28.234] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:66:0) after 1m0s
[19:30:28.271] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:66:0)
[19:30:28.271] Timer tick, asking Buildbucket for the build status
[19:30:28.453] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:28.453] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:67:0) after 1m0s
[19:31:28.496] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:67:0)
[19:31:28.496] Timer tick, asking Buildbucket for the build status
[19:31:28.666] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:28.666] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:68:0) after 1m0s
[19:32:28.763] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:68:0)
[19:32:28.763] Timer tick, asking Buildbucket for the build status
[19:32:28.858] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:28.858] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:69:0) after 1m0s
[19:33:28.889] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:69:0)
[19:33:28.889] Timer tick, asking Buildbucket for the build status
[19:33:29.296] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:29.296] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:70:0) after 1m0s
[19:34:29.359] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:70:0)
[19:34:29.359] Timer tick, asking Buildbucket for the build status
[19:34:29.437] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:29.437] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:71:0) after 1m0s
[19:35:29.461] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:71:0)
[19:35:29.461] Timer tick, asking Buildbucket for the build status
[19:35:29.542] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:29.542] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:72:0) after 1m0s
[19:36:29.568] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:72:0)
[19:36:29.568] Timer tick, asking Buildbucket for the build status
[19:36:29.704] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:29.705] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:73:0) after 1m0s
[19:37:29.764] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:73:0)
[19:37:29.764] Timer tick, asking Buildbucket for the build status
[19:37:29.839] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:29.839] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:74:0) after 1m0s
[19:38:29.884] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:74:0)
[19:38:29.884] Timer tick, asking Buildbucket for the build status
[19:38:30.569] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:30.569] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:75:0) after 1m0s
[19:39:30.589] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:75:0)
[19:39:30.589] Timer tick, asking Buildbucket for the build status
[19:39:30.732] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:30.732] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:76:0) after 1m0s
[19:40:30.761] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:76:0)
[19:40:30.761] Timer tick, asking Buildbucket for the build status
[19:40:30.890] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:30.890] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:77:0) after 1m0s
[19:41:30.922] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:77:0)
[19:41:30.922] Timer tick, asking Buildbucket for the build status
[19:41:33.493] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:33.493] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:78:0) after 1m0s
[19:42:33.560] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:78:0)
[19:42:33.560] Timer tick, asking Buildbucket for the build status
[19:42:33.642] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:33.642] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:79:0) after 1m0s
[19:43:33.681] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:79:0)
[19:43:33.681] Timer tick, asking Buildbucket for the build status
[19:43:33.762] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:33.762] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:80:0) after 1m0s
[19:44:33.843] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:80:0)
[19:44:33.843] Timer tick, asking Buildbucket for the build status
[19:44:33.907] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:33.907] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:81:0) after 1m0s
[19:45:33.966] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:81:0)
[19:45:33.966] Timer tick, asking Buildbucket for the build status
[19:45:34.053] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:34.053] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:82:0) after 1m0s
[19:46:34.200] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:82:0)
[19:46:34.200] Timer tick, asking Buildbucket for the build status
[19:46:35.801] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:35.801] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:83:0) after 1m0s
[19:47:35.848] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:83:0)
[19:47:35.848] Timer tick, asking Buildbucket for the build status
[19:47:35.936] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:35.936] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:84:0) after 1m0s
[19:48:36.024] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:84:0)
[19:48:36.024] Timer tick, asking Buildbucket for the build status
[19:48:36.169] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:36.169] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:85:0) after 1m0s
[19:49:36.211] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:85:0)
[19:49:36.211] Timer tick, asking Buildbucket for the build status
[19:49:36.377] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:36.377] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:86:0) after 1m0s
[19:50:36.402] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:86:0)
[19:50:36.402] Timer tick, asking Buildbucket for the build status
[19:50:36.534] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:36.534] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:87:0) after 1m0s
[19:51:36.852] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:87:0)
[19:51:36.852] Timer tick, asking Buildbucket for the build status
[19:51:37.253] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:37.253] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:88:0) after 1m0s
[19:52:37.413] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:88:0)
[19:52:37.413] Timer tick, asking Buildbucket for the build status
[19:52:37.488] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:37.489] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:89:0) after 1m0s
[19:53:37.730] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:89:0)
[19:53:37.730] Timer tick, asking Buildbucket for the build status
[19:53:37.801] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:37.801] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:90:0) after 1m0s
[19:54:38.100] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:90:0)
[19:54:38.100] Timer tick, asking Buildbucket for the build status
[19:54:39.441] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:39.441] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:91:0) after 1m0s
[19:55:39.827] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:91:0)
[19:55:39.828] Timer tick, asking Buildbucket for the build status
[19:55:39.928] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:39.928] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:92:0) after 1m0s
[19:56:40.099] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:92:0)
[19:56:40.099] Timer tick, asking Buildbucket for the build status
[19:56:40.240] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:40.240] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:93:0) after 1m0s
[19:57:40.549] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:93:0)
[19:57:40.549] Timer tick, asking Buildbucket for the build status
[19:57:40.653] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:40.654] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:94:0) after 1m0s
[19:58:41.535] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:94:0)
[19:58:41.535] Timer tick, asking Buildbucket for the build status
[19:58:42.619] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:42.619] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:95:0) after 1m0s
[19:59:42.677] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:95:0)
[19:59:42.677] Timer tick, asking Buildbucket for the build status
[19:59:42.779] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:42.779] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:96:0) after 1m0s
[20:00:42.879] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:96:0)
[20:00:42.879] Timer tick, asking Buildbucket for the build status
[20:00:43.116] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:43.116] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:97:0) after 1m0s
[20:01:43.244] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:97:0)
[20:01:43.244] Timer tick, asking Buildbucket for the build status
[20:01:43.332] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:43.332] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:98:0) after 1m0s
[20:02:43.456] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:98:0)
[20:02:43.456] Timer tick, asking Buildbucket for the build status
[20:02:43.864] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:43.864] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:99:0) after 1m0s
[20:03:44.007] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:99:0)
[20:03:44.007] Timer tick, asking Buildbucket for the build status
[20:03:44.264] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:44.264] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:100:0) after 1m0s
[20:04:44.364] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:100:0)
[20:04:44.364] Timer tick, asking Buildbucket for the build status
[20:04:45.600] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:45.600] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:101:0) after 1m0s
[20:05:45.614] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:101:0)
[20:05:45.614] Timer tick, asking Buildbucket for the build status
[20:05:45.877] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:45.877] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:102:0) after 1m0s
[20:06:45.899] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:102:0)
[20:06:45.899] Timer tick, asking Buildbucket for the build status
[20:06:45.978] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:45.978] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:103:0) after 1m0s
[20:07:46.011] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:103:0)
[20:07:46.011] Timer tick, asking Buildbucket for the build status
[20:07:46.128] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:46.128] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:104:0) after 1m0s
[20:08:46.158] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:104:0)
[20:08:46.158] Timer tick, asking Buildbucket for the build status
[20:08:46.349] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:46.349] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:105:0) after 1m0s
[20:09:46.399] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:105:0)
[20:09:46.399] Timer tick, asking Buildbucket for the build status
[20:09:46.550] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:46.550] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:106:0) after 1m0s
[20:10:46.532] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:106:0)
[20:10:46.532] Timer tick, asking Buildbucket for the build status
[20:10:46.604] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:46.604] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:107:0) after 1m0s
[20:11:46.910] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:107:0)
[20:11:46.910] Timer tick, asking Buildbucket for the build status
[20:11:46.989] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:46.989] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:108:0) after 1m0s
[20:12:47.117] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:108:0)
[20:12:47.117] Timer tick, asking Buildbucket for the build status
[20:12:49.317] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:49.317] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:109:0) after 1m0s
[20:13:49.485] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:109:0)
[20:13:49.485] Timer tick, asking Buildbucket for the build status
[20:13:49.635] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:49.635] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:110:0) after 1m0s
[20:14:49.647] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:110:0)
[20:14:49.647] Timer tick, asking Buildbucket for the build status
[20:14:49.709] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:49.709] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:111:0) after 1m0s
[20:15:49.726] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:111:0)
[20:15:49.726] Timer tick, asking Buildbucket for the build status
[20:15:49.792] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:49.792] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:112:0) after 1m0s
[20:16:49.892] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:112:0)
[20:16:49.892] Timer tick, asking Buildbucket for the build status
[20:16:50.005] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:50.005] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:113:0) after 1m0s
[20:17:50.143] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:113:0)
[20:17:50.143] Timer tick, asking Buildbucket for the build status
[20:17:50.214] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:50.214] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:114:0) after 1m0s
[20:18:50.341] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:114:0)
[20:18:50.341] Timer tick, asking Buildbucket for the build status
[20:18:51.033] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:51.033] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:115:0) after 1m0s
[20:19:51.267] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:115:0)
[20:19:51.267] Timer tick, asking Buildbucket for the build status
[20:19:53.743] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:53.743] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:116:0) after 1m0s
[20:20:53.955] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:116:0)
[20:20:53.955] Timer tick, asking Buildbucket for the build status
[20:20:54.037] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:54.037] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:117:0) after 1m0s
[20:21:54.070] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:117:0)
[20:21:54.070] Timer tick, asking Buildbucket for the build status
[20:21:54.138] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:54.138] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:118:0) after 1m0s
[20:22:54.167] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:118:0)
[20:22:54.167] Timer tick, asking Buildbucket for the build status
[20:22:54.448] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:54.448] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:119:0) after 1m0s
[20:23:54.697] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:119:0)
[20:23:54.697] Timer tick, asking Buildbucket for the build status
[20:23:54.785] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:54.785] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:120:0) after 1m0s
[20:24:54.852] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:120:0)
[20:24:54.852] Timer tick, asking Buildbucket for the build status
[20:24:54.962] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:54.962] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:121:0) after 1m0s
[20:25:55.047] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:121:0)
[20:25:55.047] Timer tick, asking Buildbucket for the build status
[20:25:55.136] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:55.136] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:122:0) after 1m0s
[20:26:55.171] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:122:0)
[20:26:55.171] Timer tick, asking Buildbucket for the build status
[20:26:58.321] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:58.321] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:123:0) after 1m0s
[20:27:58.381] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:123:0)
[20:27:58.381] Timer tick, asking Buildbucket for the build status
[20:27:58.465] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:58.465] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:124:0) after 1m0s
[20:28:58.499] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:124:0)
[20:28:58.499] Timer tick, asking Buildbucket for the build status
[20:28:58.660] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:58.660] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:125:0) after 1m0s
[20:29:59.913] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:125:0)
[20:29:59.913] Timer tick, asking Buildbucket for the build status
[20:30:00.124] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:00.124] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:126:0) after 1m0s
[20:31:00.204] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:126:0)
[20:31:00.204] Timer tick, asking Buildbucket for the build status
[20:31:00.494] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:00.494] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:127:0) after 1m0s
[20:32:00.639] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:127:0)
[20:32:00.639] Timer tick, asking Buildbucket for the build status
[20:32:00.768] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:00.768] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:128:0) after 1m0s
[20:33:01.124] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:128:0)
[20:33:01.124] Timer tick, asking Buildbucket for the build status
[20:33:01.197] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:01.197] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:129:0) after 1m0s
[20:34:01.549] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:129:0)
[20:34:01.549] Timer tick, asking Buildbucket for the build status
[20:34:01.628] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:01.628] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:130:0) after 1m0s
[20:35:02.022] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:130:0)
[20:35:02.022] Timer tick, asking Buildbucket for the build status
[20:35:02.123] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:02.123] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:131:0) after 1m0s
[20:36:02.212] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:131:0)
[20:36:02.212] Timer tick, asking Buildbucket for the build status
[20:36:02.325] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:02.325] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:132:0) after 1m0s
[20:37:02.523] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:132:0)
[20:37:02.523] Timer tick, asking Buildbucket for the build status
[20:37:02.608] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:02.608] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:133:0) after 1m0s
[20:38:02.753] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:133:0)
[20:38:02.753] Timer tick, asking Buildbucket for the build status
[20:38:02.820] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:02.821] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:134:0) after 1m0s
[20:39:02.863] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:134:0)
[20:39:02.863] Timer tick, asking Buildbucket for the build status
[20:39:02.960] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:02.960] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:135:0) after 1m0s
[20:40:03.183] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:135:0)
[20:40:03.183] Timer tick, asking Buildbucket for the build status
[20:40:03.289] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:03.289] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:136:0) after 1m0s
[20:41:03.394] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:136:0)
[20:41:03.394] Timer tick, asking Buildbucket for the build status
[20:41:03.609] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:03.609] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:137:0) after 1m0s
[20:42:04.134] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:137:0)
[20:42:04.134] Timer tick, asking Buildbucket for the build status
[20:42:04.210] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:04.210] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:138:0) after 1m0s
[20:43:04.481] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:138:0)
[20:43:04.481] Timer tick, asking Buildbucket for the build status
[20:43:04.856] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:04.856] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:139:0) after 1m0s
[20:44:04.923] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:139:0)
[20:44:04.923] Timer tick, asking Buildbucket for the build status
[20:44:05.058] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:05.058] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:140:0) after 1m0s
[20:45:05.485] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:140:0)
[20:45:05.485] Timer tick, asking Buildbucket for the build status
[20:45:05.659] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:05.659] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:141:0) after 1m0s
[20:46:06.042] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:141:0)
[20:46:06.042] Timer tick, asking Buildbucket for the build status
[20:46:06.123] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:06.123] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:142:0) after 1m0s
[20:47:06.929] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:142:0)
[20:47:06.929] Timer tick, asking Buildbucket for the build status
[20:47:07.075] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:07.075] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:143:0) after 1m0s
[20:48:07.114] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:143:0)
[20:48:07.114] Timer tick, asking Buildbucket for the build status
[20:48:07.274] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:07.274] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:144:0) after 1m0s
[20:49:07.448] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:144:0)
[20:49:07.448] Timer tick, asking Buildbucket for the build status
[20:49:07.520] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:07.520] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:145:0) after 1m0s
[20:50:07.909] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:145:0)
[20:50:07.909] Timer tick, asking Buildbucket for the build status
[20:50:08.124] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:08.124] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:146:0) after 1m0s
[20:51:08.145] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:146:0)
[20:51:08.145] Timer tick, asking Buildbucket for the build status
[20:51:08.500] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:08.500] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:147:0) after 1m0s
[20:52:08.497] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:147:0)
[20:52:08.497] Timer tick, asking Buildbucket for the build status
[20:52:08.597] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:08.597] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:148:0) after 1m0s
[20:53:08.632] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:148:0)
[20:53:08.632] Timer tick, asking Buildbucket for the build status
[20:53:08.709] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:08.709] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:149:0) after 1m0s
[20:54:08.899] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:149:0)
[20:54:08.899] Timer tick, asking Buildbucket for the build status
[20:54:09.019] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:09.019] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:150:0) after 1m0s
[20:55:09.122] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:150:0)
[20:55:09.122] Timer tick, asking Buildbucket for the build status
[20:55:09.183] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:09.183] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:151:0) after 1m0s
[20:56:09.252] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:151:0)
[20:56:09.252] Timer tick, asking Buildbucket for the build status
[20:56:09.403] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:09.403] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:152:0) after 1m0s
[20:57:09.442] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:152:0)
[20:57:09.442] Timer tick, asking Buildbucket for the build status
[20:57:09.515] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:09.515] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:153:0) after 1m0s
[20:58:09.590] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:153:0)
[20:58:09.590] Timer tick, asking Buildbucket for the build status
[20:58:09.702] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:09.702] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:154:0) after 1m0s
[20:59:09.742] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:154:0)
[20:59:09.742] Timer tick, asking Buildbucket for the build status
[20:59:09.810] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:09.810] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:155:0) after 1m0s
[21:00:09.954] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:155:0)
[21:00:09.954] Timer tick, asking Buildbucket for the build status
[21:00:10.043] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:10.043] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:156:0) after 1m0s
[21:01:10.230] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:156:0)
[21:01:10.230] Timer tick, asking Buildbucket for the build status
[21:01:10.336] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:10.336] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:157:0) after 1m0s
[21:02:10.507] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:157:0)
[21:02:10.507] Timer tick, asking Buildbucket for the build status
[21:02:10.661] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:10.661] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:158:0) after 1m0s
[21:03:10.686] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:158:0)
[21:03:10.686] Timer tick, asking Buildbucket for the build status
[21:03:11.474] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:11.474] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:159:0) after 1m0s
[21:04:11.606] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:159:0)
[21:04:11.606] Timer tick, asking Buildbucket for the build status
[21:04:12.042] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:12.042] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:160:0) after 1m0s
[21:05:12.117] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:160:0)
[21:05:12.117] Timer tick, asking Buildbucket for the build status
[21:05:12.417] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:12.417] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:161:0) after 1m0s
[21:06:12.616] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:161:0)
[21:06:12.616] Timer tick, asking Buildbucket for the build status
[21:06:12.712] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:12.712] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:162:0) after 1m0s
[21:07:13.270] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:162:0)
[21:07:13.270] Timer tick, asking Buildbucket for the build status
[21:07:13.360] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:13.360] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:163:0) after 1m0s
[21:08:13.518] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:163:0)
[21:08:13.518] Timer tick, asking Buildbucket for the build status
[21:08:13.630] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:13.630] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:164:0) after 1m0s
[21:09:13.901] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:164:0)
[21:09:13.901] Timer tick, asking Buildbucket for the build status
[21:09:13.977] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:13.977] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:165:0) after 1m0s
[21:10:14.198] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:165:0)
[21:10:14.198] Timer tick, asking Buildbucket for the build status
[21:10:14.268] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:14.268] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:166:0) after 1m0s
[21:11:14.424] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:166:0)
[21:11:14.424] Timer tick, asking Buildbucket for the build status
[21:11:14.808] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:14.808] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:167:0) after 1m0s
[21:12:14.799] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:167:0)
[21:12:14.799] Timer tick, asking Buildbucket for the build status
[21:12:14.971] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:14.971] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:168:0) after 1m0s
[21:13:14.959] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:168:0)
[21:13:14.959] Timer tick, asking Buildbucket for the build status
[21:13:15.139] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:15.139] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:169:0) after 1m0s
[21:14:15.221] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:169:0)
[21:14:15.221] Timer tick, asking Buildbucket for the build status
[21:14:15.611] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:15.611] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:170:0) after 1m0s
[21:15:15.656] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:170:0)
[21:15:15.656] Timer tick, asking Buildbucket for the build status
[21:15:16.215] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:16.215] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:171:0) after 1m0s
[21:16:16.259] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:171:0)
[21:16:16.260] Timer tick, asking Buildbucket for the build status
[21:16:16.592] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:16.592] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:172:0) after 1m0s
[21:17:16.629] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:172:0)
[21:17:16.629] Timer tick, asking Buildbucket for the build status
[21:17:16.719] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:16.719] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:173:0) after 1m0s
[21:18:16.755] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:173:0)
[21:18:16.755] Timer tick, asking Buildbucket for the build status
[21:18:16.938] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:16.938] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:174:0) after 1m0s
[21:19:17.012] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:174:0)
[21:19:17.012] Timer tick, asking Buildbucket for the build status
[21:19:17.140] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:17.140] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:175:0) after 1m0s
[21:20:17.172] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:175:0)
[21:20:17.172] Timer tick, asking Buildbucket for the build status
[21:20:17.248] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:17.248] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:176:0) after 1m0s
[21:21:17.320] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:176:0)
[21:21:17.320] Timer tick, asking Buildbucket for the build status
[21:21:17.490] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:17.490] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:177:0) after 1m0s
[21:22:17.527] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:177:0)
[21:22:17.527] Timer tick, asking Buildbucket for the build status
[21:22:17.611] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:17.611] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:178:0) after 1m0s
[21:23:17.609] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:178:0)
[21:23:17.609] Timer tick, asking Buildbucket for the build status
[21:23:17.695] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:17.695] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:179:0) after 1m0s
[21:24:17.688] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:179:0)
[21:24:17.688] Timer tick, asking Buildbucket for the build status
[21:24:22.111] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:22.111] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:180:0) after 1m0s
[21:25:22.120] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:180:0)
[21:25:22.120] Timer tick, asking Buildbucket for the build status
[21:25:22.228] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:22.228] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:181:0) after 1m0s
[21:26:22.255] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:181:0)
[21:26:22.255] Timer tick, asking Buildbucket for the build status
[21:26:22.496] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:22.496] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:182:0) after 1m0s
[21:27:22.539] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:182:0)
[21:27:22.539] Timer tick, asking Buildbucket for the build status
[21:27:22.745] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:22.745] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:183:0) after 1m0s
[21:28:22.773] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:183:0)
[21:28:22.773] Timer tick, asking Buildbucket for the build status
[21:28:22.839] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:22.839] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:184:0) after 1m0s
[21:29:23.005] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:184:0)
[21:29:23.005] Timer tick, asking Buildbucket for the build status
[21:29:23.134] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:23.134] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:185:0) after 1m0s
[21:30:23.145] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:185:0)
[21:30:23.145] Timer tick, asking Buildbucket for the build status
[21:30:23.233] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:23.233] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:186:0) after 1m0s
[21:31:23.297] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:186:0)
[21:31:23.297] Timer tick, asking Buildbucket for the build status
[21:31:23.354] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:23.354] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:187:0) after 1m0s
[21:32:23.381] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:187:0)
[21:32:23.381] Timer tick, asking Buildbucket for the build status
[21:32:23.453] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:23.453] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:188:0) after 1m0s
[21:33:23.478] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:188:0)
[21:33:23.478] Timer tick, asking Buildbucket for the build status
[21:33:23.780] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:23.780] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:189:0) after 1m0s
[21:34:23.803] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:189:0)
[21:34:23.803] Timer tick, asking Buildbucket for the build status
[21:34:23.954] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:23.954] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:190:0) after 1m0s
[21:35:23.946] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:190:0)
[21:35:23.946] Timer tick, asking Buildbucket for the build status
[21:35:24.054] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:24.054] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:191:0) after 1m0s
[21:36:24.121] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:191:0)
[21:36:24.121] Timer tick, asking Buildbucket for the build status
[21:36:24.187] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:24.187] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:192:0) after 1m0s
[21:37:24.228] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:192:0)
[21:37:24.228] Timer tick, asking Buildbucket for the build status
[21:37:24.450] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:24.450] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:193:0) after 1m0s
[21:38:24.476] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:193:0)
[21:38:24.476] Timer tick, asking Buildbucket for the build status
[21:38:24.729] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:24.729] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:194:0) after 1m0s
[21:39:24.773] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:194:0)
[21:39:24.773] Timer tick, asking Buildbucket for the build status
[21:39:24.954] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:24.954] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:195:0) after 1m0s
[21:40:24.996] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:195:0)
[21:40:24.996] Timer tick, asking Buildbucket for the build status
[21:40:25.567] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:25.568] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:196:0) after 1m0s
[21:41:25.592] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:196:0)
[21:41:25.592] Timer tick, asking Buildbucket for the build status
[21:41:25.818] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:25.818] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:197:0) after 1m0s
[21:42:25.835] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:197:0)
[21:42:25.835] Timer tick, asking Buildbucket for the build status
[21:42:25.931] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:25.931] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:198:0) after 1m0s
[21:43:25.962] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:198:0)
[21:43:25.962] Timer tick, asking Buildbucket for the build status
[21:43:26.036] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:26.036] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:199:0) after 1m0s
[21:44:26.080] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:199:0)
[21:44:26.080] Timer tick, asking Buildbucket for the build status
[21:44:27.213] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:27.213] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:200:0) after 1m0s
[21:45:27.304] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:200:0)
[21:45:27.304] Timer tick, asking Buildbucket for the build status
[21:45:27.399] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:27.399] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:201:0) after 1m0s
[21:46:27.566] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:201:0)
[21:46:27.566] Timer tick, asking Buildbucket for the build status
[21:46:27.736] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:27.736] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:202:0) after 1m0s
[21:47:28.143] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:202:0)
[21:47:28.143] Timer tick, asking Buildbucket for the build status
[21:47:28.244] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:28.244] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:203:0) after 1m0s
[21:48:28.299] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:203:0)
[21:48:28.299] Timer tick, asking Buildbucket for the build status
[21:48:28.437] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:28.437] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:204:0) after 1m0s
[21:49:29.344] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:204:0)
[21:49:29.344] Timer tick, asking Buildbucket for the build status
[21:49:29.406] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:29.406] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:205:0) after 1m0s
[21:50:29.604] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:205:0)
[21:50:29.604] Timer tick, asking Buildbucket for the build status
[21:50:29.757] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:29.757] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:206:0) after 1m0s
[21:51:30.034] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:206:0)
[21:51:30.034] Timer tick, asking Buildbucket for the build status
[21:51:30.808] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:30.808] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:207:0) after 1m0s
[21:52:30.907] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:207:0)
[21:52:30.907] Timer tick, asking Buildbucket for the build status
[21:52:31.064] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:31.065] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:208:0) after 1m0s
[21:53:31.171] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:208:0)
[21:53:31.171] Timer tick, asking Buildbucket for the build status
[21:53:31.287] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:31.287] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:209:0) after 1m0s
[21:54:31.447] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:209:0)
[21:54:31.447] Timer tick, asking Buildbucket for the build status
[21:54:31.578] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:31.578] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:210:0) after 1m0s
[21:55:31.618] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:210:0)
[21:55:31.618] Timer tick, asking Buildbucket for the build status
[21:55:31.737] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:31.737] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:211:0) after 1m0s
[21:56:31.790] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:211:0)
[21:56:31.790] Timer tick, asking Buildbucket for the build status
[21:56:31.942] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:31.942] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:212:0) after 1m0s
[21:57:32.063] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:212:0)
[21:57:32.063] Timer tick, asking Buildbucket for the build status
[21:57:33.634] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:33.634] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:213:0) after 1m0s
[21:58:33.707] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:213:0)
[21:58:33.707] Timer tick, asking Buildbucket for the build status
[21:58:34.025] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:34.025] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:214:0) after 1m0s
[21:59:34.020] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:214:0)
[21:59:34.020] Timer tick, asking Buildbucket for the build status
[21:59:34.077] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:34.077] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:215:0) after 1m0s
[22:00:34.129] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:215:0)
[22:00:34.129] Timer tick, asking Buildbucket for the build status
[22:00:34.212] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:34.212] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:216:0) after 1m0s
[22:01:34.261] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:216:0)
[22:01:34.261] Timer tick, asking Buildbucket for the build status
[22:01:34.566] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:34.566] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:217:0) after 1m0s
[22:02:34.615] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:217:0)
[22:02:34.615] Timer tick, asking Buildbucket for the build status
[22:02:34.680] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:34.680] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:218:0) after 1m0s
[22:03:34.729] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:218:0)
[22:03:34.729] Timer tick, asking Buildbucket for the build status
[22:03:34.798] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:34.798] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:219:0) after 1m0s
[22:04:34.861] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:219:0)
[22:04:34.861] Timer tick, asking Buildbucket for the build status
[22:04:35.030] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:35.030] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:220:0) after 1m0s
[22:05:35.456] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:220:0)
[22:05:35.456] Timer tick, asking Buildbucket for the build status
[22:05:35.598] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:35.598] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:221:0) after 1m0s
[22:06:35.656] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:221:0)
[22:06:35.656] Timer tick, asking Buildbucket for the build status
[22:06:36.488] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:36.488] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:222:0) after 1m0s
[22:07:36.701] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:222:0)
[22:07:36.701] Timer tick, asking Buildbucket for the build status
[22:07:36.927] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:36.927] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:223:0) after 1m0s
[22:08:37.091] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:223:0)
[22:08:37.091] Timer tick, asking Buildbucket for the build status
[22:08:37.146] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:37.146] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:224:0) after 1m0s
[22:09:37.246] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:224:0)
[22:09:37.246] Timer tick, asking Buildbucket for the build status
[22:09:37.412] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:37.412] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:225:0) after 1m0s
[22:10:37.474] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:225:0)
[22:10:37.474] Timer tick, asking Buildbucket for the build status
[22:10:37.794] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:37.794] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:226:0) after 1m0s
[22:11:37.825] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:226:0)
[22:11:37.825] Timer tick, asking Buildbucket for the build status
[22:11:37.920] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:37.920] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:227:0) after 1m0s
[22:12:37.953] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:227:0)
[22:12:37.953] Timer tick, asking Buildbucket for the build status
[22:12:38.423] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:38.423] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:228:0) after 1m0s
[22:13:38.468] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:228:0)
[22:13:38.468] Timer tick, asking Buildbucket for the build status
[22:13:38.541] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:38.541] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:229:0) after 1m0s
[22:14:38.523] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:229:0)
[22:14:38.523] Timer tick, asking Buildbucket for the build status
[22:14:38.581] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:38.581] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:230:0) after 1m0s
[22:15:38.762] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:230:0)
[22:15:38.762] Timer tick, asking Buildbucket for the build status
[22:15:38.862] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:38.862] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:231:0) after 1m0s
[22:16:38.877] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:231:0)
[22:16:38.877] Timer tick, asking Buildbucket for the build status
[22:16:38.966] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:38.966] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:232:0) after 1m0s
[22:17:40.186] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:232:0)
[22:17:40.186] Timer tick, asking Buildbucket for the build status
[22:17:40.273] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:40.273] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:233:0) after 1m0s
[22:18:40.662] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:233:0)
[22:18:40.662] Timer tick, asking Buildbucket for the build status
[22:18:40.723] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:40.723] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:234:0) after 1m0s
[22:19:40.923] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:234:0)
[22:19:40.923] Timer tick, asking Buildbucket for the build status
[22:19:40.998] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:40.998] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:235:0) after 1m0s
[22:20:41.114] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:235:0)
[22:20:41.114] Timer tick, asking Buildbucket for the build status
[22:20:41.875] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:41.875] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:236:0) after 1m0s
[22:21:41.935] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:236:0)
[22:21:41.935] Timer tick, asking Buildbucket for the build status
[22:21:42.039] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:42.039] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:237:0) after 1m0s
[22:22:42.144] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:237:0)
[22:22:42.144] Timer tick, asking Buildbucket for the build status
[22:22:42.209] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:42.209] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:238:0) after 1m0s
[22:23:42.244] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:238:0)
[22:23:42.244] Timer tick, asking Buildbucket for the build status
[22:23:42.328] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:42.328] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:239:0) after 1m0s
[22:24:42.436] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:239:0)
[22:24:42.436] Timer tick, asking Buildbucket for the build status
[22:24:42.518] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:42.518] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:240:0) after 1m0s
[22:25:42.583] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:240:0)
[22:25:42.583] Timer tick, asking Buildbucket for the build status
[22:25:43.060] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:43.060] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:241:0) after 1m0s
[22:26:43.046] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:241:0)
[22:26:43.046] Timer tick, asking Buildbucket for the build status
[22:26:43.105] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:43.105] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:242:0) after 1m0s
[22:27:43.159] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:242:0)
[22:27:43.159] Timer tick, asking Buildbucket for the build status
[22:27:43.263] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:43.263] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:243:0) after 1m0s
[22:28:43.338] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:243:0)
[22:28:43.338] Timer tick, asking Buildbucket for the build status
[22:28:43.432] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:43.432] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:244:0) after 1m0s
[22:29:43.623] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:244:0)
[22:29:43.623] Timer tick, asking Buildbucket for the build status
[22:29:43.682] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:43.682] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:245:0) after 1m0s
[22:30:43.784] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:245:0)
[22:30:43.784] Timer tick, asking Buildbucket for the build status
[22:30:43.929] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:43.929] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:246:0) after 1m0s
[22:31:43.933] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:246:0)
[22:31:43.933] Timer tick, asking Buildbucket for the build status
[22:31:44.038] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:44.038] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:247:0) after 1m0s
[22:32:44.288] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:247:0)
[22:32:44.355] Timer tick, asking Buildbucket for the build status
[22:32:44.467] Build 8853304438237341200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:44.468] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018734500822074032:248:0) after 1m0s
[22:33:24.246] Received PubSub notification, asking Buildbucket for the build status
[22:33:24.731] Build 8853304438237341200: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:33:24.731] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615242803112299",
"created_by": "project:chromium",
"created_ts": "1615227964135484",
"id": "8853304438237341200",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7f2e1d80cf5d3886dfe31ed9936f4ab57b14745d\"}}",
"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\": \"7f2e1d80cf5d3886dfe31ed9936f4ab57b14745d\", \"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-4-qubl\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 1715, \"got_angle_revision\": \"9bc86c50f283560a3294c256bacccc1accb5bc94\", \"got_dawn_revision\": \"010fd1a8d7c7dd4e8fabe73546be78c45b6419c2\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"7f2e1d80cf5d3886dfe31ed9936f4ab57b14745d\", \"got_revision_cp\": \"refs/heads/master@{#860778}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"de7d5775ab25234a2c14d061e0cda342248a0e6d\", \"got_v8_revision\": \"ad7609182d57f01afd2e2769869b7c3e23282119\", \"got_v8_revision_cp\": \"refs/heads/9.1.65@{#1}\", \"got_webrtc_revision\": \"3208bf102b75e8ec1eaa6640dfa3b545310b1e02\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33382}\", \"is_cached\": true, \"mirrored_builders\": [\"tryserver.chromium:win-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7f2e1d80cf5d3886dfe31ed9936f4ab57b14745d\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_9b3ebe5fd1c5be87380c40d216747346a59b28cf26de183f0e8e2b32e944d3c8_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-4-qubl\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5744-5c0a4b4\"], \"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": "1615228092951776",
"status": "COMPLETED",
"status_changed_ts": "1615242803876147",
"tags": [
"build_address:luci.chromium.ci/win-official/1715",
"builder:win-official",
"buildset:commit/git/7f2e1d80cf5d3886dfe31ed9936f4ab57b14745d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7f2e1d80cf5d3886dfe31ed9936f4ab57b14745d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018734500822074032",
"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/8853304438237341200/+/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:522be85578528a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1615242803881146",
"url": "https://ci.chromium.org/b/8853304438237341200",
"utcnow_ts": "1615242804696696"
}
}
[22:33:24.731] Invocation finished in 4h7m22.444201046s with status SUCCEEDED