[11:11:11.841] New invocation is queued and will start shortly
[11:11:13.749] Starting the invocation (attempt 1)
[11:11:13.787] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:11:13.787] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:11:13.787] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9031717224848565168",
"parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"78414b0440d90c75097181bae920c8464befe261\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-official",
"scheduler_invocation_id:9031717224848565168",
"scheduler_job_id:chromium/win-official",
"user_agent:luci-scheduler",
"buildset:commit/git/78414b0440d90c75097181bae920c8464befe261",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/78414b0440d90c75097181bae920c8464befe261",
"gitiles_ref:refs/heads/master"
]
}
[11:11:14.531] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1602846673874581",
"id": "8866287162054080032",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"78414b0440d90c75097181bae920c8464befe261\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1602846674370821",
"tags": [
"build_address:luci.chromium.ci/win-official/824",
"builder:win-official",
"buildset:commit/git/78414b0440d90c75097181bae920c8464befe261",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/78414b0440d90c75097181bae920c8464befe261",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031717224848565168",
"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/8866287162054080032/+/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": "1602846674370955",
"url": "https://ci.chromium.org/b/8866287162054080032",
"utcnow_ts": "1602846674522461"
}
}
[11:11:14.531] Task URL: https://ci.chromium.org/b/8866287162054080032
[11:11:14.531] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:2:0) after 1m0s
[11:12:10.536] Received PubSub notification, asking Buildbucket for the build status
[11:12:10.642] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:14.589] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:2:0)
[11:12:14.589] Timer tick, asking Buildbucket for the build status
[11:12:14.676] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:14.676] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:4:0) after 1m0s
[11:13:14.738] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:4:0)
[11:13:14.738] Timer tick, asking Buildbucket for the build status
[11:13:14.827] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:14.827] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:5:0) after 1m0s
[11:14:14.887] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:5:0)
[11:14:14.887] Timer tick, asking Buildbucket for the build status
[11:14:14.996] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:14.996] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:6:0) after 1m0s
[11:15:15.017] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:6:0)
[11:15:15.017] Timer tick, asking Buildbucket for the build status
[11:15:15.147] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:15.147] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:7:0) after 1m0s
[11:16:15.198] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:7:0)
[11:16:15.198] Timer tick, asking Buildbucket for the build status
[11:16:15.782] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:15.782] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:8:0) after 1m0s
[11:17:15.821] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:8:0)
[11:17:15.821] Timer tick, asking Buildbucket for the build status
[11:17:16.565] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:16.565] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:9:0) after 1m0s
[11:18:16.655] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:9:0)
[11:18:16.655] Timer tick, asking Buildbucket for the build status
[11:18:16.778] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:16.778] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:10:0) after 1m0s
[11:19:16.798] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:10:0)
[11:19:16.798] Timer tick, asking Buildbucket for the build status
[11:19:16.877] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:16.877] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:11:0) after 1m0s
[11:20:16.935] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:11:0)
[11:20:16.935] Timer tick, asking Buildbucket for the build status
[11:20:17.012] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:17.012] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:12:0) after 1m0s
[11:21:17.054] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:12:0)
[11:21:17.054] Timer tick, asking Buildbucket for the build status
[11:21:17.365] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:17.365] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:13:0) after 1m0s
[11:22:17.448] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:13:0)
[11:22:17.448] Timer tick, asking Buildbucket for the build status
[11:22:17.555] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:17.555] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:14:0) after 1m0s
[11:23:17.591] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:14:0)
[11:23:17.591] Timer tick, asking Buildbucket for the build status
[11:23:17.688] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:17.689] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:15:0) after 1m0s
[11:24:17.778] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:15:0)
[11:24:17.778] Timer tick, asking Buildbucket for the build status
[11:24:17.977] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:17.977] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:16:0) after 1m0s
[11:25:18.089] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:16:0)
[11:25:18.089] Timer tick, asking Buildbucket for the build status
[11:25:18.306] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:18.306] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:17:0) after 1m0s
[11:26:18.357] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:17:0)
[11:26:18.357] Timer tick, asking Buildbucket for the build status
[11:26:18.541] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:18.541] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:18:0) after 1m0s
[11:27:18.560] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:18:0)
[11:27:18.560] Timer tick, asking Buildbucket for the build status
[11:27:19.224] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:19.224] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:19:0) after 1m0s
[11:28:19.285] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:19:0)
[11:28:19.285] Timer tick, asking Buildbucket for the build status
[11:28:19.396] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:19.396] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:20:0) after 1m0s
[11:29:19.512] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:20:0)
[11:29:19.512] Timer tick, asking Buildbucket for the build status
[11:29:19.577] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:19.577] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:21:0) after 1m0s
[11:30:19.661] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:21:0)
[11:30:19.661] Timer tick, asking Buildbucket for the build status
[11:30:19.735] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:19.735] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:22:0) after 1m0s
[11:31:19.721] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:22:0)
[11:31:19.721] Timer tick, asking Buildbucket for the build status
[11:31:19.934] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:19.934] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:23:0) after 1m0s
[11:32:19.935] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:23:0)
[11:32:19.935] Timer tick, asking Buildbucket for the build status
[11:32:20.052] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:20.052] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:24:0) after 1m0s
[11:33:20.076] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:24:0)
[11:33:20.076] Timer tick, asking Buildbucket for the build status
[11:33:20.181] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:20.181] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:25:0) after 1m0s
[11:34:20.248] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:25:0)
[11:34:20.248] Timer tick, asking Buildbucket for the build status
[11:34:20.320] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:20.320] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:26:0) after 1m0s
[11:35:20.353] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:26:0)
[11:35:20.353] Timer tick, asking Buildbucket for the build status
[11:35:20.427] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:20.427] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:27:0) after 1m0s
[11:36:20.504] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:27:0)
[11:36:20.504] Timer tick, asking Buildbucket for the build status
[11:36:20.627] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:20.627] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:28:0) after 1m0s
[11:37:20.687] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:28:0)
[11:37:20.687] Timer tick, asking Buildbucket for the build status
[11:37:20.964] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:20.964] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:29:0) after 1m0s
[11:38:21.020] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:29:0)
[11:38:21.021] Timer tick, asking Buildbucket for the build status
[11:38:21.191] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:21.191] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:30:0) after 1m0s
[11:39:21.223] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:30:0)
[11:39:21.223] Timer tick, asking Buildbucket for the build status
[11:39:21.325] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:21.325] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:31:0) after 1m0s
[11:40:21.402] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:31:0)
[11:40:21.402] Timer tick, asking Buildbucket for the build status
[11:40:21.708] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:21.708] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:32:0) after 1m0s
[11:41:21.701] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:32:0)
[11:41:21.702] Timer tick, asking Buildbucket for the build status
[11:41:21.918] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:21.918] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:33:0) after 1m0s
[11:42:21.968] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:33:0)
[11:42:21.968] Timer tick, asking Buildbucket for the build status
[11:42:22.271] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:22.271] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:34:0) after 1m0s
[11:43:22.295] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:34:0)
[11:43:22.295] Timer tick, asking Buildbucket for the build status
[11:43:22.381] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:22.381] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:35:0) after 1m0s
[11:44:22.437] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:35:0)
[11:44:22.437] Timer tick, asking Buildbucket for the build status
[11:44:22.519] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:22.519] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:36:0) after 1m0s
[11:45:22.547] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:36:0)
[11:45:22.547] Timer tick, asking Buildbucket for the build status
[11:45:22.630] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:22.630] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:37:0) after 1m0s
[11:46:22.725] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:37:0)
[11:46:22.725] Timer tick, asking Buildbucket for the build status
[11:46:22.821] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:22.821] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:38:0) after 1m0s
[11:47:22.853] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:38:0)
[11:47:22.853] Timer tick, asking Buildbucket for the build status
[11:47:23.115] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:23.115] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:39:0) after 1m0s
[11:48:23.137] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:39:0)
[11:48:23.137] Timer tick, asking Buildbucket for the build status
[11:48:23.231] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:23.231] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:40:0) after 1m0s
[11:49:23.469] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:40:0)
[11:49:23.469] Timer tick, asking Buildbucket for the build status
[11:49:23.589] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:23.589] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:41:0) after 1m0s
[11:50:23.676] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:41:0)
[11:50:23.676] Timer tick, asking Buildbucket for the build status
[11:50:23.802] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:23.802] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:42:0) after 1m0s
[11:51:23.894] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:42:0)
[11:51:23.894] Timer tick, asking Buildbucket for the build status
[11:51:24.022] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:24.022] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:43:0) after 1m0s
[11:52:24.133] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:43:0)
[11:52:24.133] Timer tick, asking Buildbucket for the build status
[11:52:24.208] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:24.208] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:44:0) after 1m0s
[11:53:24.220] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:44:0)
[11:53:24.220] Timer tick, asking Buildbucket for the build status
[11:53:24.315] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:24.315] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:45:0) after 1m0s
[11:54:24.461] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:45:0)
[11:54:24.461] Timer tick, asking Buildbucket for the build status
[11:54:24.525] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:24.525] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:46:0) after 1m0s
[11:55:24.649] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:46:0)
[11:55:24.649] Timer tick, asking Buildbucket for the build status
[11:55:24.739] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:24.739] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:47:0) after 1m0s
[11:56:24.808] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:47:0)
[11:56:24.808] Timer tick, asking Buildbucket for the build status
[11:56:25.016] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:25.016] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:48:0) after 1m0s
[11:57:25.006] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:48:0)
[11:57:25.006] Timer tick, asking Buildbucket for the build status
[11:57:25.271] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:25.271] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:49:0) after 1m0s
[11:58:25.459] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:49:0)
[11:58:25.459] Timer tick, asking Buildbucket for the build status
[11:58:25.546] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:25.546] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:50:0) after 1m0s
[11:59:25.649] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:50:0)
[11:59:25.649] Timer tick, asking Buildbucket for the build status
[11:59:26.107] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:26.107] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:51:0) after 1m0s
[12:00:26.182] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:51:0)
[12:00:26.182] Timer tick, asking Buildbucket for the build status
[12:00:26.245] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:26.245] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:52:0) after 1m0s
[12:01:26.281] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:52:0)
[12:01:26.281] Timer tick, asking Buildbucket for the build status
[12:01:26.444] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:26.444] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:53:0) after 1m0s
[12:02:26.509] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:53:0)
[12:02:26.509] Timer tick, asking Buildbucket for the build status
[12:02:26.832] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:26.832] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:54:0) after 1m0s
[12:03:26.907] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:54:0)
[12:03:26.907] Timer tick, asking Buildbucket for the build status
[12:03:26.968] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:26.968] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:55:0) after 1m0s
[12:04:27.037] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:55:0)
[12:04:27.037] Timer tick, asking Buildbucket for the build status
[12:04:27.112] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:27.112] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:56:0) after 1m0s
[12:05:27.107] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:56:0)
[12:05:27.107] Timer tick, asking Buildbucket for the build status
[12:05:27.204] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:27.204] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:57:0) after 1m0s
[12:06:27.244] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:57:0)
[12:06:27.244] Timer tick, asking Buildbucket for the build status
[12:06:27.490] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:27.490] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:58:0) after 1m0s
[12:07:27.516] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:58:0)
[12:07:27.516] Timer tick, asking Buildbucket for the build status
[12:07:27.781] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:27.781] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:59:0) after 1m0s
[12:08:27.814] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:59:0)
[12:08:27.814] Timer tick, asking Buildbucket for the build status
[12:08:27.899] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:27.899] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:60:0) after 1m0s
[12:09:28.027] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:60:0)
[12:09:28.027] Timer tick, asking Buildbucket for the build status
[12:09:28.093] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:28.093] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:61:0) after 1m0s
[12:10:28.177] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:61:0)
[12:10:28.177] Timer tick, asking Buildbucket for the build status
[12:10:28.309] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:28.309] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:62:0) after 1m0s
[12:11:28.355] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:62:0)
[12:11:28.355] Timer tick, asking Buildbucket for the build status
[12:11:28.500] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:28.500] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:63:0) after 1m0s
[12:12:28.555] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:63:0)
[12:12:28.555] Timer tick, asking Buildbucket for the build status
[12:12:28.690] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:28.690] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:64:0) after 1m0s
[12:13:28.747] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:64:0)
[12:13:28.747] Timer tick, asking Buildbucket for the build status
[12:13:28.884] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:28.884] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:65:0) after 1m0s
[12:14:28.886] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:65:0)
[12:14:28.886] Timer tick, asking Buildbucket for the build status
[12:14:29.007] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:29.007] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:66:0) after 1m0s
[12:15:29.066] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:66:0)
[12:15:29.066] Timer tick, asking Buildbucket for the build status
[12:15:29.226] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:29.226] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:67:0) after 1m0s
[12:16:29.263] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:67:0)
[12:16:29.263] Timer tick, asking Buildbucket for the build status
[12:16:29.405] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:29.405] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:68:0) after 1m0s
[12:17:29.430] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:68:0)
[12:17:29.430] Timer tick, asking Buildbucket for the build status
[12:17:29.628] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:29.628] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:69:0) after 1m0s
[12:18:29.660] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:69:0)
[12:18:29.661] Timer tick, asking Buildbucket for the build status
[12:18:29.908] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:29.908] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:70:0) after 1m0s
[12:19:30.634] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:70:0)
[12:19:30.634] Timer tick, asking Buildbucket for the build status
[12:19:30.729] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:30.729] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:71:0) after 1m0s
[12:20:31.006] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:71:0)
[12:20:31.006] Timer tick, asking Buildbucket for the build status
[12:20:31.226] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:31.226] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:72:0) after 1m0s
[12:21:31.395] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:72:0)
[12:21:31.395] Timer tick, asking Buildbucket for the build status
[12:21:31.603] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:31.603] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:73:0) after 1m0s
[12:22:31.662] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:73:0)
[12:22:31.662] Timer tick, asking Buildbucket for the build status
[12:22:31.844] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:31.844] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:74:0) after 1m0s
[12:23:31.893] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:74:0)
[12:23:31.893] Timer tick, asking Buildbucket for the build status
[12:23:32.016] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:32.016] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:75:0) after 1m0s
[12:24:32.026] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:75:0)
[12:24:32.026] Timer tick, asking Buildbucket for the build status
[12:24:32.148] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:32.148] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:76:0) after 1m0s
[12:25:32.202] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:76:0)
[12:25:32.202] Timer tick, asking Buildbucket for the build status
[12:25:32.493] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:32.493] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:77:0) after 1m0s
[12:26:32.642] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:77:0)
[12:26:32.642] Timer tick, asking Buildbucket for the build status
[12:26:33.012] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:33.012] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:78:0) after 1m0s
[12:27:33.119] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:78:0)
[12:27:33.119] Timer tick, asking Buildbucket for the build status
[12:27:33.193] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:33.193] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:79:0) after 1m0s
[12:28:33.376] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:79:0)
[12:28:33.376] Timer tick, asking Buildbucket for the build status
[12:28:33.489] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:33.489] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:80:0) after 1m0s
[12:29:33.561] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:80:0)
[12:29:33.561] Timer tick, asking Buildbucket for the build status
[12:29:33.644] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:33.644] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:81:0) after 1m0s
[12:30:33.851] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:81:0)
[12:30:33.851] Timer tick, asking Buildbucket for the build status
[12:30:33.924] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:33.924] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:82:0) after 1m0s
[12:31:33.999] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:82:0)
[12:31:33.999] Timer tick, asking Buildbucket for the build status
[12:31:34.105] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:34.105] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:83:0) after 1m0s
[12:32:34.182] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:83:0)
[12:32:34.182] Timer tick, asking Buildbucket for the build status
[12:32:34.244] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:34.244] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:84:0) after 1m0s
[12:33:34.225] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:84:0)
[12:33:34.225] Timer tick, asking Buildbucket for the build status
[12:33:34.302] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:34.302] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:85:0) after 1m0s
[12:34:34.406] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:85:0)
[12:34:34.406] Timer tick, asking Buildbucket for the build status
[12:34:34.466] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:34.466] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:86:0) after 1m0s
[12:35:34.535] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:86:0)
[12:35:34.535] Timer tick, asking Buildbucket for the build status
[12:35:34.892] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:34.892] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:87:0) after 1m0s
[12:36:34.966] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:87:0)
[12:36:34.966] Timer tick, asking Buildbucket for the build status
[12:36:35.120] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:35.120] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:88:0) after 1m0s
[12:37:35.212] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:88:0)
[12:37:35.212] Timer tick, asking Buildbucket for the build status
[12:37:35.309] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:35.309] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:89:0) after 1m0s
[12:38:35.412] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:89:0)
[12:38:35.412] Timer tick, asking Buildbucket for the build status
[12:38:35.504] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:35.504] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:90:0) after 1m0s
[12:39:35.680] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:90:0)
[12:39:35.680] Timer tick, asking Buildbucket for the build status
[12:39:35.753] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:35.753] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:91:0) after 1m0s
[12:40:35.810] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:91:0)
[12:40:35.810] Timer tick, asking Buildbucket for the build status
[12:40:35.870] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:35.870] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:92:0) after 1m0s
[12:41:35.923] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:92:0)
[12:41:35.923] Timer tick, asking Buildbucket for the build status
[12:41:36.146] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:36.146] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:93:0) after 1m0s
[12:42:36.167] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:93:0)
[12:42:36.167] Timer tick, asking Buildbucket for the build status
[12:42:36.251] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:36.251] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:94:0) after 1m0s
[12:43:36.277] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:94:0)
[12:43:36.277] Timer tick, asking Buildbucket for the build status
[12:43:36.526] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:36.527] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:95:0) after 1m0s
[12:44:36.550] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:95:0)
[12:44:36.550] Timer tick, asking Buildbucket for the build status
[12:44:36.625] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:36.625] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:96:0) after 1m0s
[12:45:36.711] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:96:0)
[12:45:36.711] Timer tick, asking Buildbucket for the build status
[12:45:37.179] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:37.179] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:97:0) after 1m0s
[12:46:37.261] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:97:0)
[12:46:37.261] Timer tick, asking Buildbucket for the build status
[12:46:37.364] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:37.364] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:98:0) after 1m0s
[12:47:37.391] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:98:0)
[12:47:37.392] Timer tick, asking Buildbucket for the build status
[12:47:37.493] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:37.493] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:99:0) after 1m0s
[12:48:37.849] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:99:0)
[12:48:37.849] Timer tick, asking Buildbucket for the build status
[12:48:37.923] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:37.923] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:100:0) after 1m0s
[12:49:37.967] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:100:0)
[12:49:37.967] Timer tick, asking Buildbucket for the build status
[12:49:38.089] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:38.089] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:101:0) after 1m0s
[12:50:38.143] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:101:0)
[12:50:38.143] Timer tick, asking Buildbucket for the build status
[12:50:38.408] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:38.408] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:102:0) after 1m0s
[12:51:38.531] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:102:0)
[12:51:38.531] Timer tick, asking Buildbucket for the build status
[12:51:38.887] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:38.887] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:103:0) after 1m0s
[12:52:39.036] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:103:0)
[12:52:39.036] Timer tick, asking Buildbucket for the build status
[12:52:39.193] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:39.193] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:104:0) after 1m0s
[12:53:39.226] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:104:0)
[12:53:39.227] Timer tick, asking Buildbucket for the build status
[12:53:39.293] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:39.293] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:105:0) after 1m0s
[12:54:39.367] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:105:0)
[12:54:39.367] Timer tick, asking Buildbucket for the build status
[12:54:39.520] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:39.520] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:106:0) after 1m0s
[12:55:39.545] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:106:0)
[12:55:39.545] Timer tick, asking Buildbucket for the build status
[12:55:39.645] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:39.645] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:107:0) after 1m0s
[12:56:39.697] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:107:0)
[12:56:39.697] Timer tick, asking Buildbucket for the build status
[12:56:40.118] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:40.118] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:108:0) after 1m0s
[12:57:40.193] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:108:0)
[12:57:40.193] Timer tick, asking Buildbucket for the build status
[12:57:40.315] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:40.315] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:109:0) after 1m0s
[12:58:40.388] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:109:0)
[12:58:40.388] Timer tick, asking Buildbucket for the build status
[12:58:40.575] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:40.575] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:110:0) after 1m0s
[12:59:40.672] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:110:0)
[12:59:40.672] Timer tick, asking Buildbucket for the build status
[12:59:40.779] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:40.779] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:111:0) after 1m0s
[13:00:40.844] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:111:0)
[13:00:40.844] Timer tick, asking Buildbucket for the build status
[13:00:40.951] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:40.951] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:112:0) after 1m0s
[13:01:40.995] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:112:0)
[13:01:40.995] Timer tick, asking Buildbucket for the build status
[13:01:41.122] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:41.122] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:113:0) after 1m0s
[13:02:41.151] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:113:0)
[13:02:41.151] Timer tick, asking Buildbucket for the build status
[13:02:41.237] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:41.237] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:114:0) after 1m0s
[13:03:41.230] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:114:0)
[13:03:41.230] Timer tick, asking Buildbucket for the build status
[13:03:41.418] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:41.418] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:115:0) after 1m0s
[13:04:41.493] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:115:0)
[13:04:41.493] Timer tick, asking Buildbucket for the build status
[13:04:41.585] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:41.585] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:116:0) after 1m0s
[13:05:41.672] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:116:0)
[13:05:41.672] Timer tick, asking Buildbucket for the build status
[13:05:41.760] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:41.760] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:117:0) after 1m0s
[13:06:41.844] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:117:0)
[13:06:41.844] Timer tick, asking Buildbucket for the build status
[13:06:42.212] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:42.212] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:118:0) after 1m0s
[13:07:42.301] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:118:0)
[13:07:42.301] Timer tick, asking Buildbucket for the build status
[13:07:43.883] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:43.883] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:119:0) after 1m0s
[13:08:43.946] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:119:0)
[13:08:43.946] Timer tick, asking Buildbucket for the build status
[13:08:44.009] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:44.009] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:120:0) after 1m0s
[13:09:43.993] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:120:0)
[13:09:43.993] Timer tick, asking Buildbucket for the build status
[13:09:44.290] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:44.290] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:121:0) after 1m0s
[13:10:44.406] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:121:0)
[13:10:44.406] Timer tick, asking Buildbucket for the build status
[13:10:44.567] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:44.567] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:122:0) after 1m0s
[13:11:44.596] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:122:0)
[13:11:44.596] Timer tick, asking Buildbucket for the build status
[13:11:44.793] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:44.793] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:123:0) after 1m0s
[13:12:44.816] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:123:0)
[13:12:44.816] Timer tick, asking Buildbucket for the build status
[13:12:44.917] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:44.917] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:124:0) after 1m0s
[13:13:44.914] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:124:0)
[13:13:44.914] Timer tick, asking Buildbucket for the build status
[13:13:45.184] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:45.184] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:125:0) after 1m0s
[13:14:45.209] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:125:0)
[13:14:45.209] Timer tick, asking Buildbucket for the build status
[13:14:45.278] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:45.279] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:126:0) after 1m0s
[13:15:45.367] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:126:0)
[13:15:45.367] Timer tick, asking Buildbucket for the build status
[13:15:45.434] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:45.434] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:127:0) after 1m0s
[13:16:45.648] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:127:0)
[13:16:45.648] Timer tick, asking Buildbucket for the build status
[13:16:45.763] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:45.763] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:128:0) after 1m0s
[13:17:45.782] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:128:0)
[13:17:45.782] Timer tick, asking Buildbucket for the build status
[13:17:46.088] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:46.088] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:129:0) after 1m0s
[13:18:46.125] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:129:0)
[13:18:46.125] Timer tick, asking Buildbucket for the build status
[13:18:46.580] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:46.580] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:130:0) after 1m0s
[13:19:46.661] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:130:0)
[13:19:46.661] Timer tick, asking Buildbucket for the build status
[13:19:46.934] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:46.934] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:131:0) after 1m0s
[13:20:46.969] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:131:0)
[13:20:46.969] Timer tick, asking Buildbucket for the build status
[13:20:47.088] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:47.088] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:132:0) after 1m0s
[13:21:47.113] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:132:0)
[13:21:47.113] Timer tick, asking Buildbucket for the build status
[13:21:47.277] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:47.277] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:133:0) after 1m0s
[13:22:47.302] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:133:0)
[13:22:47.302] Timer tick, asking Buildbucket for the build status
[13:22:47.405] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:47.405] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:134:0) after 1m0s
[13:23:47.597] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:134:0)
[13:23:47.597] Timer tick, asking Buildbucket for the build status
[13:23:47.664] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:47.664] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:135:0) after 1m0s
[13:24:47.751] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:135:0)
[13:24:47.751] Timer tick, asking Buildbucket for the build status
[13:24:47.871] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:47.871] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:136:0) after 1m0s
[13:25:47.900] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:136:0)
[13:25:47.900] Timer tick, asking Buildbucket for the build status
[13:25:48.305] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:48.305] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:137:0) after 1m0s
[13:26:48.353] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:137:0)
[13:26:48.353] Timer tick, asking Buildbucket for the build status
[13:26:48.532] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:48.532] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:138:0) after 1m0s
[13:27:48.592] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:138:0)
[13:27:48.592] Timer tick, asking Buildbucket for the build status
[13:27:48.701] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:48.701] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:139:0) after 1m0s
[13:28:48.731] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:139:0)
[13:28:48.731] Timer tick, asking Buildbucket for the build status
[13:28:48.820] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:48.820] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:140:0) after 1m0s
[13:29:48.834] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:140:0)
[13:29:48.834] Timer tick, asking Buildbucket for the build status
[13:29:48.997] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:48.997] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:141:0) after 1m0s
[13:30:49.052] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:141:0)
[13:30:49.052] Timer tick, asking Buildbucket for the build status
[13:30:49.206] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:49.207] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:142:0) after 1m0s
[13:31:49.241] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:142:0)
[13:31:49.241] Timer tick, asking Buildbucket for the build status
[13:31:49.402] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:49.402] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:143:0) after 1m0s
[13:32:49.453] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:143:0)
[13:32:49.453] Timer tick, asking Buildbucket for the build status
[13:32:49.539] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:49.539] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:144:0) after 1m0s
[13:33:49.569] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:144:0)
[13:33:49.569] Timer tick, asking Buildbucket for the build status
[13:33:49.636] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:49.636] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:145:0) after 1m0s
[13:34:49.643] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:145:0)
[13:34:49.643] Timer tick, asking Buildbucket for the build status
[13:34:49.730] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:49.730] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:146:0) after 1m0s
[13:35:49.772] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:146:0)
[13:35:49.772] Timer tick, asking Buildbucket for the build status
[13:35:49.864] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:49.864] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:147:0) after 1m0s
[13:36:49.860] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:147:0)
[13:36:49.860] Timer tick, asking Buildbucket for the build status
[13:36:50.299] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:50.299] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:148:0) after 1m0s
[13:37:50.369] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:148:0)
[13:37:50.369] Timer tick, asking Buildbucket for the build status
[13:37:50.436] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:50.436] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:149:0) after 1m0s
[13:38:50.542] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:149:0)
[13:38:50.542] Timer tick, asking Buildbucket for the build status
[13:38:50.614] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:50.614] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:150:0) after 1m0s
[13:39:50.723] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:150:0)
[13:39:50.723] Timer tick, asking Buildbucket for the build status
[13:39:50.787] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:50.787] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:151:0) after 1m0s
[13:40:50.836] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:151:0)
[13:40:50.836] Timer tick, asking Buildbucket for the build status
[13:40:51.128] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:51.128] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:152:0) after 1m0s
[13:41:51.149] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:152:0)
[13:41:51.149] Timer tick, asking Buildbucket for the build status
[13:41:51.464] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:51.464] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:153:0) after 1m0s
[13:42:51.520] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:153:0)
[13:42:51.520] Timer tick, asking Buildbucket for the build status
[13:42:51.725] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:51.725] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:154:0) after 1m0s
[13:43:51.831] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:154:0)
[13:43:51.831] Timer tick, asking Buildbucket for the build status
[13:43:52.030] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:52.030] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:155:0) after 1m0s
[13:44:52.072] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:155:0)
[13:44:52.072] Timer tick, asking Buildbucket for the build status
[13:44:52.189] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:52.189] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:156:0) after 1m0s
[13:45:52.258] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:156:0)
[13:45:52.258] Timer tick, asking Buildbucket for the build status
[13:45:52.585] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:52.585] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:157:0) after 1m0s
[13:46:52.739] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:157:0)
[13:46:52.739] Timer tick, asking Buildbucket for the build status
[13:46:53.055] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:53.055] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:158:0) after 1m0s
[13:47:53.255] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:158:0)
[13:47:53.255] Timer tick, asking Buildbucket for the build status
[13:47:53.326] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:53.326] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:159:0) after 1m0s
[13:48:53.417] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:159:0)
[13:48:53.417] Timer tick, asking Buildbucket for the build status
[13:48:53.874] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:53.874] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:160:0) after 1m0s
[13:49:53.919] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:160:0)
[13:49:53.919] Timer tick, asking Buildbucket for the build status
[13:49:54.166] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:54.166] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:161:0) after 1m0s
[13:50:54.196] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:161:0)
[13:50:54.196] Timer tick, asking Buildbucket for the build status
[13:50:55.101] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:55.101] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:162:0) after 1m0s
[13:51:55.299] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:162:0)
[13:51:55.299] Timer tick, asking Buildbucket for the build status
[13:51:55.688] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:55.688] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:163:0) after 1m0s
[13:52:55.788] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:163:0)
[13:52:55.788] Timer tick, asking Buildbucket for the build status
[13:52:55.853] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:55.853] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:164:0) after 1m0s
[13:53:56.026] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:164:0)
[13:53:56.027] Timer tick, asking Buildbucket for the build status
[13:53:56.129] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:56.129] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:165:0) after 1m0s
[13:54:56.190] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:165:0)
[13:54:56.190] Timer tick, asking Buildbucket for the build status
[13:54:56.272] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:56.272] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:166:0) after 1m0s
[13:55:56.324] Handling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:166:0)
[13:55:56.324] Timer tick, asking Buildbucket for the build status
[13:55:56.402] Build 8866287162054080032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:56.402] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9031717224848565168:167:0) after 1m0s
[13:56:01.645] Received PubSub notification, asking Buildbucket for the build status
[13:56:01.709] Build 8866287162054080032: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[13:56:01.709] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1602856560060867",
"created_by": "project:chromium",
"created_ts": "1602846673874581",
"id": "8866287162054080032",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"78414b0440d90c75097181bae920c8464befe261\"}}",
"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\": \"78414b0440d90c75097181bae920c8464befe261\", \"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-3-9ppa\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 824, \"got_angle_revision\": \"b4fb7cc9ec8f4c1751f84dcf5098b1ec5212a9ec\", \"got_dawn_revision\": \"b1938273e4050931cadf697a946a0bcb49821ce1\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"78414b0440d90c75097181bae920c8464befe261\", \"got_revision_cp\": \"refs/heads/master@{#817874}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"04bd4d8e4ece08cc4efbb4754665f46ec42eff79\", \"got_v8_revision\": \"89f9496c20cd719cd36bc39b15557bcc741177aa\", \"got_v8_revision_cp\": \"refs/heads/8.8.104@{#1}\", \"got_webrtc_revision\": \"711de82cd1ce75d9e7c0a1230fa080a5eaf6b07d\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32420}\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"78414b0440d90c75097181bae920c8464befe261\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_9b3ebe5fd1c5be87380c40d216747346a59b28cf26de183f0e8e2b32e944d3c8_v2\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-3-9ppa\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5595-820ff29\"], \"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": "1602846729724156",
"status": "COMPLETED",
"status_changed_ts": "1602856560896256",
"tags": [
"build_address:luci.chromium.ci/win-official/824",
"builder:win-official",
"buildset:commit/git/78414b0440d90c75097181bae920c8464befe261",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/78414b0440d90c75097181bae920c8464befe261",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031717224848565168",
"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/8866287162054080032/+/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:4f49ecd9cd448f10",
"user_agent:luci-scheduler"
],
"updated_ts": "1602856560929238",
"url": "https://ci.chromium.org/b/8866287162054080032",
"utcnow_ts": "1602856561701414"
}
}
[13:56:01.709] Invocation finished in 2h44m49.884509813s with status SUCCEEDED