[04:35:09.135] New invocation is queued and will start shortly
[04:35:10.335] Starting the invocation (attempt 1)
[04:35:10.381] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:35:10.381] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:35:10.381] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020598714986256448",
"parameters_json": "{\"builder_name\":\"win32-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"7e66d589d63c7716729886a37d479d3401d3a7e9\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win32-official",
"scheduler_invocation_id:9020598714986256448",
"scheduler_job_id:chromium/win32-official",
"user_agent:luci-scheduler",
"buildset:commit/git/7e66d589d63c7716729886a37d479d3401d3a7e9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7e66d589d63c7716729886a37d479d3401d3a7e9",
"gitiles_ref:refs/heads/master"
]
}
[04:35:11.781] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613450110481184",
"id": "8855168652910889888",
"parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7e66d589d63c7716729886a37d479d3401d3a7e9\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613450111488166",
"tags": [
"build_address:luci.chromium.ci/win32-official/1557",
"builder:win32-official",
"buildset:commit/git/7e66d589d63c7716729886a37d479d3401d3a7e9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7e66d589d63c7716729886a37d479d3401d3a7e9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020598714986256448",
"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/8855168652910889888/+/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": "1613450111488307",
"url": "https://ci.chromium.org/b/8855168652910889888",
"utcnow_ts": "1613450111744860"
}
}
[04:35:11.781] Task URL: https://ci.chromium.org/b/8855168652910889888
[04:35:11.781] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:2:0) after 1m0s
[04:35:20.765] Received PubSub notification, asking Buildbucket for the build status
[04:35:20.852] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:11.815] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:2:0)
[04:36:11.815] Timer tick, asking Buildbucket for the build status
[04:36:11.917] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:11.917] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:4:0) after 1m0s
[04:37:11.987] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:4:0)
[04:37:11.987] Timer tick, asking Buildbucket for the build status
[04:37:12.244] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:12.244] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:5:0) after 1m0s
[04:38:12.325] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:5:0)
[04:38:12.325] Timer tick, asking Buildbucket for the build status
[04:38:12.397] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:12.397] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:6:0) after 1m0s
[04:39:12.446] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:6:0)
[04:39:12.446] Timer tick, asking Buildbucket for the build status
[04:39:12.520] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:12.520] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:7:0) after 1m0s
[04:40:12.689] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:7:0)
[04:40:12.689] Timer tick, asking Buildbucket for the build status
[04:40:12.797] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:12.797] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:8:0) after 1m0s
[04:41:12.844] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:8:0)
[04:41:12.844] Timer tick, asking Buildbucket for the build status
[04:41:12.929] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:12.929] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:9:0) after 1m0s
[04:42:12.949] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:9:0)
[04:42:12.949] Timer tick, asking Buildbucket for the build status
[04:42:13.029] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:13.029] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:10:0) after 1m0s
[04:43:13.050] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:10:0)
[04:43:13.050] Timer tick, asking Buildbucket for the build status
[04:43:13.132] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:13.132] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:11:0) after 1m0s
[04:44:13.227] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:11:0)
[04:44:13.227] Timer tick, asking Buildbucket for the build status
[04:44:13.444] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:13.444] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:12:0) after 1m0s
[04:45:13.459] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:12:0)
[04:45:13.459] Timer tick, asking Buildbucket for the build status
[04:45:13.825] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:13.826] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:13:0) after 1m0s
[04:46:13.869] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:13:0)
[04:46:13.870] Timer tick, asking Buildbucket for the build status
[04:46:14.165] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:14.165] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:14:0) after 1m0s
[04:47:14.220] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:14:0)
[04:47:14.220] Timer tick, asking Buildbucket for the build status
[04:47:15.294] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:15.294] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:15:0) after 1m0s
[04:48:15.374] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:15:0)
[04:48:15.374] Timer tick, asking Buildbucket for the build status
[04:48:15.444] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:15.444] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:16:0) after 1m0s
[04:49:15.450] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:16:0)
[04:49:15.450] Timer tick, asking Buildbucket for the build status
[04:49:15.521] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:15.521] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:17:0) after 1m0s
[04:50:15.544] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:17:0)
[04:50:15.544] Timer tick, asking Buildbucket for the build status
[04:50:15.667] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:15.668] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:18:0) after 1m0s
[04:51:15.664] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:18:0)
[04:51:15.664] Timer tick, asking Buildbucket for the build status
[04:51:15.745] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:15.745] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:19:0) after 1m0s
[04:52:15.823] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:19:0)
[04:52:15.824] Timer tick, asking Buildbucket for the build status
[04:52:15.893] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:15.893] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:20:0) after 1m0s
[04:53:15.890] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:20:0)
[04:53:15.890] Timer tick, asking Buildbucket for the build status
[04:53:16.049] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:16.049] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:21:0) after 1m0s
[04:54:16.067] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:21:0)
[04:54:16.067] Timer tick, asking Buildbucket for the build status
[04:54:16.203] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:16.203] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:22:0) after 1m0s
[04:55:16.268] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:22:0)
[04:55:16.268] Timer tick, asking Buildbucket for the build status
[04:55:16.351] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:16.351] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:23:0) after 1m0s
[04:56:16.369] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:23:0)
[04:56:16.369] Timer tick, asking Buildbucket for the build status
[04:56:16.510] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:16.510] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:24:0) after 1m0s
[04:57:16.529] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:24:0)
[04:57:16.529] Timer tick, asking Buildbucket for the build status
[04:57:16.623] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:16.623] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:25:0) after 1m0s
[04:58:16.645] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:25:0)
[04:58:16.645] Timer tick, asking Buildbucket for the build status
[04:58:16.749] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:16.749] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:26:0) after 1m0s
[04:59:16.794] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:26:0)
[04:59:16.794] Timer tick, asking Buildbucket for the build status
[04:59:17.070] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:17.070] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:27:0) after 1m0s
[05:00:17.087] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:27:0)
[05:00:17.087] Timer tick, asking Buildbucket for the build status
[05:00:17.326] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:17.326] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:28:0) after 1m0s
[05:01:17.322] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:28:0)
[05:01:17.322] Timer tick, asking Buildbucket for the build status
[05:01:17.437] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:17.437] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:29:0) after 1m0s
[05:02:17.449] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:29:0)
[05:02:17.449] Timer tick, asking Buildbucket for the build status
[05:02:17.535] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:17.535] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:30:0) after 1m0s
[05:03:17.575] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:30:0)
[05:03:17.575] Timer tick, asking Buildbucket for the build status
[05:03:17.676] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:17.676] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:31:0) after 1m0s
[05:04:17.682] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:31:0)
[05:04:17.682] Timer tick, asking Buildbucket for the build status
[05:04:17.763] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:17.763] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:32:0) after 1m0s
[05:05:17.866] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:32:0)
[05:05:17.866] Timer tick, asking Buildbucket for the build status
[05:05:18.015] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:18.015] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:33:0) after 1m0s
[05:06:18.076] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:33:0)
[05:06:18.076] Timer tick, asking Buildbucket for the build status
[05:06:18.294] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:18.294] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:34:0) after 1m0s
[05:07:18.364] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:34:0)
[05:07:18.364] Timer tick, asking Buildbucket for the build status
[05:07:18.629] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:18.629] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:35:0) after 1m0s
[05:08:18.623] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:35:0)
[05:08:18.623] Timer tick, asking Buildbucket for the build status
[05:08:18.736] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:18.736] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:36:0) after 1m0s
[05:09:18.797] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:36:0)
[05:09:18.797] Timer tick, asking Buildbucket for the build status
[05:09:18.982] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:18.982] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:37:0) after 1m0s
[05:10:19.112] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:37:0)
[05:10:19.112] Timer tick, asking Buildbucket for the build status
[05:10:19.487] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:19.487] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:38:0) after 1m0s
[05:11:19.564] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:38:0)
[05:11:19.564] Timer tick, asking Buildbucket for the build status
[05:11:19.656] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:19.656] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:39:0) after 1m0s
[05:12:19.696] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:39:0)
[05:12:19.696] Timer tick, asking Buildbucket for the build status
[05:12:19.766] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:19.766] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:40:0) after 1m0s
[05:13:19.796] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:40:0)
[05:13:19.796] Timer tick, asking Buildbucket for the build status
[05:13:19.885] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:19.885] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:41:0) after 1m0s
[05:14:20.013] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:41:0)
[05:14:20.013] Timer tick, asking Buildbucket for the build status
[05:14:20.085] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:20.085] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:42:0) after 1m0s
[05:15:20.121] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:42:0)
[05:15:20.121] Timer tick, asking Buildbucket for the build status
[05:15:20.368] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:20.368] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:43:0) after 1m0s
[05:16:20.368] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:43:0)
[05:16:20.368] Timer tick, asking Buildbucket for the build status
[05:16:20.443] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:20.443] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:44:0) after 1m0s
[05:17:20.463] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:44:0)
[05:17:20.463] Timer tick, asking Buildbucket for the build status
[05:17:20.716] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:20.716] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:45:0) after 1m0s
[05:18:21.678] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:45:0)
[05:18:21.678] Timer tick, asking Buildbucket for the build status
[05:18:21.760] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:21.760] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:46:0) after 1m0s
[05:19:21.899] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:46:0)
[05:19:21.899] Timer tick, asking Buildbucket for the build status
[05:19:21.975] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:21.975] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:47:0) after 1m0s
[05:20:22.055] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:47:0)
[05:20:22.055] Timer tick, asking Buildbucket for the build status
[05:20:22.292] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:22.292] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:48:0) after 1m0s
[05:21:22.368] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:48:0)
[05:21:22.368] Timer tick, asking Buildbucket for the build status
[05:21:22.557] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:22.557] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:49:0) after 1m0s
[05:22:22.702] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:49:0)
[05:22:22.702] Timer tick, asking Buildbucket for the build status
[05:22:22.846] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:22.846] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:50:0) after 1m0s
[05:23:23.019] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:50:0)
[05:23:23.019] Timer tick, asking Buildbucket for the build status
[05:23:23.097] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:23.097] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:51:0) after 1m0s
[05:24:23.213] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:51:0)
[05:24:23.213] Timer tick, asking Buildbucket for the build status
[05:24:23.285] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:23.285] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:52:0) after 1m0s
[05:25:23.356] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:52:0)
[05:25:23.356] Timer tick, asking Buildbucket for the build status
[05:25:23.698] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:23.698] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:53:0) after 1m0s
[05:26:23.757] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:53:0)
[05:26:23.757] Timer tick, asking Buildbucket for the build status
[05:26:23.882] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:23.882] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:54:0) after 1m0s
[05:27:23.938] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:54:0)
[05:27:23.939] Timer tick, asking Buildbucket for the build status
[05:27:24.063] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:24.063] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:55:0) after 1m0s
[05:28:24.046] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:55:0)
[05:28:24.046] Timer tick, asking Buildbucket for the build status
[05:28:24.121] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:24.121] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:56:0) after 1m0s
[05:29:24.179] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:56:0)
[05:29:24.179] Timer tick, asking Buildbucket for the build status
[05:29:24.275] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:24.275] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:57:0) after 1m0s
[05:30:24.389] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:57:0)
[05:30:24.389] Timer tick, asking Buildbucket for the build status
[05:30:25.522] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:25.522] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:58:0) after 1m0s
[05:31:25.633] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:58:0)
[05:31:25.633] Timer tick, asking Buildbucket for the build status
[05:31:25.717] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:25.717] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:59:0) after 1m0s
[05:32:25.728] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:59:0)
[05:32:25.728] Timer tick, asking Buildbucket for the build status
[05:32:26.090] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:26.090] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:60:0) after 1m0s
[05:33:26.177] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:60:0)
[05:33:26.177] Timer tick, asking Buildbucket for the build status
[05:33:26.268] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:26.268] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:61:0) after 1m0s
[05:34:26.306] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:61:0)
[05:34:26.306] Timer tick, asking Buildbucket for the build status
[05:34:26.840] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:26.840] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:62:0) after 1m0s
[05:35:26.930] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:62:0)
[05:35:26.930] Timer tick, asking Buildbucket for the build status
[05:35:27.099] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:27.099] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:63:0) after 1m0s
[05:36:27.144] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:63:0)
[05:36:27.144] Timer tick, asking Buildbucket for the build status
[05:36:27.220] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:27.220] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:64:0) after 1m0s
[05:37:27.318] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:64:0)
[05:37:27.318] Timer tick, asking Buildbucket for the build status
[05:37:27.425] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:27.425] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:65:0) after 1m0s
[05:38:27.542] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:65:0)
[05:38:27.542] Timer tick, asking Buildbucket for the build status
[05:38:27.689] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:27.689] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:66:0) after 1m0s
[05:39:27.721] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:66:0)
[05:39:27.721] Timer tick, asking Buildbucket for the build status
[05:39:27.952] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:27.952] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:67:0) after 1m0s
[05:40:27.992] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:67:0)
[05:40:27.992] Timer tick, asking Buildbucket for the build status
[05:40:28.208] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:28.208] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:68:0) after 1m0s
[05:41:28.267] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:68:0)
[05:41:28.267] Timer tick, asking Buildbucket for the build status
[05:41:28.337] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:28.337] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:69:0) after 1m0s
[05:42:28.373] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:69:0)
[05:42:28.373] Timer tick, asking Buildbucket for the build status
[05:42:28.453] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:28.453] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:70:0) after 1m0s
[05:43:28.575] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:70:0)
[05:43:28.575] Timer tick, asking Buildbucket for the build status
[05:43:29.068] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:29.068] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:71:0) after 1m0s
[05:44:29.126] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:71:0)
[05:44:29.126] Timer tick, asking Buildbucket for the build status
[05:44:29.252] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:29.252] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:72:0) after 1m0s
[05:45:29.355] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:72:0)
[05:45:29.355] Timer tick, asking Buildbucket for the build status
[05:45:29.617] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:29.617] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:73:0) after 1m0s
[05:46:29.788] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:73:0)
[05:46:29.788] Timer tick, asking Buildbucket for the build status
[05:46:29.860] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:29.860] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:74:0) after 1m0s
[05:47:29.930] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:74:0)
[05:47:29.930] Timer tick, asking Buildbucket for the build status
[05:47:30.026] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:30.026] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:75:0) after 1m0s
[05:48:30.095] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:75:0)
[05:48:30.095] Timer tick, asking Buildbucket for the build status
[05:48:30.172] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:30.172] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:76:0) after 1m0s
[05:49:30.245] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:76:0)
[05:49:30.245] Timer tick, asking Buildbucket for the build status
[05:49:30.403] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:30.403] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:77:0) after 1m0s
[05:50:30.452] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:77:0)
[05:50:30.452] Timer tick, asking Buildbucket for the build status
[05:50:30.623] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:30.623] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:78:0) after 1m0s
[05:51:30.714] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:78:0)
[05:51:30.714] Timer tick, asking Buildbucket for the build status
[05:51:30.805] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:30.806] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:79:0) after 1m0s
[05:52:30.824] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:79:0)
[05:52:30.824] Timer tick, asking Buildbucket for the build status
[05:52:30.893] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:30.893] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:80:0) after 1m0s
[05:53:30.923] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:80:0)
[05:53:30.923] Timer tick, asking Buildbucket for the build status
[05:53:30.993] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:30.993] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:81:0) after 1m0s
[05:54:31.015] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:81:0)
[05:54:31.015] Timer tick, asking Buildbucket for the build status
[05:54:31.096] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:31.096] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:82:0) after 1m0s
[05:55:31.189] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:82:0)
[05:55:31.189] Timer tick, asking Buildbucket for the build status
[05:55:31.501] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:31.501] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:83:0) after 1m0s
[05:56:31.549] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:83:0)
[05:56:31.549] Timer tick, asking Buildbucket for the build status
[05:56:31.634] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:31.634] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:84:0) after 1m0s
[05:57:31.737] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:84:0)
[05:57:31.737] Timer tick, asking Buildbucket for the build status
[05:57:31.820] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:31.821] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:85:0) after 1m0s
[05:58:31.844] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:85:0)
[05:58:31.844] Timer tick, asking Buildbucket for the build status
[05:58:31.920] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:31.920] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:86:0) after 1m0s
[05:59:31.978] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:86:0)
[05:59:31.978] Timer tick, asking Buildbucket for the build status
[05:59:32.056] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:32.056] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:87:0) after 1m0s
[06:00:32.142] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:87:0)
[06:00:32.142] Timer tick, asking Buildbucket for the build status
[06:00:32.449] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:32.449] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:88:0) after 1m0s
[06:01:42.915] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:88:0)
[06:01:42.915] Timer tick, asking Buildbucket for the build status
[06:01:43.000] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:43.000] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:89:0) after 1m0s
[06:02:43.013] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:89:0)
[06:02:43.013] Timer tick, asking Buildbucket for the build status
[06:02:43.182] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:43.182] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:90:0) after 1m0s
[06:03:43.285] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:90:0)
[06:03:43.285] Timer tick, asking Buildbucket for the build status
[06:03:43.359] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:43.359] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:91:0) after 1m0s
[06:04:43.569] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:91:0)
[06:04:43.569] Timer tick, asking Buildbucket for the build status
[06:04:44.006] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:44.006] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:92:0) after 1m0s
[06:05:44.144] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:92:0)
[06:05:44.144] Timer tick, asking Buildbucket for the build status
[06:05:44.231] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:44.231] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:93:0) after 1m0s
[06:06:44.299] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:93:0)
[06:06:44.299] Timer tick, asking Buildbucket for the build status
[06:06:44.379] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:44.379] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:94:0) after 1m0s
[06:07:44.476] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:94:0)
[06:07:44.476] Timer tick, asking Buildbucket for the build status
[06:07:44.554] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:44.554] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:95:0) after 1m0s
[06:08:44.601] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:95:0)
[06:08:44.601] Timer tick, asking Buildbucket for the build status
[06:08:44.697] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:44.697] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:96:0) after 1m0s
[06:09:44.807] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:96:0)
[06:09:44.807] Timer tick, asking Buildbucket for the build status
[06:09:44.917] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:44.917] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:97:0) after 1m0s
[06:10:44.987] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:97:0)
[06:10:44.987] Timer tick, asking Buildbucket for the build status
[06:10:45.079] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:45.079] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:98:0) after 1m0s
[06:11:45.155] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:98:0)
[06:11:45.155] Timer tick, asking Buildbucket for the build status
[06:11:45.344] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:45.344] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:99:0) after 1m0s
[06:12:45.381] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:99:0)
[06:12:45.381] Timer tick, asking Buildbucket for the build status
[06:12:45.482] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:45.482] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:100:0) after 1m0s
[06:13:45.572] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:100:0)
[06:13:45.572] Timer tick, asking Buildbucket for the build status
[06:13:45.903] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:45.903] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:101:0) after 1m0s
[06:14:46.038] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:101:0)
[06:14:46.038] Timer tick, asking Buildbucket for the build status
[06:14:47.822] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:47.822] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:102:0) after 1m0s
[06:15:47.878] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:102:0)
[06:15:47.878] Timer tick, asking Buildbucket for the build status
[06:15:47.988] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:47.988] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:103:0) after 1m0s
[06:16:48.030] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:103:0)
[06:16:48.030] Timer tick, asking Buildbucket for the build status
[06:16:48.102] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:48.102] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:104:0) after 1m0s
[06:17:48.173] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:104:0)
[06:17:48.173] Timer tick, asking Buildbucket for the build status
[06:17:48.314] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:48.314] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:105:0) after 1m0s
[06:18:48.415] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:105:0)
[06:18:48.415] Timer tick, asking Buildbucket for the build status
[06:18:48.814] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:48.814] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:106:0) after 1m0s
[06:19:48.861] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:106:0)
[06:19:48.861] Timer tick, asking Buildbucket for the build status
[06:19:49.114] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:49.114] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:107:0) after 1m0s
[06:20:49.185] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:107:0)
[06:20:49.185] Timer tick, asking Buildbucket for the build status
[06:20:49.329] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:49.329] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:108:0) after 1m0s
[06:21:49.382] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:108:0)
[06:21:49.382] Timer tick, asking Buildbucket for the build status
[06:21:49.608] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:49.608] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:109:0) after 1m0s
[06:22:49.664] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:109:0)
[06:22:49.664] Timer tick, asking Buildbucket for the build status
[06:22:49.790] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:49.790] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:110:0) after 1m0s
[06:23:49.791] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:110:0)
[06:23:49.791] Timer tick, asking Buildbucket for the build status
[06:23:49.871] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:49.871] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:111:0) after 1m0s
[06:24:49.923] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:111:0)
[06:24:49.923] Timer tick, asking Buildbucket for the build status
[06:24:50.112] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:50.112] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:112:0) after 1m0s
[06:25:50.143] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:112:0)
[06:25:50.143] Timer tick, asking Buildbucket for the build status
[06:25:50.248] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:50.248] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:113:0) after 1m0s
[06:26:50.314] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:113:0)
[06:26:50.314] Timer tick, asking Buildbucket for the build status
[06:26:50.404] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:50.405] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:114:0) after 1m0s
[06:27:50.559] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:114:0)
[06:27:50.559] Timer tick, asking Buildbucket for the build status
[06:27:50.631] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:50.631] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:115:0) after 1m0s
[06:28:50.846] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:115:0)
[06:28:50.846] Timer tick, asking Buildbucket for the build status
[06:28:51.494] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:51.494] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:116:0) after 1m0s
[06:29:51.494] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:116:0)
[06:29:51.494] Timer tick, asking Buildbucket for the build status
[06:29:51.857] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:51.857] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:117:0) after 1m0s
[06:30:51.921] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:117:0)
[06:30:51.921] Timer tick, asking Buildbucket for the build status
[06:30:52.026] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:52.026] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:118:0) after 1m0s
[06:31:52.251] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:118:0)
[06:31:52.251] Timer tick, asking Buildbucket for the build status
[06:31:52.323] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:52.323] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:119:0) after 1m0s
[06:32:52.430] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:119:0)
[06:32:52.430] Timer tick, asking Buildbucket for the build status
[06:32:52.556] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:52.556] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:120:0) after 1m0s
[06:33:52.634] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:120:0)
[06:33:52.634] Timer tick, asking Buildbucket for the build status
[06:33:52.721] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:52.721] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:121:0) after 1m0s
[06:34:52.729] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:121:0)
[06:34:52.729] Timer tick, asking Buildbucket for the build status
[06:34:52.818] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:52.818] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:122:0) after 1m0s
[06:35:52.877] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:122:0)
[06:35:52.877] Timer tick, asking Buildbucket for the build status
[06:35:53.093] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:53.093] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:123:0) after 1m0s
[06:36:53.210] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:123:0)
[06:36:53.210] Timer tick, asking Buildbucket for the build status
[06:36:53.528] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:53.528] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:124:0) after 1m0s
[06:37:53.716] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:124:0)
[06:37:53.716] Timer tick, asking Buildbucket for the build status
[06:37:53.904] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:53.904] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:125:0) after 1m0s
[06:38:53.897] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:125:0)
[06:38:53.897] Timer tick, asking Buildbucket for the build status
[06:38:54.238] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:54.238] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:126:0) after 1m0s
[06:39:54.371] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:126:0)
[06:39:54.371] Timer tick, asking Buildbucket for the build status
[06:39:54.525] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:54.525] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:127:0) after 1m0s
[06:40:54.613] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:127:0)
[06:40:54.613] Timer tick, asking Buildbucket for the build status
[06:40:54.721] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:54.721] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:128:0) after 1m0s
[06:41:54.822] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:128:0)
[06:41:54.822] Timer tick, asking Buildbucket for the build status
[06:41:54.913] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:54.913] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:129:0) after 1m0s
[06:42:54.980] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:129:0)
[06:42:54.980] Timer tick, asking Buildbucket for the build status
[06:42:55.074] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:55.074] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:130:0) after 1m0s
[06:43:55.119] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:130:0)
[06:43:55.119] Timer tick, asking Buildbucket for the build status
[06:43:55.211] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:55.212] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:131:0) after 1m0s
[06:44:55.332] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:131:0)
[06:44:55.332] Timer tick, asking Buildbucket for the build status
[06:44:55.701] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:55.701] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:132:0) after 1m0s
[06:45:55.733] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:132:0)
[06:45:55.733] Timer tick, asking Buildbucket for the build status
[06:45:55.835] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:55.835] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:133:0) after 1m0s
[06:46:55.879] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:133:0)
[06:46:55.879] Timer tick, asking Buildbucket for the build status
[06:46:55.968] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:55.968] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:134:0) after 1m0s
[06:47:56.093] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:134:0)
[06:47:56.093] Timer tick, asking Buildbucket for the build status
[06:47:56.159] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:56.159] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:135:0) after 1m0s
[06:48:56.226] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:135:0)
[06:48:56.226] Timer tick, asking Buildbucket for the build status
[06:48:56.316] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:56.316] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:136:0) after 1m0s
[06:49:56.414] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:136:0)
[06:49:56.414] Timer tick, asking Buildbucket for the build status
[06:49:56.507] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:56.507] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:137:0) after 1m0s
[06:50:56.637] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:137:0)
[06:50:56.638] Timer tick, asking Buildbucket for the build status
[06:50:56.729] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:56.729] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:138:0) after 1m0s
[06:51:56.815] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:138:0)
[06:51:56.815] Timer tick, asking Buildbucket for the build status
[06:51:56.899] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:56.899] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:139:0) after 1m0s
[06:52:56.883] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:139:0)
[06:52:56.883] Timer tick, asking Buildbucket for the build status
[06:52:57.144] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:57.144] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:140:0) after 1m0s
[06:53:57.268] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:140:0)
[06:53:57.268] Timer tick, asking Buildbucket for the build status
[06:53:57.520] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:57.520] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:141:0) after 1m0s
[06:54:57.534] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:141:0)
[06:54:57.534] Timer tick, asking Buildbucket for the build status
[06:54:57.608] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:57.608] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:142:0) after 1m0s
[06:55:57.679] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:142:0)
[06:55:57.679] Timer tick, asking Buildbucket for the build status
[06:55:57.799] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:57.799] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:143:0) after 1m0s
[06:56:57.875] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:143:0)
[06:56:57.875] Timer tick, asking Buildbucket for the build status
[06:56:58.013] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:58.013] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:144:0) after 1m0s
[06:57:58.229] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:144:0)
[06:57:58.229] Timer tick, asking Buildbucket for the build status
[06:57:58.296] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:58.296] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:145:0) after 1m0s
[06:58:58.278] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:145:0)
[06:58:58.278] Timer tick, asking Buildbucket for the build status
[06:58:58.438] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:58.438] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:146:0) after 1m0s
[06:59:58.538] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:146:0)
[06:59:58.538] Timer tick, asking Buildbucket for the build status
[06:59:58.636] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:58.636] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:147:0) after 1m0s
[07:00:58.746] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:147:0)
[07:00:58.746] Timer tick, asking Buildbucket for the build status
[07:00:58.845] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:58.845] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:148:0) after 1m0s
[07:01:58.879] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:148:0)
[07:01:58.879] Timer tick, asking Buildbucket for the build status
[07:01:58.959] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:58.959] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:149:0) after 1m0s
[07:02:59.017] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:149:0)
[07:02:59.017] Timer tick, asking Buildbucket for the build status
[07:02:59.446] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:59.446] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:150:0) after 1m0s
[07:03:59.569] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:150:0)
[07:03:59.569] Timer tick, asking Buildbucket for the build status
[07:03:59.638] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:59.638] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:151:0) after 1m0s
[07:04:59.633] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:151:0)
[07:04:59.633] Timer tick, asking Buildbucket for the build status
[07:04:59.720] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:59.720] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:152:0) after 1m0s
[07:05:59.751] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:152:0)
[07:05:59.751] Timer tick, asking Buildbucket for the build status
[07:05:59.845] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:59.845] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:153:0) after 1m0s
[07:06:59.904] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:153:0)
[07:06:59.904] Timer tick, asking Buildbucket for the build status
[07:07:00.257] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:00.257] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:154:0) after 1m0s
[07:08:00.261] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:154:0)
[07:08:00.261] Timer tick, asking Buildbucket for the build status
[07:08:00.345] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:00.345] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:155:0) after 1m0s
[07:09:00.705] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:155:0)
[07:09:00.705] Timer tick, asking Buildbucket for the build status
[07:09:00.844] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:00.844] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:156:0) after 1m0s
[07:10:01.569] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:156:0)
[07:10:01.588] Timer tick, asking Buildbucket for the build status
[07:10:01.994] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:01.994] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:157:0) after 1m0s
[07:11:02.713] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:157:0)
[07:11:02.713] Timer tick, asking Buildbucket for the build status
[07:11:02.939] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:02.939] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:158:0) after 1m0s
[07:12:03.120] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:158:0)
[07:12:03.120] Timer tick, asking Buildbucket for the build status
[07:12:03.350] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:03.350] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:159:0) after 1m0s
[07:13:03.356] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:159:0)
[07:13:03.356] Timer tick, asking Buildbucket for the build status
[07:13:03.444] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:03.444] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:160:0) after 1m0s
[07:14:03.517] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:160:0)
[07:14:03.517] Timer tick, asking Buildbucket for the build status
[07:14:03.648] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:03.648] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:161:0) after 1m0s
[07:15:03.732] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:161:0)
[07:15:03.732] Timer tick, asking Buildbucket for the build status
[07:15:03.862] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:03.862] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:162:0) after 1m0s
[07:16:03.964] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:162:0)
[07:16:03.964] Timer tick, asking Buildbucket for the build status
[07:16:04.051] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:04.051] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:163:0) after 1m0s
[07:17:04.126] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:163:0)
[07:17:04.126] Timer tick, asking Buildbucket for the build status
[07:17:04.604] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:04.604] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:164:0) after 1m0s
[07:18:04.741] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:164:0)
[07:18:04.741] Timer tick, asking Buildbucket for the build status
[07:18:04.839] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:04.839] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:165:0) after 1m0s
[07:19:04.967] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:165:0)
[07:19:04.967] Timer tick, asking Buildbucket for the build status
[07:19:05.076] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:05.076] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:166:0) after 1m0s
[07:20:05.246] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:166:0)
[07:20:05.246] Timer tick, asking Buildbucket for the build status
[07:20:05.886] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:05.886] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:167:0) after 1m0s
[07:21:06.079] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:167:0)
[07:21:06.079] Timer tick, asking Buildbucket for the build status
[07:21:06.452] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:06.452] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:168:0) after 1m0s
[07:22:06.700] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:168:0)
[07:22:06.700] Timer tick, asking Buildbucket for the build status
[07:22:06.889] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:06.889] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:169:0) after 1m0s
[07:23:06.954] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:169:0)
[07:23:06.954] Timer tick, asking Buildbucket for the build status
[07:23:07.038] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:07.038] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:170:0) after 1m0s
[07:24:07.113] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:170:0)
[07:24:07.113] Timer tick, asking Buildbucket for the build status
[07:24:07.196] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:07.196] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:171:0) after 1m0s
[07:25:07.219] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:171:0)
[07:25:07.219] Timer tick, asking Buildbucket for the build status
[07:25:07.311] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:07.311] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:172:0) after 1m0s
[07:26:07.329] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:172:0)
[07:26:07.329] Timer tick, asking Buildbucket for the build status
[07:26:07.425] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:07.426] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:173:0) after 1m0s
[07:27:07.610] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:173:0)
[07:27:07.610] Timer tick, asking Buildbucket for the build status
[07:27:07.739] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:07.739] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:174:0) after 1m0s
[07:28:07.877] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:174:0)
[07:28:07.877] Timer tick, asking Buildbucket for the build status
[07:28:07.953] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:07.953] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:175:0) after 1m0s
[07:29:08.110] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:175:0)
[07:29:08.110] Timer tick, asking Buildbucket for the build status
[07:29:08.196] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:08.196] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:176:0) after 1m0s
[07:30:08.296] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:176:0)
[07:30:08.296] Timer tick, asking Buildbucket for the build status
[07:30:08.379] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:08.379] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:177:0) after 1m0s
[07:31:10.399] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:177:0)
[07:31:10.400] Timer tick, asking Buildbucket for the build status
[07:31:10.960] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:10.960] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:178:0) after 1m0s
[07:32:11.658] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:178:0)
[07:32:11.658] Timer tick, asking Buildbucket for the build status
[07:32:11.848] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:11.848] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:179:0) after 1m0s
[07:33:12.300] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:179:0)
[07:33:12.300] Timer tick, asking Buildbucket for the build status
[07:33:12.419] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:12.419] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:180:0) after 1m0s
[07:34:12.622] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:180:0)
[07:34:12.622] Timer tick, asking Buildbucket for the build status
[07:34:12.723] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:12.723] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:181:0) after 1m0s
[07:35:12.944] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:181:0)
[07:35:12.944] Timer tick, asking Buildbucket for the build status
[07:35:13.279] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:13.279] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:182:0) after 1m0s
[07:36:13.638] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:182:0)
[07:36:13.638] Timer tick, asking Buildbucket for the build status
[07:36:14.103] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:14.103] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:183:0) after 1m0s
[07:37:14.126] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:183:0)
[07:37:14.126] Timer tick, asking Buildbucket for the build status
[07:37:14.213] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:14.213] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:184:0) after 1m0s
[07:38:14.319] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:184:0)
[07:38:14.319] Timer tick, asking Buildbucket for the build status
[07:38:14.394] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:14.394] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:185:0) after 1m0s
[07:39:14.450] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:185:0)
[07:39:14.450] Timer tick, asking Buildbucket for the build status
[07:39:14.530] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:14.530] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:186:0) after 1m0s
[07:40:14.598] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:186:0)
[07:40:14.598] Timer tick, asking Buildbucket for the build status
[07:40:14.673] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:14.673] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:187:0) after 1m0s
[07:41:14.726] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:187:0)
[07:41:14.726] Timer tick, asking Buildbucket for the build status
[07:41:14.841] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:14.841] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:188:0) after 1m0s
[07:42:14.832] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:188:0)
[07:42:14.832] Timer tick, asking Buildbucket for the build status
[07:42:14.926] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:14.926] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:189:0) after 1m0s
[07:43:15.015] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:189:0)
[07:43:15.015] Timer tick, asking Buildbucket for the build status
[07:43:15.091] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:15.092] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:190:0) after 1m0s
[07:44:15.325] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:190:0)
[07:44:15.325] Timer tick, asking Buildbucket for the build status
[07:44:15.412] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:15.412] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:191:0) after 1m0s
[07:45:15.511] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:191:0)
[07:45:15.511] Timer tick, asking Buildbucket for the build status
[07:45:15.620] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:15.620] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:192:0) after 1m0s
[07:46:15.685] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:192:0)
[07:46:15.685] Timer tick, asking Buildbucket for the build status
[07:46:15.793] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:15.793] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:193:0) after 1m0s
[07:47:15.833] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:193:0)
[07:47:15.833] Timer tick, asking Buildbucket for the build status
[07:47:15.984] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:15.984] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:194:0) after 1m0s
[07:48:16.053] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:194:0)
[07:48:16.053] Timer tick, asking Buildbucket for the build status
[07:48:16.143] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:16.143] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:195:0) after 1m0s
[07:49:16.165] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:195:0)
[07:49:16.165] Timer tick, asking Buildbucket for the build status
[07:49:16.234] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:16.235] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:196:0) after 1m0s
[07:50:16.284] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:196:0)
[07:50:16.284] Timer tick, asking Buildbucket for the build status
[07:50:16.370] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:16.370] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:197:0) after 1m0s
[07:51:16.457] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:197:0)
[07:51:16.457] Timer tick, asking Buildbucket for the build status
[07:51:16.553] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:16.553] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:198:0) after 1m0s
[07:52:16.645] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:198:0)
[07:52:16.645] Timer tick, asking Buildbucket for the build status
[07:52:16.723] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:16.723] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:199:0) after 1m0s
[07:53:16.810] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:199:0)
[07:53:16.810] Timer tick, asking Buildbucket for the build status
[07:53:16.893] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:16.893] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:200:0) after 1m0s
[07:54:16.957] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:200:0)
[07:54:16.957] Timer tick, asking Buildbucket for the build status
[07:54:17.025] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:17.025] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:201:0) after 1m0s
[07:55:17.122] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:201:0)
[07:55:17.122] Timer tick, asking Buildbucket for the build status
[07:55:17.316] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:17.316] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:202:0) after 1m0s
[07:56:17.336] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:202:0)
[07:56:17.336] Timer tick, asking Buildbucket for the build status
[07:56:17.438] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:17.438] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:203:0) after 1m0s
[07:57:17.461] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:203:0)
[07:57:17.461] Timer tick, asking Buildbucket for the build status
[07:57:17.535] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:17.535] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:204:0) after 1m0s
[07:58:17.827] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:204:0)
[07:58:17.827] Timer tick, asking Buildbucket for the build status
[07:58:17.934] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:17.934] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:205:0) after 1m0s
[07:59:18.100] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:205:0)
[07:59:18.100] Timer tick, asking Buildbucket for the build status
[07:59:18.644] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:18.644] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:206:0) after 1m0s
[08:00:18.698] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:206:0)
[08:00:18.698] Timer tick, asking Buildbucket for the build status
[08:00:18.852] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:18.852] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:207:0) after 1m0s
[08:01:19.047] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:207:0)
[08:01:19.047] Timer tick, asking Buildbucket for the build status
[08:01:19.393] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:19.393] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:208:0) after 1m0s
[08:02:19.436] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:208:0)
[08:02:19.436] Timer tick, asking Buildbucket for the build status
[08:02:19.520] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:19.520] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:209:0) after 1m0s
[08:03:19.649] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:209:0)
[08:03:19.649] Timer tick, asking Buildbucket for the build status
[08:03:20.032] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:20.032] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:210:0) after 1m0s
[08:04:20.122] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:210:0)
[08:04:20.122] Timer tick, asking Buildbucket for the build status
[08:04:20.203] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:20.203] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:211:0) after 1m0s
[08:05:20.338] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:211:0)
[08:05:20.338] Timer tick, asking Buildbucket for the build status
[08:05:20.444] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:20.444] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:212:0) after 1m0s
[08:06:20.682] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:212:0)
[08:06:20.682] Timer tick, asking Buildbucket for the build status
[08:06:20.953] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:20.953] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:213:0) after 1m0s
[08:07:22.731] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:213:0)
[08:07:22.731] Timer tick, asking Buildbucket for the build status
[08:07:23.085] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:23.085] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:214:0) after 1m0s
[08:08:23.221] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:214:0)
[08:08:23.221] Timer tick, asking Buildbucket for the build status
[08:08:23.300] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:23.300] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:215:0) after 1m0s
[08:09:23.763] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:215:0)
[08:09:23.763] Timer tick, asking Buildbucket for the build status
[08:09:23.848] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:23.848] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:216:0) after 1m0s
[08:10:24.168] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:216:0)
[08:10:24.168] Timer tick, asking Buildbucket for the build status
[08:10:24.316] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:24.316] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:217:0) after 1m0s
[08:11:24.431] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:217:0)
[08:11:24.431] Timer tick, asking Buildbucket for the build status
[08:11:24.526] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:24.526] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:218:0) after 1m0s
[08:12:24.603] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:218:0)
[08:12:24.603] Timer tick, asking Buildbucket for the build status
[08:12:24.781] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:24.781] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:219:0) after 1m0s
[08:13:24.834] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:219:0)
[08:13:24.834] Timer tick, asking Buildbucket for the build status
[08:13:25.116] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:25.116] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:220:0) after 1m0s
[08:14:25.134] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:220:0)
[08:14:25.134] Timer tick, asking Buildbucket for the build status
[08:14:25.506] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:25.506] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:221:0) after 1m0s
[08:15:25.552] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:221:0)
[08:15:25.552] Timer tick, asking Buildbucket for the build status
[08:15:26.322] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:26.322] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:222:0) after 1m0s
[08:16:26.415] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:222:0)
[08:16:26.415] Timer tick, asking Buildbucket for the build status
[08:16:26.726] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:26.726] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:223:0) after 1m0s
[08:17:26.825] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:223:0)
[08:17:26.825] Timer tick, asking Buildbucket for the build status
[08:17:26.906] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:26.906] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:224:0) after 1m0s
[08:18:26.979] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:224:0)
[08:18:26.979] Timer tick, asking Buildbucket for the build status
[08:18:27.070] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:27.070] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:225:0) after 1m0s
[08:19:27.118] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:225:0)
[08:19:27.118] Timer tick, asking Buildbucket for the build status
[08:19:27.209] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:27.209] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:226:0) after 1m0s
[08:20:27.340] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:226:0)
[08:20:27.340] Timer tick, asking Buildbucket for the build status
[08:20:27.487] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:27.487] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:227:0) after 1m0s
[08:21:27.701] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:227:0)
[08:21:27.701] Timer tick, asking Buildbucket for the build status
[08:21:27.912] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:27.912] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:228:0) after 1m0s
[08:22:28.210] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:228:0)
[08:22:28.210] Timer tick, asking Buildbucket for the build status
[08:22:28.284] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:28.284] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:229:0) after 1m0s
[08:23:28.341] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:229:0)
[08:23:28.341] Timer tick, asking Buildbucket for the build status
[08:23:28.425] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:28.425] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:230:0) after 1m0s
[08:24:28.598] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:230:0)
[08:24:28.598] Timer tick, asking Buildbucket for the build status
[08:24:28.679] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:28.679] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:231:0) after 1m0s
[08:25:28.712] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:231:0)
[08:25:28.712] Timer tick, asking Buildbucket for the build status
[08:25:28.806] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:28.806] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:232:0) after 1m0s
[08:26:28.920] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:232:0)
[08:26:28.920] Timer tick, asking Buildbucket for the build status
[08:26:29.049] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:29.049] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:233:0) after 1m0s
[08:27:29.122] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:233:0)
[08:27:29.122] Timer tick, asking Buildbucket for the build status
[08:27:29.209] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:29.209] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:234:0) after 1m0s
[08:28:29.276] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:234:0)
[08:28:29.276] Timer tick, asking Buildbucket for the build status
[08:28:29.377] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:29.377] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:235:0) after 1m0s
[08:29:29.445] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:235:0)
[08:29:29.445] Timer tick, asking Buildbucket for the build status
[08:29:29.557] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:29.557] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:236:0) after 1m0s
[08:30:29.592] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:236:0)
[08:30:29.592] Timer tick, asking Buildbucket for the build status
[08:30:29.688] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:29.688] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:237:0) after 1m0s
[08:31:29.722] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:237:0)
[08:31:29.722] Timer tick, asking Buildbucket for the build status
[08:31:30.034] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:30.034] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:238:0) after 1m0s
[08:32:30.117] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:238:0)
[08:32:30.117] Timer tick, asking Buildbucket for the build status
[08:32:30.318] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:30.318] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:239:0) after 1m0s
[08:33:30.438] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:239:0)
[08:33:30.438] Timer tick, asking Buildbucket for the build status
[08:33:30.644] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:30.644] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:240:0) after 1m0s
[08:34:30.744] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:240:0)
[08:34:30.744] Timer tick, asking Buildbucket for the build status
[08:34:30.831] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:30.831] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:241:0) after 1m0s
[08:35:30.890] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:241:0)
[08:35:30.890] Timer tick, asking Buildbucket for the build status
[08:35:31.005] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:31.005] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:242:0) after 1m0s
[08:36:31.192] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:242:0)
[08:36:31.192] Timer tick, asking Buildbucket for the build status
[08:36:31.641] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:31.641] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:243:0) after 1m0s
[08:37:31.709] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:243:0)
[08:37:31.709] Timer tick, asking Buildbucket for the build status
[08:37:31.843] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:31.843] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:244:0) after 1m0s
[08:38:31.947] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:244:0)
[08:38:31.947] Timer tick, asking Buildbucket for the build status
[08:38:32.035] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:32.035] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:245:0) after 1m0s
[08:39:32.085] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:245:0)
[08:39:32.085] Timer tick, asking Buildbucket for the build status
[08:39:32.218] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:32.218] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:246:0) after 1m0s
[08:40:32.241] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:246:0)
[08:40:32.241] Timer tick, asking Buildbucket for the build status
[08:40:32.334] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:32.334] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:247:0) after 1m0s
[08:41:32.399] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:247:0)
[08:41:32.399] Timer tick, asking Buildbucket for the build status
[08:41:32.495] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:32.495] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:248:0) after 1m0s
[08:42:33.014] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:248:0)
[08:42:33.014] Timer tick, asking Buildbucket for the build status
[08:42:33.240] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:33.240] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:249:0) after 1m0s
[08:43:33.385] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:249:0)
[08:43:33.385] Timer tick, asking Buildbucket for the build status
[08:43:33.625] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:33.625] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:250:0) after 1m0s
[08:44:33.714] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:250:0)
[08:44:33.714] Timer tick, asking Buildbucket for the build status
[08:44:33.903] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:33.903] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:251:0) after 1m0s
[08:45:34.046] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:251:0)
[08:45:34.046] Timer tick, asking Buildbucket for the build status
[08:45:34.356] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:34.356] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:252:0) after 1m0s
[08:46:34.566] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:252:0)
[08:46:34.566] Timer tick, asking Buildbucket for the build status
[08:46:34.658] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:34.658] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:253:0) after 1m0s
[08:47:34.902] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:253:0)
[08:47:34.902] Timer tick, asking Buildbucket for the build status
[08:47:35.045] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:35.045] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:254:0) after 1m0s
[08:48:35.273] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:254:0)
[08:48:35.273] Timer tick, asking Buildbucket for the build status
[08:48:35.551] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:35.551] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:255:0) after 1m0s
[08:49:35.755] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:255:0)
[08:49:35.755] Timer tick, asking Buildbucket for the build status
[08:49:35.921] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:35.921] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:256:0) after 1m0s
[08:50:36.032] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:256:0)
[08:50:36.032] Timer tick, asking Buildbucket for the build status
[08:50:39.685] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:39.686] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:257:0) after 1m0s
[08:51:39.784] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:257:0)
[08:51:39.784] Timer tick, asking Buildbucket for the build status
[08:51:40.110] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:40.110] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:258:0) after 1m0s
[08:52:40.159] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:258:0)
[08:52:40.159] Timer tick, asking Buildbucket for the build status
[08:52:40.282] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:40.282] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:259:0) after 1m0s
[08:53:40.426] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:259:0)
[08:53:40.426] Timer tick, asking Buildbucket for the build status
[08:53:40.602] Build 8855168652910889888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:40.602] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9020598714986256448:260:0) after 1m0s
[08:54:22.263] Received PubSub notification, asking Buildbucket for the build status
[08:54:22.331] Build 8855168652910889888: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[08:54:22.331] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613465661741934",
"created_by": "project:chromium",
"created_ts": "1613450110481184",
"id": "8855168652910889888",
"parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7e66d589d63c7716729886a37d479d3401d3a7e9\"}}",
"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\": \"7e66d589d63c7716729886a37d479d3401d3a7e9\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"win-dbg-1-exts\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win32-official\", \"buildnumber\": 1557, \"got_angle_revision\": \"a8a2a71b3ab5e535def6239997f6f24da918556b\", \"got_dawn_revision\": \"e61c9d86884145733d5763ab23c15bf09acf358c\", \"got_nacl_revision\": \"8a92e6ba1b6d62631f8d3ba3f4f8872ae8b6cca1\", \"got_revision\": \"7e66d589d63c7716729886a37d479d3401d3a7e9\", \"got_revision_cp\": \"refs/heads/master@{#854151}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"539ef8e9426e10d7611d433ee60b94de0737344a\", \"got_v8_revision\": \"ebacb645b20531cd78dc088730fb72269822eeb6\", \"got_v8_revision_cp\": \"refs/heads/9.0.172@{#2}\", \"got_webrtc_revision\": \"8408c9938cb543a7cd5e7127927f3b4d0834ad59\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33272}\", \"mirrored_builders\": [\"tryserver.chromium:win32-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7e66d589d63c7716729886a37d479d3401d3a7e9\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_cc946d8c9fe3204026095d74248289703a45d938e0b9766be9cb626e466da04f_v2\", \"builder_f6b49936a2965b3cdad8f63ce13313d0c4b82119a9acfffbfe199e91c26d0c88_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-1-exts\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5700-b36f18b\"], \"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": "1613450120275790",
"status": "COMPLETED",
"status_changed_ts": "1613465662072810",
"tags": [
"build_address:luci.chromium.ci/win32-official/1557",
"builder:win32-official",
"buildset:commit/git/7e66d589d63c7716729886a37d479d3401d3a7e9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7e66d589d63c7716729886a37d479d3401d3a7e9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020598714986256448",
"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/8855168652910889888/+/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:51c1f073cc82d510",
"user_agent:luci-scheduler"
],
"updated_ts": "1613465662077290",
"url": "https://ci.chromium.org/b/8855168652910889888",
"utcnow_ts": "1613465662323672"
}
}
[08:54:22.331] Invocation finished in 4h19m13.212625368s with status SUCCEEDED