[18:22:15.516] New invocation is queued and will start shortly
[18:22:16.713] Starting the invocation (attempt 1)
[18:22:16.800] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:22:16.800] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:22:16.801] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029153389767096208",
"parameters_json": "{\"builder_name\":\"win32-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"2b23491b8f3e10d177de607dafa83428b062a57a\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win32-official",
"scheduler_invocation_id:9029153389767096208",
"scheduler_job_id:chromium/win32-official",
"user_agent:luci-scheduler",
"buildset:commit/git/2b23491b8f3e10d177de607dafa83428b062a57a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2b23491b8f3e10d177de607dafa83428b062a57a",
"gitiles_ref:refs/heads/master"
]
}
[18:22:17.782] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605291736928197",
"id": "8863723327617228672",
"parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2b23491b8f3e10d177de607dafa83428b062a57a\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605291737470023",
"tags": [
"build_address:luci.chromium.ci/win32-official/930",
"builder:win32-official",
"buildset:commit/git/2b23491b8f3e10d177de607dafa83428b062a57a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2b23491b8f3e10d177de607dafa83428b062a57a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029153389767096208",
"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/8863723327617228672/+/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": "1605291737470400",
"url": "https://ci.chromium.org/b/8863723327617228672",
"utcnow_ts": "1605291737768773"
}
}
[18:22:17.782] Task URL: https://ci.chromium.org/b/8863723327617228672
[18:22:17.782] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:2:0) after 1m0s
[18:23:00.441] Received PubSub notification, asking Buildbucket for the build status
[18:23:00.561] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:17.893] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:2:0)
[18:23:17.896] Timer tick, asking Buildbucket for the build status
[18:23:18.668] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:18.668] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:4:0) after 1m0s
[18:24:18.697] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:4:0)
[18:24:18.697] Timer tick, asking Buildbucket for the build status
[18:24:18.828] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:18.828] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:5:0) after 1m0s
[18:25:18.854] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:5:0)
[18:25:18.854] Timer tick, asking Buildbucket for the build status
[18:25:18.961] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:18.961] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:6:0) after 1m0s
[18:26:19.079] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:6:0)
[18:26:19.080] Timer tick, asking Buildbucket for the build status
[18:26:19.215] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:19.216] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:7:0) after 1m0s
[18:27:19.328] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:7:0)
[18:27:19.328] Timer tick, asking Buildbucket for the build status
[18:27:19.446] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:19.446] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:8:0) after 1m0s
[18:28:19.533] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:8:0)
[18:28:19.533] Timer tick, asking Buildbucket for the build status
[18:28:19.672] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:19.672] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:9:0) after 1m0s
[18:29:19.773] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:9:0)
[18:29:19.773] Timer tick, asking Buildbucket for the build status
[18:29:19.858] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:19.858] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:10:0) after 1m0s
[18:30:19.916] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:10:0)
[18:30:19.916] Timer tick, asking Buildbucket for the build status
[18:30:20.313] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:20.313] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:11:0) after 1m0s
[18:31:20.355] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:11:0)
[18:31:20.355] Timer tick, asking Buildbucket for the build status
[18:31:20.648] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:20.648] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:12:0) after 1m0s
[18:32:20.746] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:12:0)
[18:32:20.746] Timer tick, asking Buildbucket for the build status
[18:32:20.849] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:20.849] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:13:0) after 1m0s
[18:33:20.872] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:13:0)
[18:33:20.872] Timer tick, asking Buildbucket for the build status
[18:33:21.028] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:21.028] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:14:0) after 1m0s
[18:34:21.810] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:14:0)
[18:34:21.810] Timer tick, asking Buildbucket for the build status
[18:34:21.962] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:21.962] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:15:0) after 1m0s
[18:35:22.250] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:15:0)
[18:35:22.250] Timer tick, asking Buildbucket for the build status
[18:35:22.527] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:22.527] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:16:0) after 1m0s
[18:36:22.617] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:16:0)
[18:36:22.617] Timer tick, asking Buildbucket for the build status
[18:36:22.689] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:22.689] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:17:0) after 1m0s
[18:37:22.744] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:17:0)
[18:37:22.744] Timer tick, asking Buildbucket for the build status
[18:37:22.875] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:22.875] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:18:0) after 1m0s
[18:38:22.987] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:18:0)
[18:38:22.987] Timer tick, asking Buildbucket for the build status
[18:38:23.055] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:23.055] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:19:0) after 1m0s
[18:39:23.336] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:19:0)
[18:39:23.336] Timer tick, asking Buildbucket for the build status
[18:39:23.404] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:23.404] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:20:0) after 1m0s
[18:40:23.715] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:20:0)
[18:40:23.715] Timer tick, asking Buildbucket for the build status
[18:40:23.865] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:23.865] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:21:0) after 1m0s
[18:41:23.948] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:21:0)
[18:41:23.948] Timer tick, asking Buildbucket for the build status
[18:41:24.073] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:24.073] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:22:0) after 1m0s
[18:42:24.129] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:22:0)
[18:42:24.129] Timer tick, asking Buildbucket for the build status
[18:42:24.241] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:24.241] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:23:0) after 1m0s
[18:43:24.336] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:23:0)
[18:43:24.336] Timer tick, asking Buildbucket for the build status
[18:43:24.456] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:24.456] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:24:0) after 1m0s
[18:44:24.464] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:24:0)
[18:44:24.464] Timer tick, asking Buildbucket for the build status
[18:44:24.578] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:24.578] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:25:0) after 1m0s
[18:45:24.631] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:25:0)
[18:45:24.631] Timer tick, asking Buildbucket for the build status
[18:45:24.963] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:24.963] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:26:0) after 1m0s
[18:46:25.016] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:26:0)
[18:46:25.016] Timer tick, asking Buildbucket for the build status
[18:46:25.115] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:25.115] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:27:0) after 1m0s
[18:47:25.180] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:27:0)
[18:47:25.180] Timer tick, asking Buildbucket for the build status
[18:47:25.442] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:25.442] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:28:0) after 1m0s
[18:48:25.484] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:28:0)
[18:48:25.484] Timer tick, asking Buildbucket for the build status
[18:48:25.751] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:25.751] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:29:0) after 1m0s
[18:49:25.800] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:29:0)
[18:49:25.800] Timer tick, asking Buildbucket for the build status
[18:49:25.939] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:25.939] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:30:0) after 1m0s
[18:50:25.966] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:30:0)
[18:50:25.966] Timer tick, asking Buildbucket for the build status
[18:50:26.062] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:26.062] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:31:0) after 1m0s
[18:51:26.217] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:31:0)
[18:51:26.217] Timer tick, asking Buildbucket for the build status
[18:51:26.277] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:26.277] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:32:0) after 1m0s
[18:52:26.415] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:32:0)
[18:52:26.415] Timer tick, asking Buildbucket for the build status
[18:52:27.027] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:27.027] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:33:0) after 1m0s
[18:53:27.043] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:33:0)
[18:53:27.043] Timer tick, asking Buildbucket for the build status
[18:53:27.130] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:27.130] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:34:0) after 1m0s
[18:54:27.226] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:34:0)
[18:54:27.226] Timer tick, asking Buildbucket for the build status
[18:54:27.680] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:27.680] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:35:0) after 1m0s
[18:55:27.781] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:35:0)
[18:55:27.781] Timer tick, asking Buildbucket for the build status
[18:55:28.103] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:28.103] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:36:0) after 1m0s
[18:56:28.142] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:36:0)
[18:56:28.142] Timer tick, asking Buildbucket for the build status
[18:56:28.252] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:28.252] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:37:0) after 1m0s
[18:57:28.392] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:37:0)
[18:57:28.392] Timer tick, asking Buildbucket for the build status
[18:57:28.984] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:28.984] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:38:0) after 1m0s
[18:58:29.016] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:38:0)
[18:58:29.016] Timer tick, asking Buildbucket for the build status
[18:58:29.522] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:29.522] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:39:0) after 1m0s
[18:59:29.855] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:39:0)
[18:59:29.856] Timer tick, asking Buildbucket for the build status
[18:59:29.944] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:29.944] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:40:0) after 1m0s
[19:00:30.027] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:40:0)
[19:00:30.027] Timer tick, asking Buildbucket for the build status
[19:00:30.534] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:30.534] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:41:0) after 1m0s
[19:01:30.567] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:41:0)
[19:01:30.567] Timer tick, asking Buildbucket for the build status
[19:01:30.652] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:30.652] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:42:0) after 1m0s
[19:02:30.687] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:42:0)
[19:02:30.687] Timer tick, asking Buildbucket for the build status
[19:02:30.817] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:30.817] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:43:0) after 1m0s
[19:03:30.874] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:43:0)
[19:03:30.874] Timer tick, asking Buildbucket for the build status
[19:03:31.047] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:31.047] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:44:0) after 1m0s
[19:04:31.101] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:44:0)
[19:04:31.101] Timer tick, asking Buildbucket for the build status
[19:04:31.177] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:31.177] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:45:0) after 1m0s
[19:05:31.307] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:45:0)
[19:05:31.307] Timer tick, asking Buildbucket for the build status
[19:05:31.529] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:31.529] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:46:0) after 1m0s
[19:06:31.532] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:46:0)
[19:06:31.532] Timer tick, asking Buildbucket for the build status
[19:06:31.598] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:31.598] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:47:0) after 1m0s
[19:07:31.694] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:47:0)
[19:07:31.694] Timer tick, asking Buildbucket for the build status
[19:07:31.823] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:31.823] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:48:0) after 1m0s
[19:08:31.859] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:48:0)
[19:08:31.859] Timer tick, asking Buildbucket for the build status
[19:08:32.138] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:32.138] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:49:0) after 1m0s
[19:09:32.334] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:49:0)
[19:09:32.334] Timer tick, asking Buildbucket for the build status
[19:09:35.654] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:35.654] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:50:0) after 1m0s
[19:10:35.814] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:50:0)
[19:10:35.814] Timer tick, asking Buildbucket for the build status
[19:10:35.880] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:35.880] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:51:0) after 1m0s
[19:11:35.951] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:51:0)
[19:11:35.951] Timer tick, asking Buildbucket for the build status
[19:11:36.031] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:36.031] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:52:0) after 1m0s
[19:12:36.067] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:52:0)
[19:12:36.067] Timer tick, asking Buildbucket for the build status
[19:12:36.174] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:36.174] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:53:0) after 1m0s
[19:13:36.240] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:53:0)
[19:13:36.240] Timer tick, asking Buildbucket for the build status
[19:13:36.305] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:36.305] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:54:0) after 1m0s
[19:14:36.384] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:54:0)
[19:14:36.384] Timer tick, asking Buildbucket for the build status
[19:14:36.477] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:36.477] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:55:0) after 1m0s
[19:15:36.507] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:55:0)
[19:15:36.507] Timer tick, asking Buildbucket for the build status
[19:15:36.739] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:36.739] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:56:0) after 1m0s
[19:16:36.841] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:56:0)
[19:16:36.841] Timer tick, asking Buildbucket for the build status
[19:16:36.905] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:36.905] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:57:0) after 1m0s
[19:17:36.938] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:57:0)
[19:17:36.938] Timer tick, asking Buildbucket for the build status
[19:17:37.407] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:37.407] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:58:0) after 1m0s
[19:18:37.395] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:58:0)
[19:18:37.395] Timer tick, asking Buildbucket for the build status
[19:18:37.454] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:37.454] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:59:0) after 1m0s
[19:19:37.526] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:59:0)
[19:19:37.526] Timer tick, asking Buildbucket for the build status
[19:19:39.071] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:39.071] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:60:0) after 1m0s
[19:20:39.223] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:60:0)
[19:20:39.223] Timer tick, asking Buildbucket for the build status
[19:20:54.188] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:54.188] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:61:0) after 1m0s
[19:21:54.280] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:61:0)
[19:21:54.280] Timer tick, asking Buildbucket for the build status
[19:21:54.365] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:54.365] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:62:0) after 1m0s
[19:22:54.385] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:62:0)
[19:22:54.385] Timer tick, asking Buildbucket for the build status
[19:22:54.531] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:54.531] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:63:0) after 1m0s
[19:23:54.554] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:63:0)
[19:23:54.554] Timer tick, asking Buildbucket for the build status
[19:23:54.641] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:54.641] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:64:0) after 1m0s
[19:24:54.786] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:64:0)
[19:24:54.786] Timer tick, asking Buildbucket for the build status
[19:24:54.854] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:54.854] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:65:0) after 1m0s
[19:25:54.954] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:65:0)
[19:25:54.954] Timer tick, asking Buildbucket for the build status
[19:25:55.054] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:55.054] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:66:0) after 1m0s
[19:26:55.114] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:66:0)
[19:26:55.114] Timer tick, asking Buildbucket for the build status
[19:26:55.396] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:55.396] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:67:0) after 1m0s
[19:27:55.424] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:67:0)
[19:27:55.424] Timer tick, asking Buildbucket for the build status
[19:27:55.533] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:55.533] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:68:0) after 1m0s
[19:28:56.620] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:68:0)
[19:28:56.620] Timer tick, asking Buildbucket for the build status
[19:28:56.713] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:56.713] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:69:0) after 1m0s
[19:29:57.037] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:69:0)
[19:29:57.037] Timer tick, asking Buildbucket for the build status
[19:29:57.106] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:57.106] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:70:0) after 1m0s
[19:30:57.259] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:70:0)
[19:30:57.259] Timer tick, asking Buildbucket for the build status
[19:30:57.339] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:57.339] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:71:0) after 1m0s
[19:31:57.569] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:71:0)
[19:31:57.569] Timer tick, asking Buildbucket for the build status
[19:31:57.625] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:57.625] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:72:0) after 1m0s
[19:32:57.830] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:72:0)
[19:32:57.830] Timer tick, asking Buildbucket for the build status
[19:32:58.002] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:58.002] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:73:0) after 1m0s
[19:33:58.053] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:73:0)
[19:33:58.053] Timer tick, asking Buildbucket for the build status
[19:33:58.677] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:58.677] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:74:0) after 1m0s
[19:34:58.883] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:74:0)
[19:34:58.883] Timer tick, asking Buildbucket for the build status
[19:34:58.982] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:58.982] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:75:0) after 1m0s
[19:35:59.110] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:75:0)
[19:35:59.110] Timer tick, asking Buildbucket for the build status
[19:35:59.187] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:59.187] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:76:0) after 1m0s
[19:36:59.292] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:76:0)
[19:36:59.292] Timer tick, asking Buildbucket for the build status
[19:36:59.369] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:59.369] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:77:0) after 1m0s
[19:37:59.429] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:77:0)
[19:37:59.429] Timer tick, asking Buildbucket for the build status
[19:37:59.539] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:59.539] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:78:0) after 1m0s
[19:38:59.584] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:78:0)
[19:38:59.584] Timer tick, asking Buildbucket for the build status
[19:38:59.669] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:59.669] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:79:0) after 1m0s
[19:39:59.829] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:79:0)
[19:39:59.829] Timer tick, asking Buildbucket for the build status
[19:39:59.934] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:59.934] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:80:0) after 1m0s
[19:41:00.016] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:80:0)
[19:41:00.016] Timer tick, asking Buildbucket for the build status
[19:41:00.352] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:00.352] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:81:0) after 1m0s
[19:42:00.420] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:81:0)
[19:42:00.420] Timer tick, asking Buildbucket for the build status
[19:42:01.001] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:01.001] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:82:0) after 1m0s
[19:43:02.281] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:82:0)
[19:43:02.281] Timer tick, asking Buildbucket for the build status
[19:43:03.139] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:03.139] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:83:0) after 1m0s
[19:44:03.153] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:83:0)
[19:44:03.153] Timer tick, asking Buildbucket for the build status
[19:44:03.637] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:03.637] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:84:0) after 1m0s
[19:45:03.692] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:84:0)
[19:45:03.692] Timer tick, asking Buildbucket for the build status
[19:45:03.791] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:03.791] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:85:0) after 1m0s
[19:46:03.980] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:85:0)
[19:46:03.980] Timer tick, asking Buildbucket for the build status
[19:46:04.420] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:04.420] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:86:0) after 1m0s
[19:47:04.524] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:86:0)
[19:47:04.524] Timer tick, asking Buildbucket for the build status
[19:47:04.670] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:04.670] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:87:0) after 1m0s
[19:48:04.711] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:87:0)
[19:48:04.712] Timer tick, asking Buildbucket for the build status
[19:48:04.917] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:04.917] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:88:0) after 1m0s
[19:49:05.015] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:88:0)
[19:49:05.015] Timer tick, asking Buildbucket for the build status
[19:49:05.104] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:05.104] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:89:0) after 1m0s
[19:50:05.153] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:89:0)
[19:50:05.153] Timer tick, asking Buildbucket for the build status
[19:50:05.239] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:05.239] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:90:0) after 1m0s
[19:51:05.299] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:90:0)
[19:51:05.299] Timer tick, asking Buildbucket for the build status
[19:51:05.590] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:05.590] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:91:0) after 1m0s
[19:52:05.764] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:91:0)
[19:52:05.764] Timer tick, asking Buildbucket for the build status
[19:52:06.009] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:06.009] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:92:0) after 1m0s
[19:53:06.087] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:92:0)
[19:53:06.087] Timer tick, asking Buildbucket for the build status
[19:53:06.289] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:06.289] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:93:0) after 1m0s
[19:54:06.429] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:93:0)
[19:54:06.429] Timer tick, asking Buildbucket for the build status
[19:54:06.509] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:06.509] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:94:0) after 1m0s
[19:55:06.557] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:94:0)
[19:55:06.557] Timer tick, asking Buildbucket for the build status
[19:55:06.621] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:06.621] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:95:0) after 1m0s
[19:56:06.655] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:95:0)
[19:56:06.655] Timer tick, asking Buildbucket for the build status
[19:56:06.880] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:06.880] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:96:0) after 1m0s
[19:57:06.933] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:96:0)
[19:57:06.933] Timer tick, asking Buildbucket for the build status
[19:57:06.986] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:06.986] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:97:0) after 1m0s
[19:58:07.167] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:97:0)
[19:58:07.167] Timer tick, asking Buildbucket for the build status
[19:58:08.121] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:08.121] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:98:0) after 1m0s
[19:59:08.145] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:98:0)
[19:59:08.145] Timer tick, asking Buildbucket for the build status
[19:59:08.335] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:08.335] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:99:0) after 1m0s
[20:00:08.387] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:99:0)
[20:00:08.387] Timer tick, asking Buildbucket for the build status
[20:00:08.467] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:08.468] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:100:0) after 1m0s
[20:01:09.390] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:100:0)
[20:01:09.390] Timer tick, asking Buildbucket for the build status
[20:01:12.470] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:12.470] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:101:0) after 1m0s
[20:02:12.874] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:101:0)
[20:02:12.874] Timer tick, asking Buildbucket for the build status
[20:02:12.963] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:12.963] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:102:0) after 1m0s
[20:03:13.266] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:102:0)
[20:03:13.266] Timer tick, asking Buildbucket for the build status
[20:03:14.272] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:14.272] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:103:0) after 1m0s
[20:04:14.341] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:103:0)
[20:04:14.341] Timer tick, asking Buildbucket for the build status
[20:04:14.406] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:14.406] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:104:0) after 1m0s
[20:05:14.570] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:104:0)
[20:05:14.570] Timer tick, asking Buildbucket for the build status
[20:05:14.639] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:14.639] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:105:0) after 1m0s
[20:06:14.733] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:105:0)
[20:06:14.733] Timer tick, asking Buildbucket for the build status
[20:06:14.921] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:14.921] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:106:0) after 1m0s
[20:07:14.972] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:106:0)
[20:07:14.972] Timer tick, asking Buildbucket for the build status
[20:07:15.067] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:15.067] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:107:0) after 1m0s
[20:08:15.093] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:107:0)
[20:08:15.093] Timer tick, asking Buildbucket for the build status
[20:08:15.702] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:15.702] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:108:0) after 1m0s
[20:09:15.762] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:108:0)
[20:09:15.762] Timer tick, asking Buildbucket for the build status
[20:09:15.828] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:15.828] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:109:0) after 1m0s
[20:10:15.892] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:109:0)
[20:10:15.892] Timer tick, asking Buildbucket for the build status
[20:10:16.467] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:16.467] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:110:0) after 1m0s
[20:11:16.555] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:110:0)
[20:11:16.555] Timer tick, asking Buildbucket for the build status
[20:11:16.627] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:16.627] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:111:0) after 1m0s
[20:12:16.711] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:111:0)
[20:12:16.711] Timer tick, asking Buildbucket for the build status
[20:12:16.814] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:16.814] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:112:0) after 1m0s
[20:13:16.828] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:112:0)
[20:13:16.828] Timer tick, asking Buildbucket for the build status
[20:13:16.966] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:16.966] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:113:0) after 1m0s
[20:14:17.044] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:113:0)
[20:14:17.044] Timer tick, asking Buildbucket for the build status
[20:14:17.803] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:17.803] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:114:0) after 1m0s
[20:15:17.837] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:114:0)
[20:15:17.837] Timer tick, asking Buildbucket for the build status
[20:15:17.916] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:17.916] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:115:0) after 1m0s
[20:16:17.996] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:115:0)
[20:16:17.996] Timer tick, asking Buildbucket for the build status
[20:16:19.122] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:19.122] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:116:0) after 1m0s
[20:17:19.163] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:116:0)
[20:17:19.163] Timer tick, asking Buildbucket for the build status
[20:17:19.249] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:19.249] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:117:0) after 1m0s
[20:18:19.358] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:117:0)
[20:18:19.358] Timer tick, asking Buildbucket for the build status
[20:18:19.499] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:19.499] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:118:0) after 1m0s
[20:19:19.987] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:118:0)
[20:19:19.987] Timer tick, asking Buildbucket for the build status
[20:19:20.056] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:20.056] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:119:0) after 1m0s
[20:20:20.500] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:119:0)
[20:20:20.500] Timer tick, asking Buildbucket for the build status
[20:20:20.624] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:20.624] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:120:0) after 1m0s
[20:21:20.820] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:120:0)
[20:21:20.820] Timer tick, asking Buildbucket for the build status
[20:21:20.942] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:20.942] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:121:0) after 1m0s
[20:22:21.134] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:121:0)
[20:22:21.134] Timer tick, asking Buildbucket for the build status
[20:22:21.221] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:21.221] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:122:0) after 1m0s
[20:23:21.393] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:122:0)
[20:23:21.393] Timer tick, asking Buildbucket for the build status
[20:23:21.658] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:21.658] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:123:0) after 1m0s
[20:24:21.815] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:123:0)
[20:24:21.815] Timer tick, asking Buildbucket for the build status
[20:24:22.211] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:22.211] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:124:0) after 1m0s
[20:25:22.316] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:124:0)
[20:25:22.316] Timer tick, asking Buildbucket for the build status
[20:25:22.438] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:22.438] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:125:0) after 1m0s
[20:26:22.532] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:125:0)
[20:26:22.532] Timer tick, asking Buildbucket for the build status
[20:26:22.623] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:22.623] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:126:0) after 1m0s
[20:27:22.762] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:126:0)
[20:27:22.762] Timer tick, asking Buildbucket for the build status
[20:27:23.058] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:23.058] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:127:0) after 1m0s
[20:28:23.170] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:127:0)
[20:28:23.170] Timer tick, asking Buildbucket for the build status
[20:28:23.723] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:23.724] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:128:0) after 1m0s
[20:29:23.732] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:128:0)
[20:29:23.732] Timer tick, asking Buildbucket for the build status
[20:29:23.818] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:23.818] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:129:0) after 1m0s
[20:30:23.922] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:129:0)
[20:30:23.922] Timer tick, asking Buildbucket for the build status
[20:30:23.992] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:23.992] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:130:0) after 1m0s
[20:31:24.131] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:130:0)
[20:31:24.131] Timer tick, asking Buildbucket for the build status
[20:31:24.199] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:24.199] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:131:0) after 1m0s
[20:32:24.222] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:131:0)
[20:32:24.222] Timer tick, asking Buildbucket for the build status
[20:32:24.297] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:24.297] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:132:0) after 1m0s
[20:33:24.355] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:132:0)
[20:33:24.355] Timer tick, asking Buildbucket for the build status
[20:33:24.498] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:24.498] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:133:0) after 1m0s
[20:34:24.576] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:133:0)
[20:34:24.576] Timer tick, asking Buildbucket for the build status
[20:34:25.039] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:25.039] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:134:0) after 1m0s
[20:35:25.046] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:134:0)
[20:35:25.046] Timer tick, asking Buildbucket for the build status
[20:35:25.128] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:25.128] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:135:0) after 1m0s
[20:36:25.200] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:135:0)
[20:36:25.200] Timer tick, asking Buildbucket for the build status
[20:36:25.278] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:25.278] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:136:0) after 1m0s
[20:37:25.390] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:136:0)
[20:37:25.390] Timer tick, asking Buildbucket for the build status
[20:37:27.129] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:27.129] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:137:0) after 1m0s
[20:38:27.245] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:137:0)
[20:38:27.245] Timer tick, asking Buildbucket for the build status
[20:38:27.375] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:27.375] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:138:0) after 1m0s
[20:39:27.437] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:138:0)
[20:39:27.437] Timer tick, asking Buildbucket for the build status
[20:39:27.851] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:27.851] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:139:0) after 1m0s
[20:40:27.908] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:139:0)
[20:40:27.908] Timer tick, asking Buildbucket for the build status
[20:40:28.019] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:28.019] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:140:0) after 1m0s
[20:41:28.138] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:140:0)
[20:41:28.138] Timer tick, asking Buildbucket for the build status
[20:41:28.474] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:28.474] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:141:0) after 1m0s
[20:42:28.574] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:141:0)
[20:42:28.574] Timer tick, asking Buildbucket for the build status
[20:42:28.639] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:28.639] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:142:0) after 1m0s
[20:43:28.687] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:142:0)
[20:43:28.687] Timer tick, asking Buildbucket for the build status
[20:43:30.511] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:30.511] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:143:0) after 1m0s
[20:44:30.610] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:143:0)
[20:44:30.610] Timer tick, asking Buildbucket for the build status
[20:44:30.886] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:30.887] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:144:0) after 1m0s
[20:45:30.948] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:144:0)
[20:45:30.948] Timer tick, asking Buildbucket for the build status
[20:45:31.194] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:31.194] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:145:0) after 1m0s
[20:46:31.287] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:145:0)
[20:46:31.287] Timer tick, asking Buildbucket for the build status
[20:46:31.408] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:31.408] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:146:0) after 1m0s
[20:47:31.504] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:146:0)
[20:47:31.504] Timer tick, asking Buildbucket for the build status
[20:47:31.840] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:31.840] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:147:0) after 1m0s
[20:48:31.861] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:147:0)
[20:48:31.861] Timer tick, asking Buildbucket for the build status
[20:48:31.984] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:31.984] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:148:0) after 1m0s
[20:49:32.114] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:148:0)
[20:49:32.114] Timer tick, asking Buildbucket for the build status
[20:49:32.318] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:32.318] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:149:0) after 1m0s
[20:50:32.540] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:149:0)
[20:50:32.540] Timer tick, asking Buildbucket for the build status
[20:50:32.611] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:32.611] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:150:0) after 1m0s
[20:51:32.779] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:150:0)
[20:51:32.779] Timer tick, asking Buildbucket for the build status
[20:51:32.893] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:32.893] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:151:0) after 1m0s
[20:52:33.199] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:151:0)
[20:52:33.199] Timer tick, asking Buildbucket for the build status
[20:52:33.281] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:33.281] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:152:0) after 1m0s
[20:53:33.409] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:152:0)
[20:53:33.409] Timer tick, asking Buildbucket for the build status
[20:53:33.531] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:33.531] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:153:0) after 1m0s
[20:54:33.619] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:153:0)
[20:54:33.619] Timer tick, asking Buildbucket for the build status
[20:54:33.692] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:33.692] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:154:0) after 1m0s
[20:55:33.854] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:154:0)
[20:55:33.854] Timer tick, asking Buildbucket for the build status
[20:55:34.013] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:34.013] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:155:0) after 1m0s
[20:56:34.115] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:155:0)
[20:56:34.115] Timer tick, asking Buildbucket for the build status
[20:56:34.226] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:34.226] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:156:0) after 1m0s
[20:57:34.341] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:156:0)
[20:57:34.342] Timer tick, asking Buildbucket for the build status
[20:57:34.428] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:34.428] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:157:0) after 1m0s
[20:58:34.558] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:157:0)
[20:58:34.558] Timer tick, asking Buildbucket for the build status
[20:58:35.306] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:35.306] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:158:0) after 1m0s
[20:59:35.465] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:158:0)
[20:59:35.465] Timer tick, asking Buildbucket for the build status
[20:59:35.542] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:35.542] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:159:0) after 1m0s
[21:00:35.699] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:159:0)
[21:00:35.699] Timer tick, asking Buildbucket for the build status
[21:00:35.788] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:35.788] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:160:0) after 1m0s
[21:01:35.882] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:160:0)
[21:01:35.882] Timer tick, asking Buildbucket for the build status
[21:01:36.032] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:36.032] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:161:0) after 1m0s
[21:02:36.208] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:161:0)
[21:02:36.208] Timer tick, asking Buildbucket for the build status
[21:02:37.138] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:37.138] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:162:0) after 1m0s
[21:03:37.180] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:162:0)
[21:03:37.180] Timer tick, asking Buildbucket for the build status
[21:03:37.495] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:37.496] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:163:0) after 1m0s
[21:04:37.609] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:163:0)
[21:04:37.609] Timer tick, asking Buildbucket for the build status
[21:04:37.892] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:37.892] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:164:0) after 1m0s
[21:05:37.996] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:164:0)
[21:05:37.996] Timer tick, asking Buildbucket for the build status
[21:05:38.074] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:38.074] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:165:0) after 1m0s
[21:06:38.168] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:165:0)
[21:06:38.168] Timer tick, asking Buildbucket for the build status
[21:06:38.237] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:38.237] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:166:0) after 1m0s
[21:07:38.298] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:166:0)
[21:07:38.298] Timer tick, asking Buildbucket for the build status
[21:07:38.369] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:38.369] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:167:0) after 1m0s
[21:08:38.461] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:167:0)
[21:08:38.461] Timer tick, asking Buildbucket for the build status
[21:08:38.584] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:38.584] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:168:0) after 1m0s
[21:09:38.674] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:168:0)
[21:09:38.674] Timer tick, asking Buildbucket for the build status
[21:09:38.813] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:38.813] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:169:0) after 1m0s
[21:10:39.096] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:169:0)
[21:10:39.096] Timer tick, asking Buildbucket for the build status
[21:10:39.525] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:39.525] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:170:0) after 1m0s
[21:11:39.926] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:170:0)
[21:11:39.926] Timer tick, asking Buildbucket for the build status
[21:11:40.125] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:40.125] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:171:0) after 1m0s
[21:12:40.201] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:171:0)
[21:12:40.201] Timer tick, asking Buildbucket for the build status
[21:12:40.307] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:40.307] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:172:0) after 1m0s
[21:13:40.408] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:172:0)
[21:13:40.408] Timer tick, asking Buildbucket for the build status
[21:13:40.587] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:40.587] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:173:0) after 1m0s
[21:14:40.688] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:173:0)
[21:14:40.688] Timer tick, asking Buildbucket for the build status
[21:14:40.770] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:40.770] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:174:0) after 1m0s
[21:15:40.958] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:174:0)
[21:15:40.958] Timer tick, asking Buildbucket for the build status
[21:15:41.035] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:41.035] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:175:0) after 1m0s
[21:16:41.300] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:175:0)
[21:16:41.300] Timer tick, asking Buildbucket for the build status
[21:16:41.368] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:41.368] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:176:0) after 1m0s
[21:17:41.511] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:176:0)
[21:17:41.511] Timer tick, asking Buildbucket for the build status
[21:17:41.644] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:41.644] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:177:0) after 1m0s
[21:18:41.805] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:177:0)
[21:18:41.805] Timer tick, asking Buildbucket for the build status
[21:18:41.903] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:41.904] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:178:0) after 1m0s
[21:19:42.011] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:178:0)
[21:19:42.011] Timer tick, asking Buildbucket for the build status
[21:19:42.211] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:42.211] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:179:0) after 1m0s
[21:20:42.230] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:179:0)
[21:20:42.230] Timer tick, asking Buildbucket for the build status
[21:20:42.634] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:42.634] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:180:0) after 1m0s
[21:21:42.714] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:180:0)
[21:21:42.714] Timer tick, asking Buildbucket for the build status
[21:21:42.834] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:42.834] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:181:0) after 1m0s
[21:22:42.856] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:181:0)
[21:22:42.856] Timer tick, asking Buildbucket for the build status
[21:22:43.089] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:43.089] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:182:0) after 1m0s
[21:23:43.198] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:182:0)
[21:23:43.198] Timer tick, asking Buildbucket for the build status
[21:23:43.447] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:43.447] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:183:0) after 1m0s
[21:24:43.580] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:183:0)
[21:24:43.580] Timer tick, asking Buildbucket for the build status
[21:24:43.976] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:43.976] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:184:0) after 1m0s
[21:25:44.162] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:184:0)
[21:25:44.162] Timer tick, asking Buildbucket for the build status
[21:25:44.229] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:44.229] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:185:0) after 1m0s
[21:26:44.304] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:185:0)
[21:26:44.304] Timer tick, asking Buildbucket for the build status
[21:26:44.621] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:44.621] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:186:0) after 1m0s
[21:27:44.748] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:186:0)
[21:27:44.748] Timer tick, asking Buildbucket for the build status
[21:27:45.183] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:45.183] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:187:0) after 1m0s
[21:28:45.436] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:187:0)
[21:28:45.436] Timer tick, asking Buildbucket for the build status
[21:28:45.513] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:45.513] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:188:0) after 1m0s
[21:29:45.539] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:188:0)
[21:29:45.539] Timer tick, asking Buildbucket for the build status
[21:29:45.635] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:45.635] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:189:0) after 1m0s
[21:30:45.683] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:189:0)
[21:30:45.683] Timer tick, asking Buildbucket for the build status
[21:30:45.762] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:45.762] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:190:0) after 1m0s
[21:31:45.750] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:190:0)
[21:31:45.750] Timer tick, asking Buildbucket for the build status
[21:31:45.843] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:45.843] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:191:0) after 1m0s
[21:32:45.868] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:191:0)
[21:32:45.868] Timer tick, asking Buildbucket for the build status
[21:32:45.988] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:45.988] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:192:0) after 1m0s
[21:33:45.991] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:192:0)
[21:33:45.991] Timer tick, asking Buildbucket for the build status
[21:33:46.115] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:46.115] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:193:0) after 1m0s
[21:34:46.176] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:193:0)
[21:34:46.176] Timer tick, asking Buildbucket for the build status
[21:34:46.235] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:46.235] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:194:0) after 1m0s
[21:35:46.366] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:194:0)
[21:35:46.366] Timer tick, asking Buildbucket for the build status
[21:35:46.453] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:46.453] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:195:0) after 1m0s
[21:36:46.598] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:195:0)
[21:36:46.598] Timer tick, asking Buildbucket for the build status
[21:36:46.806] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:46.806] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:196:0) after 1m0s
[21:37:46.895] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:196:0)
[21:37:46.895] Timer tick, asking Buildbucket for the build status
[21:37:47.112] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:47.112] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:197:0) after 1m0s
[21:38:47.177] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:197:0)
[21:38:47.177] Timer tick, asking Buildbucket for the build status
[21:38:47.252] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:47.252] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:198:0) after 1m0s
[21:39:47.289] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:198:0)
[21:39:47.289] Timer tick, asking Buildbucket for the build status
[21:39:47.406] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:47.407] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:199:0) after 1m0s
[21:40:47.443] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:199:0)
[21:40:47.443] Timer tick, asking Buildbucket for the build status
[21:40:47.584] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:47.584] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:200:0) after 1m0s
[21:41:47.606] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:200:0)
[21:41:47.606] Timer tick, asking Buildbucket for the build status
[21:41:47.748] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:47.748] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:201:0) after 1m0s
[21:42:47.806] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:201:0)
[21:42:47.806] Timer tick, asking Buildbucket for the build status
[21:42:47.956] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:47.956] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:202:0) after 1m0s
[21:43:48.023] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:202:0)
[21:43:48.023] Timer tick, asking Buildbucket for the build status
[21:43:48.307] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:48.307] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:203:0) after 1m0s
[21:44:48.339] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:203:0)
[21:44:48.339] Timer tick, asking Buildbucket for the build status
[21:44:48.731] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:48.731] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:204:0) after 1m0s
[21:45:48.903] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:204:0)
[21:45:48.903] Timer tick, asking Buildbucket for the build status
[21:45:48.966] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:48.966] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:205:0) after 1m0s
[21:46:49.015] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:205:0)
[21:46:49.015] Timer tick, asking Buildbucket for the build status
[21:46:49.287] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:49.287] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:206:0) after 1m0s
[21:47:49.416] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:206:0)
[21:47:49.416] Timer tick, asking Buildbucket for the build status
[21:47:49.642] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:49.642] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:207:0) after 1m0s
[21:48:49.747] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:207:0)
[21:48:49.747] Timer tick, asking Buildbucket for the build status
[21:48:49.896] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:49.896] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:208:0) after 1m0s
[21:49:49.985] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:208:0)
[21:49:49.985] Timer tick, asking Buildbucket for the build status
[21:49:50.255] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:50.255] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:209:0) after 1m0s
[21:50:50.281] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:209:0)
[21:50:50.281] Timer tick, asking Buildbucket for the build status
[21:50:50.364] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:50.364] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:210:0) after 1m0s
[21:51:50.497] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:210:0)
[21:51:50.497] Timer tick, asking Buildbucket for the build status
[21:51:50.566] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:50.566] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:211:0) after 1m0s
[21:52:50.654] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:211:0)
[21:52:50.654] Timer tick, asking Buildbucket for the build status
[21:52:51.031] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:51.031] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:212:0) after 1m0s
[21:53:51.024] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:212:0)
[21:53:51.024] Timer tick, asking Buildbucket for the build status
[21:53:52.175] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:52.175] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:213:0) after 1m0s
[21:54:52.249] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:213:0)
[21:54:52.249] Timer tick, asking Buildbucket for the build status
[21:54:52.914] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:52.914] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:214:0) after 1m0s
[21:55:53.068] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:214:0)
[21:55:53.068] Timer tick, asking Buildbucket for the build status
[21:55:53.199] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:53.199] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:215:0) after 1m0s
[21:56:53.351] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:215:0)
[21:56:53.351] Timer tick, asking Buildbucket for the build status
[21:56:53.438] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:53.438] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:216:0) after 1m0s
[21:57:53.525] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:216:0)
[21:57:53.525] Timer tick, asking Buildbucket for the build status
[21:57:53.678] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:53.678] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:217:0) after 1m0s
[21:58:53.729] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:217:0)
[21:58:53.729] Timer tick, asking Buildbucket for the build status
[21:58:53.801] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:53.801] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:218:0) after 1m0s
[21:59:53.916] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:218:0)
[21:59:53.916] Timer tick, asking Buildbucket for the build status
[21:59:54.193] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:54.193] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:219:0) after 1m0s
[22:00:54.323] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:219:0)
[22:00:54.324] Timer tick, asking Buildbucket for the build status
[22:00:54.437] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:54.437] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:220:0) after 1m0s
[22:01:54.535] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:220:0)
[22:01:54.535] Timer tick, asking Buildbucket for the build status
[22:01:54.645] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:54.645] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:221:0) after 1m0s
[22:02:54.806] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:221:0)
[22:02:54.806] Timer tick, asking Buildbucket for the build status
[22:02:55.693] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:55.693] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:222:0) after 1m0s
[22:03:55.742] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:222:0)
[22:03:55.742] Timer tick, asking Buildbucket for the build status
[22:03:55.808] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:55.808] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:223:0) after 1m0s
[22:04:55.914] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:223:0)
[22:04:55.914] Timer tick, asking Buildbucket for the build status
[22:04:55.988] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:55.988] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:224:0) after 1m0s
[22:05:56.196] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:224:0)
[22:05:56.196] Timer tick, asking Buildbucket for the build status
[22:05:56.261] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:56.261] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:225:0) after 1m0s
[22:06:56.373] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:225:0)
[22:06:56.373] Timer tick, asking Buildbucket for the build status
[22:06:56.441] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:56.441] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:226:0) after 1m0s
[22:07:56.520] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:226:0)
[22:07:56.520] Timer tick, asking Buildbucket for the build status
[22:07:56.628] Build 8863723327617228672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:56.628] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9029153389767096208:227:0) after 1m0s
[22:08:08.551] Received PubSub notification, asking Buildbucket for the build status
[22:08:08.952] Build 8863723327617228672: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:08:08.952] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605305287555336",
"created_by": "project:chromium",
"created_ts": "1605291736928197",
"id": "8863723327617228672",
"parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2b23491b8f3e10d177de607dafa83428b062a57a\"}}",
"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\": \"2b23491b8f3e10d177de607dafa83428b062a57a\", \"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-2-scf4\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win32-official\", \"buildnumber\": 930, \"got_angle_revision\": \"c43088c6dc01658d86792e0d33925790c30afdcb\", \"got_dawn_revision\": \"b6f4d53126d3f0ad522df5fc77da4ac919ea43f6\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"2b23491b8f3e10d177de607dafa83428b062a57a\", \"got_revision_cp\": \"refs/heads/master@{#827330}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"e4c1a25cc6797a47043fc415c53b8edcd7b3e37e\", \"got_v8_revision\": \"2dbcdc105b963ee2501c82139eef7e0603977ff0\", \"got_v8_revision_cp\": \"refs/heads/8.8.278@{#1}\", \"got_webrtc_revision\": \"bee6408d7b671199206bbf3b27a6d52ad906532e\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32603}\", \"mirrored_builders\": [\"tryserver.chromium:win32-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2b23491b8f3e10d177de607dafa83428b062a57a\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_f6b49936a2965b3cdad8f63ce13313d0c4b82119a9acfffbfe199e91c26d0c88_v2\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-2-scf4\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5626-39642e9\"], \"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": "1605291778491441",
"status": "COMPLETED",
"status_changed_ts": "1605305288118877",
"tags": [
"build_address:luci.chromium.ci/win32-official/930",
"builder:win32-official",
"buildset:commit/git/2b23491b8f3e10d177de607dafa83428b062a57a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2b23491b8f3e10d177de607dafa83428b062a57a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029153389767096208",
"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/8863723327617228672/+/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:4fdba9921b782910",
"user_agent:luci-scheduler"
],
"updated_ts": "1605305288207229",
"url": "https://ci.chromium.org/b/8863723327617228672",
"utcnow_ts": "1605305288876321"
}
}
[22:08:08.952] Invocation finished in 3h45m53.457889573s with status SUCCEEDED