[12:09:21.748] New invocation is queued and will start shortly
[12:09:22.827] Starting the invocation (attempt 1)
[12:09:22.874] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:09:22.874] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:09:22.874] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019664168884694064",
"parameters_json": "{\"builder_name\":\"win32-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"2747499e3f613f6ae3231a0fff255c77d523ad76\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win32-official",
"scheduler_invocation_id:9019664168884694064",
"scheduler_job_id:chromium/win32-official",
"user_agent:luci-scheduler",
"buildset:commit/git/2747499e3f613f6ae3231a0fff255c77d523ad76",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2747499e3f613f6ae3231a0fff255c77d523ad76",
"gitiles_ref:refs/heads/master"
]
}
[12:09:24.566] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614341362995985",
"id": "8854234106914732480",
"parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2747499e3f613f6ae3231a0fff255c77d523ad76\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614341363475540",
"tags": [
"build_address:luci.chromium.ci/win32-official/1613",
"builder:win32-official",
"buildset:commit/git/2747499e3f613f6ae3231a0fff255c77d523ad76",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2747499e3f613f6ae3231a0fff255c77d523ad76",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019664168884694064",
"scheduler_job_id:chromium/win32-official",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8854234106914732480/+/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": "1614341363475659",
"url": "https://ci.chromium.org/b/8854234106914732480",
"utcnow_ts": "1614341364558175"
}
}
[12:09:24.566] Task URL: https://ci.chromium.org/b/8854234106914732480
[12:09:24.566] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:2:0) after 1m0s
[12:09:26.711] Received PubSub notification, asking Buildbucket for the build status
[12:09:26.980] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:24.580] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:2:0)
[12:10:24.580] Timer tick, asking Buildbucket for the build status
[12:10:24.644] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:24.644] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:4:0) after 1m0s
[12:11:24.635] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:4:0)
[12:11:24.635] Timer tick, asking Buildbucket for the build status
[12:11:24.813] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:24.813] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:5:0) after 1m0s
[12:12:24.835] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:5:0)
[12:12:24.835] Timer tick, asking Buildbucket for the build status
[12:12:24.906] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:24.906] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:6:0) after 1m0s
[12:13:24.991] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:6:0)
[12:13:24.991] Timer tick, asking Buildbucket for the build status
[12:13:25.072] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:25.072] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:7:0) after 1m0s
[12:14:25.202] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:7:0)
[12:14:25.202] Timer tick, asking Buildbucket for the build status
[12:14:25.366] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:25.366] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:8:0) after 1m0s
[12:15:25.477] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:8:0)
[12:15:25.477] Timer tick, asking Buildbucket for the build status
[12:15:25.613] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:25.613] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:9:0) after 1m0s
[12:16:25.657] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:9:0)
[12:16:25.657] Timer tick, asking Buildbucket for the build status
[12:16:25.728] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:25.728] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:10:0) after 1m0s
[12:17:25.817] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:10:0)
[12:17:25.817] Timer tick, asking Buildbucket for the build status
[12:17:25.912] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:25.912] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:11:0) after 1m0s
[12:18:26.305] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:11:0)
[12:18:26.305] Timer tick, asking Buildbucket for the build status
[12:18:26.394] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:26.394] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:12:0) after 1m0s
[12:19:26.482] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:12:0)
[12:19:26.482] Timer tick, asking Buildbucket for the build status
[12:19:26.604] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:26.604] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:13:0) after 1m0s
[12:20:26.716] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:13:0)
[12:20:26.716] Timer tick, asking Buildbucket for the build status
[12:20:26.813] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:26.813] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:14:0) after 1m0s
[12:21:26.954] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:14:0)
[12:21:26.954] Timer tick, asking Buildbucket for the build status
[12:21:27.172] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:27.172] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:15:0) after 1m0s
[12:22:27.258] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:15:0)
[12:22:27.258] Timer tick, asking Buildbucket for the build status
[12:22:27.325] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:27.325] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:16:0) after 1m0s
[12:23:27.433] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:16:0)
[12:23:27.433] Timer tick, asking Buildbucket for the build status
[12:23:27.525] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:27.525] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:17:0) after 1m0s
[12:24:27.673] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:17:0)
[12:24:27.673] Timer tick, asking Buildbucket for the build status
[12:24:27.738] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:27.738] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:18:0) after 1m0s
[12:25:27.791] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:18:0)
[12:25:27.791] Timer tick, asking Buildbucket for the build status
[12:25:27.873] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:27.873] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:19:0) after 1m0s
[12:26:27.924] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:19:0)
[12:26:27.924] Timer tick, asking Buildbucket for the build status
[12:26:28.125] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:28.125] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:20:0) after 1m0s
[12:27:28.191] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:20:0)
[12:27:28.191] Timer tick, asking Buildbucket for the build status
[12:27:28.418] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:28.419] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:21:0) after 1m0s
[12:28:28.491] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:21:0)
[12:28:28.491] Timer tick, asking Buildbucket for the build status
[12:28:28.557] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:28.557] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:22:0) after 1m0s
[12:29:28.575] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:22:0)
[12:29:28.575] Timer tick, asking Buildbucket for the build status
[12:29:31.453] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:31.453] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:23:0) after 1m0s
[12:30:31.544] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:23:0)
[12:30:31.544] Timer tick, asking Buildbucket for the build status
[12:30:31.630] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:31.630] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:24:0) after 1m0s
[12:31:31.747] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:24:0)
[12:31:31.747] Timer tick, asking Buildbucket for the build status
[12:31:31.905] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:31.906] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:25:0) after 1m0s
[12:32:32.043] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:25:0)
[12:32:32.043] Timer tick, asking Buildbucket for the build status
[12:32:32.136] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:32.136] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:26:0) after 1m0s
[12:33:32.157] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:26:0)
[12:33:32.158] Timer tick, asking Buildbucket for the build status
[12:33:32.226] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:32.226] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:27:0) after 1m0s
[12:34:32.336] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:27:0)
[12:34:32.336] Timer tick, asking Buildbucket for the build status
[12:34:32.628] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:32.628] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:28:0) after 1m0s
[12:35:32.705] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:28:0)
[12:35:32.705] Timer tick, asking Buildbucket for the build status
[12:35:32.789] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:32.789] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:29:0) after 1m0s
[12:36:32.802] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:29:0)
[12:36:32.802] Timer tick, asking Buildbucket for the build status
[12:36:32.898] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:32.898] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:30:0) after 1m0s
[12:37:32.956] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:30:0)
[12:37:32.956] Timer tick, asking Buildbucket for the build status
[12:37:33.017] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:33.017] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:31:0) after 1m0s
[12:38:33.066] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:31:0)
[12:38:33.066] Timer tick, asking Buildbucket for the build status
[12:38:33.139] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:33.139] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:32:0) after 1m0s
[12:39:33.241] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:32:0)
[12:39:33.241] Timer tick, asking Buildbucket for the build status
[12:39:33.317] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:33.317] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:33:0) after 1m0s
[12:40:33.352] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:33:0)
[12:40:33.352] Timer tick, asking Buildbucket for the build status
[12:40:33.438] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:33.438] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:34:0) after 1m0s
[12:41:33.508] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:34:0)
[12:41:33.508] Timer tick, asking Buildbucket for the build status
[12:41:33.589] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:33.589] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:35:0) after 1m0s
[12:42:33.582] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:35:0)
[12:42:33.582] Timer tick, asking Buildbucket for the build status
[12:42:33.741] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:33.741] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:36:0) after 1m0s
[12:43:33.723] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:36:0)
[12:43:33.723] Timer tick, asking Buildbucket for the build status
[12:43:34.111] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:34.111] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:37:0) after 1m0s
[12:44:34.190] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:37:0)
[12:44:34.190] Timer tick, asking Buildbucket for the build status
[12:44:34.279] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:34.279] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:38:0) after 1m0s
[12:45:34.305] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:38:0)
[12:45:34.305] Timer tick, asking Buildbucket for the build status
[12:45:34.403] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:34.403] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:39:0) after 1m0s
[12:46:34.390] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:39:0)
[12:46:34.390] Timer tick, asking Buildbucket for the build status
[12:46:34.482] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:34.482] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:40:0) after 1m0s
[12:47:34.523] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:40:0)
[12:47:34.523] Timer tick, asking Buildbucket for the build status
[12:47:34.659] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:34.659] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:41:0) after 1m0s
[12:48:34.694] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:41:0)
[12:48:34.694] Timer tick, asking Buildbucket for the build status
[12:48:34.869] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:34.869] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:42:0) after 1m0s
[12:49:34.887] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:42:0)
[12:49:34.887] Timer tick, asking Buildbucket for the build status
[12:49:35.260] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:35.260] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:43:0) after 1m0s
[12:50:35.343] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:43:0)
[12:50:35.343] Timer tick, asking Buildbucket for the build status
[12:50:35.413] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:35.413] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:44:0) after 1m0s
[12:51:35.391] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:44:0)
[12:51:35.391] Timer tick, asking Buildbucket for the build status
[12:51:35.529] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:35.529] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:45:0) after 1m0s
[12:52:35.548] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:45:0)
[12:52:35.548] Timer tick, asking Buildbucket for the build status
[12:52:35.687] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:35.687] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:46:0) after 1m0s
[12:53:35.826] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:46:0)
[12:53:35.826] Timer tick, asking Buildbucket for the build status
[12:53:35.911] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:35.911] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:47:0) after 1m0s
[12:54:36.015] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:47:0)
[12:54:36.015] Timer tick, asking Buildbucket for the build status
[12:54:36.108] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:36.108] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:48:0) after 1m0s
[12:55:36.184] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:48:0)
[12:55:36.184] Timer tick, asking Buildbucket for the build status
[12:55:36.407] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:36.407] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:49:0) after 1m0s
[12:56:36.411] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:49:0)
[12:56:36.411] Timer tick, asking Buildbucket for the build status
[12:56:36.632] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:36.632] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:50:0) after 1m0s
[12:57:36.770] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:50:0)
[12:57:36.770] Timer tick, asking Buildbucket for the build status
[12:57:37.012] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:37.012] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:51:0) after 1m0s
[12:58:37.051] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:51:0)
[12:58:37.051] Timer tick, asking Buildbucket for the build status
[12:58:37.146] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:37.146] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:52:0) after 1m0s
[12:59:37.243] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:52:0)
[12:59:37.243] Timer tick, asking Buildbucket for the build status
[12:59:37.317] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:37.318] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:53:0) after 1m0s
[13:00:37.338] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:53:0)
[13:00:37.338] Timer tick, asking Buildbucket for the build status
[13:00:37.404] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:37.404] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:54:0) after 1m0s
[13:01:37.411] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:54:0)
[13:01:37.411] Timer tick, asking Buildbucket for the build status
[13:01:37.732] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:37.732] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:55:0) after 1m0s
[13:02:37.758] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:55:0)
[13:02:37.759] Timer tick, asking Buildbucket for the build status
[13:02:37.910] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:37.910] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:56:0) after 1m0s
[13:03:37.898] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:56:0)
[13:03:37.898] Timer tick, asking Buildbucket for the build status
[13:03:38.125] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:38.125] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:57:0) after 1m0s
[13:04:38.260] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:57:0)
[13:04:38.260] Timer tick, asking Buildbucket for the build status
[13:04:38.342] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:38.342] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:58:0) after 1m0s
[13:05:38.406] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:58:0)
[13:05:38.406] Timer tick, asking Buildbucket for the build status
[13:05:38.477] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:38.477] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:59:0) after 1m0s
[13:06:38.505] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:59:0)
[13:06:38.505] Timer tick, asking Buildbucket for the build status
[13:06:38.620] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:38.620] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:60:0) after 1m0s
[13:07:38.656] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:60:0)
[13:07:38.657] Timer tick, asking Buildbucket for the build status
[13:07:38.729] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:38.729] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:61:0) after 1m0s
[13:08:38.778] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:61:0)
[13:08:38.778] Timer tick, asking Buildbucket for the build status
[13:08:38.878] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:38.878] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:62:0) after 1m0s
[13:09:38.902] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:62:0)
[13:09:38.902] Timer tick, asking Buildbucket for the build status
[13:09:38.966] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:38.966] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:63:0) after 1m0s
[13:10:39.004] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:63:0)
[13:10:39.004] Timer tick, asking Buildbucket for the build status
[13:10:39.072] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:39.072] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:64:0) after 1m0s
[13:11:39.131] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:64:0)
[13:11:39.131] Timer tick, asking Buildbucket for the build status
[13:11:39.427] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:39.427] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:65:0) after 1m0s
[13:12:39.553] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:65:0)
[13:12:39.553] Timer tick, asking Buildbucket for the build status
[13:12:39.996] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:39.996] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:66:0) after 1m0s
[13:13:39.989] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:66:0)
[13:13:39.989] Timer tick, asking Buildbucket for the build status
[13:13:40.104] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:40.104] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:67:0) after 1m0s
[13:14:40.131] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:67:0)
[13:14:40.131] Timer tick, asking Buildbucket for the build status
[13:14:40.323] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:40.323] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:68:0) after 1m0s
[13:15:41.157] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:68:0)
[13:15:41.157] Timer tick, asking Buildbucket for the build status
[13:15:41.230] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:41.230] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:69:0) after 1m0s
[13:16:41.541] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:69:0)
[13:16:41.541] Timer tick, asking Buildbucket for the build status
[13:16:41.612] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:41.612] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:70:0) after 1m0s
[13:17:41.857] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:70:0)
[13:17:41.857] Timer tick, asking Buildbucket for the build status
[13:17:41.940] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:41.940] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:71:0) after 1m0s
[13:18:42.150] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:71:0)
[13:18:42.150] Timer tick, asking Buildbucket for the build status
[13:18:42.335] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:42.335] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:72:0) after 1m0s
[13:19:42.319] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:72:0)
[13:19:42.319] Timer tick, asking Buildbucket for the build status
[13:19:42.427] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:42.427] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:73:0) after 1m0s
[13:20:42.446] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:73:0)
[13:20:42.446] Timer tick, asking Buildbucket for the build status
[13:20:42.612] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:42.612] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:74:0) after 1m0s
[13:21:42.639] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:74:0)
[13:21:42.639] Timer tick, asking Buildbucket for the build status
[13:21:42.703] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:42.703] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:75:0) after 1m0s
[13:22:42.747] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:75:0)
[13:22:42.747] Timer tick, asking Buildbucket for the build status
[13:22:42.851] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:42.851] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:76:0) after 1m0s
[13:23:42.880] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:76:0)
[13:23:42.880] Timer tick, asking Buildbucket for the build status
[13:23:43.192] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:43.192] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:77:0) after 1m0s
[13:24:43.189] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:77:0)
[13:24:43.189] Timer tick, asking Buildbucket for the build status
[13:24:43.485] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:43.485] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:78:0) after 1m0s
[13:25:43.577] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:78:0)
[13:25:43.577] Timer tick, asking Buildbucket for the build status
[13:25:43.662] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:43.662] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:79:0) after 1m0s
[13:26:43.711] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:79:0)
[13:26:43.711] Timer tick, asking Buildbucket for the build status
[13:26:43.826] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:43.826] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:80:0) after 1m0s
[13:27:43.825] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:80:0)
[13:27:43.825] Timer tick, asking Buildbucket for the build status
[13:27:43.995] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:43.995] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:81:0) after 1m0s
[13:28:44.044] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:81:0)
[13:28:44.044] Timer tick, asking Buildbucket for the build status
[13:28:44.201] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:44.201] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:82:0) after 1m0s
[13:29:44.339] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:82:0)
[13:29:44.339] Timer tick, asking Buildbucket for the build status
[13:29:44.424] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:44.424] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:83:0) after 1m0s
[13:30:44.438] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:83:0)
[13:30:44.438] Timer tick, asking Buildbucket for the build status
[13:30:44.652] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:44.652] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:84:0) after 1m0s
[13:31:44.704] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:84:0)
[13:31:44.704] Timer tick, asking Buildbucket for the build status
[13:31:45.005] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:45.005] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:85:0) after 1m0s
[13:32:45.065] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:85:0)
[13:32:45.065] Timer tick, asking Buildbucket for the build status
[13:32:45.162] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:45.162] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:86:0) after 1m0s
[13:33:45.257] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:86:0)
[13:33:45.258] Timer tick, asking Buildbucket for the build status
[13:33:45.340] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:45.340] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:87:0) after 1m0s
[13:34:45.399] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:87:0)
[13:34:45.399] Timer tick, asking Buildbucket for the build status
[13:34:45.612] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:45.612] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:88:0) after 1m0s
[13:35:45.704] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:88:0)
[13:35:45.704] Timer tick, asking Buildbucket for the build status
[13:35:45.828] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:45.828] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:89:0) after 1m0s
[13:36:45.835] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:89:0)
[13:36:45.835] Timer tick, asking Buildbucket for the build status
[13:36:46.043] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:46.043] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:90:0) after 1m0s
[13:37:46.062] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:90:0)
[13:37:46.062] Timer tick, asking Buildbucket for the build status
[13:37:46.140] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:46.140] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:91:0) after 1m0s
[13:38:46.185] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:91:0)
[13:38:46.185] Timer tick, asking Buildbucket for the build status
[13:38:46.409] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:46.409] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:92:0) after 1m0s
[13:39:46.439] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:92:0)
[13:39:46.439] Timer tick, asking Buildbucket for the build status
[13:39:46.505] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:46.505] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:93:0) after 1m0s
[13:40:46.551] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:93:0)
[13:40:46.551] Timer tick, asking Buildbucket for the build status
[13:40:46.652] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:46.652] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:94:0) after 1m0s
[13:41:46.750] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:94:0)
[13:41:46.750] Timer tick, asking Buildbucket for the build status
[13:41:46.849] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:46.849] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:95:0) after 1m0s
[13:42:46.918] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:95:0)
[13:42:46.918] Timer tick, asking Buildbucket for the build status
[13:42:47.105] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:47.105] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:96:0) after 1m0s
[13:43:47.182] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:96:0)
[13:43:47.182] Timer tick, asking Buildbucket for the build status
[13:43:47.334] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:47.334] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:97:0) after 1m0s
[13:44:47.357] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:97:0)
[13:44:47.357] Timer tick, asking Buildbucket for the build status
[13:44:47.454] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:47.454] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:98:0) after 1m0s
[13:45:47.601] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:98:0)
[13:45:47.601] Timer tick, asking Buildbucket for the build status
[13:45:47.969] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:47.969] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:99:0) after 1m0s
[13:46:48.085] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:99:0)
[13:46:48.085] Timer tick, asking Buildbucket for the build status
[13:46:48.193] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:48.193] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:100:0) after 1m0s
[13:47:48.245] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:100:0)
[13:47:48.245] Timer tick, asking Buildbucket for the build status
[13:47:48.345] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:48.345] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:101:0) after 1m0s
[13:48:48.391] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:101:0)
[13:48:48.391] Timer tick, asking Buildbucket for the build status
[13:48:48.469] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:48.469] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:102:0) after 1m0s
[13:49:48.633] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:102:0)
[13:49:48.633] Timer tick, asking Buildbucket for the build status
[13:49:48.736] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:48.736] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:103:0) after 1m0s
[13:50:48.797] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:103:0)
[13:50:48.797] Timer tick, asking Buildbucket for the build status
[13:50:48.881] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:48.881] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:104:0) after 1m0s
[13:51:48.986] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:104:0)
[13:51:48.986] Timer tick, asking Buildbucket for the build status
[13:51:49.130] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:49.130] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:105:0) after 1m0s
[13:52:49.187] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:105:0)
[13:52:49.187] Timer tick, asking Buildbucket for the build status
[13:52:49.738] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:49.738] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:106:0) after 1m0s
[13:53:49.850] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:106:0)
[13:53:49.850] Timer tick, asking Buildbucket for the build status
[13:53:49.943] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:49.943] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:107:0) after 1m0s
[13:54:50.030] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:107:0)
[13:54:50.030] Timer tick, asking Buildbucket for the build status
[13:54:50.141] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:50.141] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:108:0) after 1m0s
[13:55:50.330] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:108:0)
[13:55:50.330] Timer tick, asking Buildbucket for the build status
[13:55:50.447] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:50.447] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:109:0) after 1m0s
[13:56:50.591] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:109:0)
[13:56:50.591] Timer tick, asking Buildbucket for the build status
[13:56:50.732] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:50.732] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:110:0) after 1m0s
[13:57:50.764] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:110:0)
[13:57:50.764] Timer tick, asking Buildbucket for the build status
[13:57:50.876] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:50.876] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:111:0) after 1m0s
[13:58:50.961] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:111:0)
[13:58:50.961] Timer tick, asking Buildbucket for the build status
[13:58:51.053] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:51.053] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:112:0) after 1m0s
[13:59:51.128] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:112:0)
[13:59:51.128] Timer tick, asking Buildbucket for the build status
[13:59:51.209] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:51.209] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:113:0) after 1m0s
[14:00:51.296] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:113:0)
[14:00:51.296] Timer tick, asking Buildbucket for the build status
[14:00:52.584] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:52.584] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:114:0) after 1m0s
[14:01:52.604] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:114:0)
[14:01:52.604] Timer tick, asking Buildbucket for the build status
[14:01:52.831] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:52.831] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:115:0) after 1m0s
[14:02:52.907] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:115:0)
[14:02:52.907] Timer tick, asking Buildbucket for the build status
[14:02:53.218] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:53.218] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:116:0) after 1m0s
[14:03:53.241] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:116:0)
[14:03:53.241] Timer tick, asking Buildbucket for the build status
[14:03:53.360] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:53.360] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:117:0) after 1m0s
[14:04:53.466] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:117:0)
[14:04:53.466] Timer tick, asking Buildbucket for the build status
[14:04:53.545] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:53.546] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:118:0) after 1m0s
[14:05:53.636] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:118:0)
[14:05:53.636] Timer tick, asking Buildbucket for the build status
[14:05:53.729] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:53.729] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:119:0) after 1m0s
[14:06:53.851] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:119:0)
[14:06:53.851] Timer tick, asking Buildbucket for the build status
[14:06:54.043] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:54.043] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:120:0) after 1m0s
[14:07:54.171] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:120:0)
[14:07:54.171] Timer tick, asking Buildbucket for the build status
[14:07:54.332] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:54.332] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:121:0) after 1m0s
[14:08:54.420] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:121:0)
[14:08:54.420] Timer tick, asking Buildbucket for the build status
[14:08:54.515] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:54.515] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:122:0) after 1m0s
[14:09:54.609] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:122:0)
[14:09:54.609] Timer tick, asking Buildbucket for the build status
[14:09:54.723] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:54.723] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:123:0) after 1m0s
[14:10:54.757] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:123:0)
[14:10:54.757] Timer tick, asking Buildbucket for the build status
[14:10:55.007] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:55.007] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:124:0) after 1m0s
[14:11:55.068] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:124:0)
[14:11:55.068] Timer tick, asking Buildbucket for the build status
[14:11:55.225] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:55.226] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:125:0) after 1m0s
[14:12:55.325] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:125:0)
[14:12:55.325] Timer tick, asking Buildbucket for the build status
[14:12:55.390] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:55.390] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:126:0) after 1m0s
[14:13:55.446] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:126:0)
[14:13:55.446] Timer tick, asking Buildbucket for the build status
[14:13:55.656] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:55.656] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:127:0) after 1m0s
[14:14:55.809] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:127:0)
[14:14:55.809] Timer tick, asking Buildbucket for the build status
[14:14:56.220] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:56.220] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:128:0) after 1m0s
[14:15:56.293] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:128:0)
[14:15:56.294] Timer tick, asking Buildbucket for the build status
[14:15:56.376] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:56.376] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:129:0) after 1m0s
[14:16:56.549] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:129:0)
[14:16:56.549] Timer tick, asking Buildbucket for the build status
[14:16:56.624] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:56.624] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:130:0) after 1m0s
[14:17:56.738] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:130:0)
[14:17:56.738] Timer tick, asking Buildbucket for the build status
[14:17:56.822] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:56.822] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:131:0) after 1m0s
[14:18:56.837] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:131:0)
[14:18:56.837] Timer tick, asking Buildbucket for the build status
[14:18:56.934] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:56.934] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:132:0) after 1m0s
[14:19:57.043] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:132:0)
[14:19:57.043] Timer tick, asking Buildbucket for the build status
[14:19:57.139] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:57.139] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:133:0) after 1m0s
[14:20:57.293] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:133:0)
[14:20:57.293] Timer tick, asking Buildbucket for the build status
[14:20:57.520] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:57.520] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:134:0) after 1m0s
[14:21:57.721] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:134:0)
[14:21:57.721] Timer tick, asking Buildbucket for the build status
[14:21:57.807] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:57.807] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:135:0) after 1m0s
[14:22:57.937] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:135:0)
[14:22:57.937] Timer tick, asking Buildbucket for the build status
[14:22:58.302] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:58.302] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:136:0) after 1m0s
[14:23:58.296] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:136:0)
[14:23:58.296] Timer tick, asking Buildbucket for the build status
[14:23:58.376] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:58.376] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:137:0) after 1m0s
[14:24:58.409] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:137:0)
[14:24:58.409] Timer tick, asking Buildbucket for the build status
[14:24:58.492] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:58.492] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:138:0) after 1m0s
[14:25:58.521] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:138:0)
[14:25:58.521] Timer tick, asking Buildbucket for the build status
[14:25:58.598] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:58.598] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:139:0) after 1m0s
[14:26:58.685] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:139:0)
[14:26:58.685] Timer tick, asking Buildbucket for the build status
[14:26:58.750] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:58.750] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:140:0) after 1m0s
[14:27:58.780] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:140:0)
[14:27:58.780] Timer tick, asking Buildbucket for the build status
[14:27:58.854] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:58.854] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:141:0) after 1m0s
[14:28:58.855] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:141:0)
[14:28:58.856] Timer tick, asking Buildbucket for the build status
[14:28:59.267] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:59.267] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:142:0) after 1m0s
[14:29:59.338] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:142:0)
[14:29:59.338] Timer tick, asking Buildbucket for the build status
[14:29:59.440] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:59.440] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:143:0) after 1m0s
[14:30:59.659] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:143:0)
[14:30:59.659] Timer tick, asking Buildbucket for the build status
[14:30:59.745] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:59.745] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:144:0) after 1m0s
[14:31:59.799] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:144:0)
[14:31:59.799] Timer tick, asking Buildbucket for the build status
[14:31:59.915] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:59.915] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:145:0) after 1m0s
[14:32:59.956] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:145:0)
[14:32:59.956] Timer tick, asking Buildbucket for the build status
[14:33:00.356] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:00.356] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:146:0) after 1m0s
[14:34:00.552] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:146:0)
[14:34:00.552] Timer tick, asking Buildbucket for the build status
[14:34:00.702] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:00.702] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:147:0) after 1m0s
[14:35:01.536] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:147:0)
[14:35:01.536] Timer tick, asking Buildbucket for the build status
[14:35:01.678] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:01.678] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:148:0) after 1m0s
[14:36:01.723] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:148:0)
[14:36:01.723] Timer tick, asking Buildbucket for the build status
[14:36:01.885] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:01.885] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:149:0) after 1m0s
[14:37:01.965] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:149:0)
[14:37:01.965] Timer tick, asking Buildbucket for the build status
[14:37:02.200] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:02.200] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:150:0) after 1m0s
[14:38:02.221] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:150:0)
[14:38:02.221] Timer tick, asking Buildbucket for the build status
[14:38:02.323] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:02.323] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:151:0) after 1m0s
[14:39:02.364] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:151:0)
[14:39:02.364] Timer tick, asking Buildbucket for the build status
[14:39:02.447] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:02.447] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:152:0) after 1m0s
[14:40:02.495] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:152:0)
[14:40:02.495] Timer tick, asking Buildbucket for the build status
[14:40:02.588] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:02.588] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:153:0) after 1m0s
[14:41:02.614] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:153:0)
[14:41:02.614] Timer tick, asking Buildbucket for the build status
[14:41:02.806] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:02.806] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:154:0) after 1m0s
[14:42:03.218] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:154:0)
[14:42:03.218] Timer tick, asking Buildbucket for the build status
[14:42:03.317] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:03.317] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:155:0) after 1m0s
[14:43:03.333] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:155:0)
[14:43:03.333] Timer tick, asking Buildbucket for the build status
[14:43:03.509] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:03.509] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:156:0) after 1m0s
[14:44:03.556] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:156:0)
[14:44:03.556] Timer tick, asking Buildbucket for the build status
[14:44:03.659] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:03.659] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:157:0) after 1m0s
[14:45:03.701] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:157:0)
[14:45:03.701] Timer tick, asking Buildbucket for the build status
[14:45:03.775] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:03.775] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:158:0) after 1m0s
[14:46:03.853] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:158:0)
[14:46:03.853] Timer tick, asking Buildbucket for the build status
[14:46:03.938] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:03.938] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:159:0) after 1m0s
[14:47:04.028] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:159:0)
[14:47:04.028] Timer tick, asking Buildbucket for the build status
[14:47:04.136] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:04.136] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:160:0) after 1m0s
[14:48:04.209] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:160:0)
[14:48:04.209] Timer tick, asking Buildbucket for the build status
[14:48:04.427] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:04.427] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:161:0) after 1m0s
[14:49:04.452] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:161:0)
[14:49:04.452] Timer tick, asking Buildbucket for the build status
[14:49:04.665] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:04.665] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:162:0) after 1m0s
[14:50:04.691] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:162:0)
[14:50:04.691] Timer tick, asking Buildbucket for the build status
[14:50:04.794] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:04.794] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:163:0) after 1m0s
[14:51:04.835] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:163:0)
[14:51:04.835] Timer tick, asking Buildbucket for the build status
[14:51:04.904] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:04.904] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:164:0) after 1m0s
[14:52:04.970] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:164:0)
[14:52:04.970] Timer tick, asking Buildbucket for the build status
[14:52:07.359] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:07.359] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:165:0) after 1m0s
[14:53:07.488] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:165:0)
[14:53:07.488] Timer tick, asking Buildbucket for the build status
[14:53:07.645] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:07.645] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:166:0) after 1m0s
[14:54:07.783] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:166:0)
[14:54:07.783] Timer tick, asking Buildbucket for the build status
[14:54:08.000] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:08.000] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:167:0) after 1m0s
[14:55:08.084] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:167:0)
[14:55:08.084] Timer tick, asking Buildbucket for the build status
[14:55:08.348] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:08.348] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:168:0) after 1m0s
[14:56:08.382] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:168:0)
[14:56:08.382] Timer tick, asking Buildbucket for the build status
[14:56:08.459] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:08.459] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:169:0) after 1m0s
[14:57:08.518] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:169:0)
[14:57:08.518] Timer tick, asking Buildbucket for the build status
[14:57:08.610] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:08.610] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:170:0) after 1m0s
[14:58:08.656] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:170:0)
[14:58:08.656] Timer tick, asking Buildbucket for the build status
[14:58:08.791] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:08.791] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:171:0) after 1m0s
[14:59:08.828] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:171:0)
[14:59:08.828] Timer tick, asking Buildbucket for the build status
[14:59:08.958] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:08.958] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:172:0) after 1m0s
[15:00:09.050] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:172:0)
[15:00:09.050] Timer tick, asking Buildbucket for the build status
[15:00:09.178] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:09.178] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:173:0) after 1m0s
[15:01:09.266] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:173:0)
[15:01:09.266] Timer tick, asking Buildbucket for the build status
[15:01:09.346] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:09.346] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:174:0) after 1m0s
[15:02:09.390] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:174:0)
[15:02:09.390] Timer tick, asking Buildbucket for the build status
[15:02:09.476] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:09.476] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:175:0) after 1m0s
[15:03:09.478] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:175:0)
[15:03:09.478] Timer tick, asking Buildbucket for the build status
[15:03:09.554] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:09.554] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:176:0) after 1m0s
[15:04:09.565] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:176:0)
[15:04:09.565] Timer tick, asking Buildbucket for the build status
[15:04:09.634] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:09.634] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:177:0) after 1m0s
[15:05:09.721] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:177:0)
[15:05:09.721] Timer tick, asking Buildbucket for the build status
[15:05:09.907] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:09.907] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:178:0) after 1m0s
[15:06:09.939] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:178:0)
[15:06:09.939] Timer tick, asking Buildbucket for the build status
[15:06:10.057] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:10.057] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:179:0) after 1m0s
[15:07:10.414] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:179:0)
[15:07:10.414] Timer tick, asking Buildbucket for the build status
[15:07:10.815] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:10.815] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:180:0) after 1m0s
[15:08:10.871] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:180:0)
[15:08:10.871] Timer tick, asking Buildbucket for the build status
[15:08:10.948] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:10.948] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:181:0) after 1m0s
[15:09:10.987] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:181:0)
[15:09:10.987] Timer tick, asking Buildbucket for the build status
[15:09:11.392] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:11.392] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:182:0) after 1m0s
[15:10:11.495] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:182:0)
[15:10:11.495] Timer tick, asking Buildbucket for the build status
[15:10:11.584] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:11.584] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:183:0) after 1m0s
[15:11:11.635] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:183:0)
[15:11:11.635] Timer tick, asking Buildbucket for the build status
[15:11:11.730] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:11.730] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:184:0) after 1m0s
[15:12:11.881] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:184:0)
[15:12:11.881] Timer tick, asking Buildbucket for the build status
[15:12:12.232] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:12.232] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:185:0) after 1m0s
[15:13:12.387] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:185:0)
[15:13:12.387] Timer tick, asking Buildbucket for the build status
[15:13:12.610] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:12.610] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:186:0) after 1m0s
[15:14:12.677] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:186:0)
[15:14:12.677] Timer tick, asking Buildbucket for the build status
[15:14:12.895] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:12.895] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:187:0) after 1m0s
[15:15:12.968] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:187:0)
[15:15:12.968] Timer tick, asking Buildbucket for the build status
[15:15:13.155] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:13.155] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:188:0) after 1m0s
[15:16:13.295] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:188:0)
[15:16:13.295] Timer tick, asking Buildbucket for the build status
[15:16:13.391] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:13.391] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:189:0) after 1m0s
[15:17:13.587] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:189:0)
[15:17:13.587] Timer tick, asking Buildbucket for the build status
[15:17:13.703] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:13.703] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:190:0) after 1m0s
[15:18:13.728] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:190:0)
[15:18:13.728] Timer tick, asking Buildbucket for the build status
[15:18:13.954] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:13.955] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:191:0) after 1m0s
[15:19:14.026] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:191:0)
[15:19:14.026] Timer tick, asking Buildbucket for the build status
[15:19:14.152] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:14.152] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:192:0) after 1m0s
[15:20:14.215] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:192:0)
[15:20:14.215] Timer tick, asking Buildbucket for the build status
[15:20:14.335] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:14.335] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:193:0) after 1m0s
[15:21:14.669] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:193:0)
[15:21:14.669] Timer tick, asking Buildbucket for the build status
[15:21:14.790] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:14.790] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:194:0) after 1m0s
[15:22:14.810] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:194:0)
[15:22:14.810] Timer tick, asking Buildbucket for the build status
[15:22:15.027] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:15.027] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:195:0) after 1m0s
[15:23:15.029] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:195:0)
[15:23:15.029] Timer tick, asking Buildbucket for the build status
[15:23:15.110] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:15.110] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:196:0) after 1m0s
[15:24:15.157] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:196:0)
[15:24:15.157] Timer tick, asking Buildbucket for the build status
[15:24:15.237] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:15.237] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:197:0) after 1m0s
[15:25:15.219] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:197:0)
[15:25:15.219] Timer tick, asking Buildbucket for the build status
[15:25:15.549] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:15.549] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:198:0) after 1m0s
[15:26:15.607] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:198:0)
[15:26:15.607] Timer tick, asking Buildbucket for the build status
[15:26:15.762] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:15.762] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:199:0) after 1m0s
[15:27:15.845] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:199:0)
[15:27:15.845] Timer tick, asking Buildbucket for the build status
[15:27:16.150] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:16.150] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:200:0) after 1m0s
[15:28:16.214] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:200:0)
[15:28:16.214] Timer tick, asking Buildbucket for the build status
[15:28:16.288] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:16.288] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:201:0) after 1m0s
[15:29:16.326] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:201:0)
[15:29:16.326] Timer tick, asking Buildbucket for the build status
[15:29:16.392] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:16.392] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:202:0) after 1m0s
[15:30:16.504] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:202:0)
[15:30:16.504] Timer tick, asking Buildbucket for the build status
[15:30:16.607] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:16.607] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:203:0) after 1m0s
[15:31:16.653] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:203:0)
[15:31:16.653] Timer tick, asking Buildbucket for the build status
[15:31:16.907] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:16.907] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:204:0) after 1m0s
[15:32:16.954] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:204:0)
[15:32:16.954] Timer tick, asking Buildbucket for the build status
[15:32:17.737] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:17.737] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:205:0) after 1m0s
[15:33:17.819] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:205:0)
[15:33:17.819] Timer tick, asking Buildbucket for the build status
[15:33:17.905] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:17.905] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:206:0) after 1m0s
[15:34:17.997] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:206:0)
[15:34:17.997] Timer tick, asking Buildbucket for the build status
[15:34:18.145] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:18.145] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:207:0) after 1m0s
[15:35:18.199] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:207:0)
[15:35:18.199] Timer tick, asking Buildbucket for the build status
[15:35:18.400] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:18.400] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:208:0) after 1m0s
[15:36:18.449] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:208:0)
[15:36:18.449] Timer tick, asking Buildbucket for the build status
[15:36:18.572] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:18.572] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:209:0) after 1m0s
[15:37:18.618] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:209:0)
[15:37:18.618] Timer tick, asking Buildbucket for the build status
[15:37:18.728] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:18.728] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:210:0) after 1m0s
[15:38:18.754] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:210:0)
[15:38:18.754] Timer tick, asking Buildbucket for the build status
[15:38:18.823] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:18.823] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:211:0) after 1m0s
[15:39:18.801] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:211:0)
[15:39:18.801] Timer tick, asking Buildbucket for the build status
[15:39:18.893] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:18.893] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:212:0) after 1m0s
[15:40:18.947] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:212:0)
[15:40:18.947] Timer tick, asking Buildbucket for the build status
[15:40:19.294] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:19.294] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:213:0) after 1m0s
[15:41:19.316] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:213:0)
[15:41:19.316] Timer tick, asking Buildbucket for the build status
[15:41:19.548] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:19.548] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:214:0) after 1m0s
[15:42:19.603] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:214:0)
[15:42:19.603] Timer tick, asking Buildbucket for the build status
[15:42:19.686] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:19.686] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:215:0) after 1m0s
[15:43:19.736] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:215:0)
[15:43:19.736] Timer tick, asking Buildbucket for the build status
[15:43:19.849] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:19.849] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:216:0) after 1m0s
[15:44:19.881] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:216:0)
[15:44:19.881] Timer tick, asking Buildbucket for the build status
[15:44:19.972] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:19.972] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:217:0) after 1m0s
[15:45:19.994] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:217:0)
[15:45:19.994] Timer tick, asking Buildbucket for the build status
[15:45:20.147] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:20.147] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:218:0) after 1m0s
[15:46:20.198] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:218:0)
[15:46:20.198] Timer tick, asking Buildbucket for the build status
[15:46:20.296] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:20.296] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:219:0) after 1m0s
[15:47:20.392] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:219:0)
[15:47:20.392] Timer tick, asking Buildbucket for the build status
[15:47:20.662] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:20.663] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:220:0) after 1m0s
[15:48:20.737] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:220:0)
[15:48:20.737] Timer tick, asking Buildbucket for the build status
[15:48:29.170] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:29.170] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:221:0) after 1m0s
[15:49:29.273] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:221:0)
[15:49:29.273] Timer tick, asking Buildbucket for the build status
[15:49:29.349] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:29.349] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:222:0) after 1m0s
[15:50:29.460] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:222:0)
[15:50:29.460] Timer tick, asking Buildbucket for the build status
[15:50:29.802] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:29.802] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:223:0) after 1m0s
[15:51:30.002] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:223:0)
[15:51:30.002] Timer tick, asking Buildbucket for the build status
[15:51:30.371] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:30.371] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:224:0) after 1m0s
[15:52:30.581] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:224:0)
[15:52:30.581] Timer tick, asking Buildbucket for the build status
[15:52:30.815] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:30.815] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:225:0) after 1m0s
[15:53:30.867] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:225:0)
[15:53:30.867] Timer tick, asking Buildbucket for the build status
[15:53:31.064] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:31.064] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:226:0) after 1m0s
[15:54:31.154] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:226:0)
[15:54:31.154] Timer tick, asking Buildbucket for the build status
[15:54:31.309] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:31.309] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:227:0) after 1m0s
[15:55:31.376] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:227:0)
[15:55:31.376] Timer tick, asking Buildbucket for the build status
[15:55:31.475] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:31.475] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:228:0) after 1m0s
[15:56:31.502] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:228:0)
[15:56:31.502] Timer tick, asking Buildbucket for the build status
[15:56:31.572] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:31.572] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:229:0) after 1m0s
[15:57:31.594] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:229:0)
[15:57:31.594] Timer tick, asking Buildbucket for the build status
[15:57:31.901] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:31.901] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:230:0) after 1m0s
[15:58:31.926] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:230:0)
[15:58:31.926] Timer tick, asking Buildbucket for the build status
[15:58:32.022] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:32.022] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:231:0) after 1m0s
[15:59:32.064] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:231:0)
[15:59:32.064] Timer tick, asking Buildbucket for the build status
[15:59:32.164] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:32.164] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:232:0) after 1m0s
[16:00:32.218] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:232:0)
[16:00:32.218] Timer tick, asking Buildbucket for the build status
[16:00:32.651] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:32.651] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:233:0) after 1m0s
[16:01:32.713] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:233:0)
[16:01:32.713] Timer tick, asking Buildbucket for the build status
[16:01:32.812] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:32.812] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:234:0) after 1m0s
[16:02:32.880] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:234:0)
[16:02:32.880] Timer tick, asking Buildbucket for the build status
[16:02:33.000] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:33.000] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:235:0) after 1m0s
[16:03:33.039] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:235:0)
[16:03:33.039] Timer tick, asking Buildbucket for the build status
[16:03:33.116] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:33.116] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:236:0) after 1m0s
[16:04:33.176] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:236:0)
[16:04:33.176] Timer tick, asking Buildbucket for the build status
[16:04:33.348] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:33.348] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:237:0) after 1m0s
[16:05:33.417] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:237:0)
[16:05:33.417] Timer tick, asking Buildbucket for the build status
[16:05:33.726] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:33.726] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:238:0) after 1m0s
[16:06:33.749] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:238:0)
[16:06:33.749] Timer tick, asking Buildbucket for the build status
[16:06:33.860] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:33.860] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:239:0) after 1m0s
[16:07:33.938] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:239:0)
[16:07:33.938] Timer tick, asking Buildbucket for the build status
[16:07:34.197] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:34.197] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:240:0) after 1m0s
[16:08:34.221] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:240:0)
[16:08:34.221] Timer tick, asking Buildbucket for the build status
[16:08:34.632] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:34.632] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:241:0) after 1m0s
[16:09:34.645] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:241:0)
[16:09:34.645] Timer tick, asking Buildbucket for the build status
[16:09:34.729] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:34.729] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:242:0) after 1m0s
[16:10:34.752] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:242:0)
[16:10:34.752] Timer tick, asking Buildbucket for the build status
[16:10:34.819] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:34.820] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:243:0) after 1m0s
[16:11:34.880] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:243:0)
[16:11:34.880] Timer tick, asking Buildbucket for the build status
[16:11:34.953] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:34.953] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:244:0) after 1m0s
[16:12:35.075] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:244:0)
[16:12:35.075] Timer tick, asking Buildbucket for the build status
[16:12:35.248] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:35.248] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:245:0) after 1m0s
[16:13:35.367] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:245:0)
[16:13:35.367] Timer tick, asking Buildbucket for the build status
[16:13:35.753] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:35.753] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:246:0) after 1m0s
[16:14:35.843] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:246:0)
[16:14:35.843] Timer tick, asking Buildbucket for the build status
[16:14:36.119] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:36.119] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:247:0) after 1m0s
[16:15:36.168] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:247:0)
[16:15:36.168] Timer tick, asking Buildbucket for the build status
[16:15:36.408] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:36.408] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:248:0) after 1m0s
[16:16:36.549] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:248:0)
[16:16:36.549] Timer tick, asking Buildbucket for the build status
[16:16:36.748] Build 8854234106914732480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:36.748] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9019664168884694064:249:0) after 1m0s
[16:16:51.348] Received PubSub notification, asking Buildbucket for the build status
[16:16:51.488] Build 8854234106914732480: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:16:51.488] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614356210542697",
"created_by": "project:chromium",
"created_ts": "1614341362995985",
"id": "8854234106914732480",
"parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2747499e3f613f6ae3231a0fff255c77d523ad76\"}}",
"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\": \"2747499e3f613f6ae3231a0fff255c77d523ad76\", \"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-9-ifpv\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win32-official\", \"buildnumber\": 1613, \"got_angle_revision\": \"d24398b3e36175d08e74261a1a0a2c8a27a00dd6\", \"got_dawn_revision\": \"6cbef93c73ceff40010e74533d461f80e2afbd51\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"2747499e3f613f6ae3231a0fff255c77d523ad76\", \"got_revision_cp\": \"refs/heads/master@{#858082}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"349abccec8f7ebd1259de11965d58790a76b0ba4\", \"got_v8_revision\": \"bd0108b4c88e0d6f2350cb79b5f363fbd02f3eb7\", \"got_v8_revision_cp\": \"refs/heads/9.0.257@{#1}\", \"got_webrtc_revision\": \"bb52bdf09516ca548c4aff50526eda561f239bc0\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33341}\", \"mirrored_builders\": [\"tryserver.chromium:win32-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2747499e3f613f6ae3231a0fff255c77d523ad76\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_a69e6b6949245e742d9a022200655bac5124ee86184973d811510d142a3a53fc_v2\", \"builder_f6b49936a2965b3cdad8f63ce13313d0c4b82119a9acfffbfe199e91c26d0c88_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-9-ifpv\"], \"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\": [\"5712-339372b\"], \"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": "1614341365928164",
"status": "COMPLETED",
"status_changed_ts": "1614356211107472",
"tags": [
"build_address:luci.chromium.ci/win32-official/1613",
"builder:win32-official",
"buildset:commit/git/2747499e3f613f6ae3231a0fff255c77d523ad76",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2747499e3f613f6ae3231a0fff255c77d523ad76",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019664168884694064",
"scheduler_job_id:chromium/win32-official",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8854234106914732480/+/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:51f70fe41a6d6810",
"user_agent:luci-scheduler"
],
"updated_ts": "1614356211114904",
"url": "https://ci.chromium.org/b/8854234106914732480",
"utcnow_ts": "1614356211479215"
}
}
[16:16:51.488] Invocation finished in 4h7m29.756331119s with status SUCCEEDED