[00:29:30.550] New invocation is queued and will start shortly
[00:29:31.663] Starting the invocation (attempt 1)
[00:29:31.706] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:29:31.706] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:29:31.706] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9037736996162787120",
"parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"46daab5a64cf5b23b9b4aa4a8ac2681240480d59\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-official",
"scheduler_invocation_id:9037736996162787120",
"scheduler_job_id:chromium/win-official",
"user_agent:luci-scheduler",
"buildset:commit/git/46daab5a64cf5b23b9b4aa4a8ac2681240480d59",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/46daab5a64cf5b23b9b4aa4a8ac2681240480d59",
"gitiles_ref:refs/heads/master"
]
}
[00:29:32.692] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1597105771811136",
"id": "8872306934175380192",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"46daab5a64cf5b23b9b4aa4a8ac2681240480d59\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1597105772525034",
"tags": [
"build_address:luci.chromium.ci/win-official/312",
"builder:win-official",
"buildset:commit/git/46daab5a64cf5b23b9b4aa4a8ac2681240480d59",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/46daab5a64cf5b23b9b4aa4a8ac2681240480d59",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9037736996162787120",
"scheduler_job_id:chromium/win-official",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8872306934175380192/+/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": "1597105772525494",
"url": "https://ci.chromium.org/b/8872306934175380192",
"utcnow_ts": "1597105772679733"
}
}
[00:29:32.692] Task URL: https://ci.chromium.org/b/8872306934175380192
[00:29:32.692] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:2:0) after 1m0s
[00:30:33.028] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:2:0)
[00:30:33.028] Timer tick, asking Buildbucket for the build status
[00:30:33.242] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:33.242] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:3:0) after 1m0s
[00:30:33.381] Received PubSub notification, asking Buildbucket for the build status
[00:30:33.571] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:33.308] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:3:0)
[00:31:33.308] Timer tick, asking Buildbucket for the build status
[00:31:33.603] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:33.603] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:5:0) after 1m0s
[00:32:33.716] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:5:0)
[00:32:33.716] Timer tick, asking Buildbucket for the build status
[00:32:36.394] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:36.394] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:6:0) after 1m0s
[00:33:36.465] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:6:0)
[00:33:36.465] Timer tick, asking Buildbucket for the build status
[00:33:36.575] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:36.575] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:7:0) after 1m0s
[00:34:36.646] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:7:0)
[00:34:36.646] Timer tick, asking Buildbucket for the build status
[00:34:36.845] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:36.845] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:8:0) after 1m0s
[00:35:36.969] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:8:0)
[00:35:36.970] Timer tick, asking Buildbucket for the build status
[00:35:37.100] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:37.100] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:9:0) after 1m0s
[00:36:37.229] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:9:0)
[00:36:37.230] Timer tick, asking Buildbucket for the build status
[00:36:37.316] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:37.316] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:10:0) after 1m0s
[00:37:37.365] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:10:0)
[00:37:37.365] Timer tick, asking Buildbucket for the build status
[00:37:37.536] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:37.536] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:11:0) after 1m0s
[00:38:37.555] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:11:0)
[00:38:37.555] Timer tick, asking Buildbucket for the build status
[00:38:37.658] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:37.658] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:12:0) after 1m0s
[00:39:37.716] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:12:0)
[00:39:37.716] Timer tick, asking Buildbucket for the build status
[00:39:38.032] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:38.032] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:13:0) after 1m0s
[00:40:38.067] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:13:0)
[00:40:38.067] Timer tick, asking Buildbucket for the build status
[00:40:38.230] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:38.230] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:14:0) after 1m0s
[00:41:38.270] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:14:0)
[00:41:38.270] Timer tick, asking Buildbucket for the build status
[00:41:38.433] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:38.433] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:15:0) after 1m0s
[00:42:38.466] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:15:0)
[00:42:38.466] Timer tick, asking Buildbucket for the build status
[00:42:38.727] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:38.727] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:16:0) after 1m0s
[00:43:38.749] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:16:0)
[00:43:38.749] Timer tick, asking Buildbucket for the build status
[00:43:38.961] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:38.961] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:17:0) after 1m0s
[00:44:38.986] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:17:0)
[00:44:38.986] Timer tick, asking Buildbucket for the build status
[00:44:40.248] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:40.248] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:18:0) after 1m0s
[00:45:40.259] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:18:0)
[00:45:40.259] Timer tick, asking Buildbucket for the build status
[00:45:40.496] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:40.496] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:19:0) after 1m0s
[00:46:40.499] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:19:0)
[00:46:40.499] Timer tick, asking Buildbucket for the build status
[00:46:40.888] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:40.888] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:20:0) after 1m0s
[00:47:40.928] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:20:0)
[00:47:40.928] Timer tick, asking Buildbucket for the build status
[00:47:41.182] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:41.182] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:21:0) after 1m0s
[00:48:41.208] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:21:0)
[00:48:41.208] Timer tick, asking Buildbucket for the build status
[00:48:41.319] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:41.319] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:22:0) after 1m0s
[00:49:41.330] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:22:0)
[00:49:41.330] Timer tick, asking Buildbucket for the build status
[00:49:42.316] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:42.316] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:23:0) after 1m0s
[00:50:42.306] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:23:0)
[00:50:42.306] Timer tick, asking Buildbucket for the build status
[00:50:42.410] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:42.410] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:24:0) after 1m0s
[00:51:42.492] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:24:0)
[00:51:42.492] Timer tick, asking Buildbucket for the build status
[00:51:42.748] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:42.748] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:25:0) after 1m0s
[00:52:42.769] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:25:0)
[00:52:42.769] Timer tick, asking Buildbucket for the build status
[00:52:42.891] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:42.891] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:26:0) after 1m0s
[00:53:42.933] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:26:0)
[00:53:42.933] Timer tick, asking Buildbucket for the build status
[00:53:43.971] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:43.971] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:27:0) after 1m0s
[00:54:44.021] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:27:0)
[00:54:44.021] Timer tick, asking Buildbucket for the build status
[00:54:44.753] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:44.754] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:28:0) after 1m0s
[00:55:44.824] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:28:0)
[00:55:44.824] Timer tick, asking Buildbucket for the build status
[00:55:45.008] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:45.008] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:29:0) after 1m0s
[00:56:45.094] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:29:0)
[00:56:45.094] Timer tick, asking Buildbucket for the build status
[00:56:45.196] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:45.196] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:30:0) after 1m0s
[00:57:45.225] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:30:0)
[00:57:45.225] Timer tick, asking Buildbucket for the build status
[00:57:45.300] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:45.300] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:31:0) after 1m0s
[00:58:45.291] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:31:0)
[00:58:45.291] Timer tick, asking Buildbucket for the build status
[00:58:45.363] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:45.363] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:32:0) after 1m0s
[00:59:45.363] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:32:0)
[00:59:45.363] Timer tick, asking Buildbucket for the build status
[00:59:45.705] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:45.705] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:33:0) after 1m0s
[01:00:45.757] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:33:0)
[01:00:45.757] Timer tick, asking Buildbucket for the build status
[01:00:45.980] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:45.980] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:34:0) after 1m0s
[01:01:46.022] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:34:0)
[01:01:46.022] Timer tick, asking Buildbucket for the build status
[01:01:46.148] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:46.148] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:35:0) after 1m0s
[01:02:46.205] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:35:0)
[01:02:46.205] Timer tick, asking Buildbucket for the build status
[01:02:46.315] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:46.315] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:36:0) after 1m0s
[01:03:46.466] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:36:0)
[01:03:46.466] Timer tick, asking Buildbucket for the build status
[01:03:46.558] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:46.558] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:37:0) after 1m0s
[01:04:46.550] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:37:0)
[01:04:46.550] Timer tick, asking Buildbucket for the build status
[01:04:46.925] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:46.925] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:38:0) after 1m0s
[01:05:47.023] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:38:0)
[01:05:47.023] Timer tick, asking Buildbucket for the build status
[01:05:47.304] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:47.304] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:39:0) after 1m0s
[01:06:47.385] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:39:0)
[01:06:47.385] Timer tick, asking Buildbucket for the build status
[01:06:47.627] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:47.627] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:40:0) after 1m0s
[01:07:47.724] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:40:0)
[01:07:47.724] Timer tick, asking Buildbucket for the build status
[01:07:47.806] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:47.806] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:41:0) after 1m0s
[01:08:47.877] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:41:0)
[01:08:47.877] Timer tick, asking Buildbucket for the build status
[01:08:47.976] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:47.976] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:42:0) after 1m0s
[01:09:48.087] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:42:0)
[01:09:48.087] Timer tick, asking Buildbucket for the build status
[01:09:48.428] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:48.428] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:43:0) after 1m0s
[01:10:48.497] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:43:0)
[01:10:48.497] Timer tick, asking Buildbucket for the build status
[01:10:48.735] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:48.735] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:44:0) after 1m0s
[01:11:48.752] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:44:0)
[01:11:48.752] Timer tick, asking Buildbucket for the build status
[01:11:48.831] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:48.831] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:45:0) after 1m0s
[01:12:48.995] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:45:0)
[01:12:48.995] Timer tick, asking Buildbucket for the build status
[01:12:49.128] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:49.128] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:46:0) after 1m0s
[01:13:49.137] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:46:0)
[01:13:49.137] Timer tick, asking Buildbucket for the build status
[01:13:49.277] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:49.277] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:47:0) after 1m0s
[01:14:49.365] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:47:0)
[01:14:49.365] Timer tick, asking Buildbucket for the build status
[01:14:49.510] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:49.510] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:48:0) after 1m0s
[01:15:49.709] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:48:0)
[01:15:49.709] Timer tick, asking Buildbucket for the build status
[01:15:49.817] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:49.817] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:49:0) after 1m0s
[01:16:49.857] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:49:0)
[01:16:49.857] Timer tick, asking Buildbucket for the build status
[01:16:50.069] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:50.069] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:50:0) after 1m0s
[01:17:50.124] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:50:0)
[01:17:50.124] Timer tick, asking Buildbucket for the build status
[01:17:50.213] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:50.214] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:51:0) after 1m0s
[01:18:50.243] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:51:0)
[01:18:50.243] Timer tick, asking Buildbucket for the build status
[01:18:50.336] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:50.336] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:52:0) after 1m0s
[01:19:52.284] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:52:0)
[01:19:52.284] Timer tick, asking Buildbucket for the build status
[01:19:52.627] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:52.627] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:53:0) after 1m0s
[01:20:52.748] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:53:0)
[01:20:52.748] Timer tick, asking Buildbucket for the build status
[01:20:53.099] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:53.099] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:54:0) after 1m0s
[01:21:53.093] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:54:0)
[01:21:53.093] Timer tick, asking Buildbucket for the build status
[01:21:53.243] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:53.243] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:55:0) after 1m0s
[01:22:53.275] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:55:0)
[01:22:53.275] Timer tick, asking Buildbucket for the build status
[01:22:53.427] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:53.427] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:56:0) after 1m0s
[01:23:54.164] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:56:0)
[01:23:54.164] Timer tick, asking Buildbucket for the build status
[01:23:54.277] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:54.277] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:57:0) after 1m0s
[01:24:54.428] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:57:0)
[01:24:54.428] Timer tick, asking Buildbucket for the build status
[01:24:54.633] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:54.633] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:58:0) after 1m0s
[01:25:54.794] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:58:0)
[01:25:54.794] Timer tick, asking Buildbucket for the build status
[01:25:55.097] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:55.097] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:59:0) after 1m0s
[01:26:55.202] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:59:0)
[01:26:55.202] Timer tick, asking Buildbucket for the build status
[01:26:55.374] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:55.374] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:60:0) after 1m0s
[01:27:55.440] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:60:0)
[01:27:55.440] Timer tick, asking Buildbucket for the build status
[01:27:55.617] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:55.617] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:61:0) after 1m0s
[01:28:55.691] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:61:0)
[01:28:55.691] Timer tick, asking Buildbucket for the build status
[01:28:55.771] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:55.771] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:62:0) after 1m0s
[01:29:55.834] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:62:0)
[01:29:55.834] Timer tick, asking Buildbucket for the build status
[01:29:56.683] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:56.683] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:63:0) after 1m0s
[01:30:56.803] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:63:0)
[01:30:56.803] Timer tick, asking Buildbucket for the build status
[01:30:56.893] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:56.893] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:64:0) after 1m0s
[01:31:56.938] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:64:0)
[01:31:56.938] Timer tick, asking Buildbucket for the build status
[01:31:57.113] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:57.113] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:65:0) after 1m0s
[01:32:57.247] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:65:0)
[01:32:57.247] Timer tick, asking Buildbucket for the build status
[01:32:57.683] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:57.683] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:66:0) after 1m0s
[01:33:57.715] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:66:0)
[01:33:57.715] Timer tick, asking Buildbucket for the build status
[01:33:57.789] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:57.789] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:67:0) after 1m0s
[01:34:57.836] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:67:0)
[01:34:57.836] Timer tick, asking Buildbucket for the build status
[01:34:57.964] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:57.964] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:68:0) after 1m0s
[01:35:58.064] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:68:0)
[01:35:58.064] Timer tick, asking Buildbucket for the build status
[01:35:58.178] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:58.178] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:69:0) after 1m0s
[01:36:58.186] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:69:0)
[01:36:58.186] Timer tick, asking Buildbucket for the build status
[01:36:58.269] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:58.269] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:70:0) after 1m0s
[01:37:58.356] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:70:0)
[01:37:58.356] Timer tick, asking Buildbucket for the build status
[01:37:58.453] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:58.453] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:71:0) after 1m0s
[01:38:58.521] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:71:0)
[01:38:58.521] Timer tick, asking Buildbucket for the build status
[01:38:58.746] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:58.746] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:72:0) after 1m0s
[01:39:58.812] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:72:0)
[01:39:58.812] Timer tick, asking Buildbucket for the build status
[01:39:58.966] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:58.966] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:73:0) after 1m0s
[01:40:58.996] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:73:0)
[01:40:58.996] Timer tick, asking Buildbucket for the build status
[01:40:59.101] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:59.101] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:74:0) after 1m0s
[01:41:59.325] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:74:0)
[01:41:59.325] Timer tick, asking Buildbucket for the build status
[01:41:59.413] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:59.413] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:75:0) after 1m0s
[01:42:59.476] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:75:0)
[01:42:59.476] Timer tick, asking Buildbucket for the build status
[01:42:59.569] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:59.569] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:76:0) after 1m0s
[01:43:59.655] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:76:0)
[01:43:59.655] Timer tick, asking Buildbucket for the build status
[01:43:59.753] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:59.753] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:77:0) after 1m0s
[01:44:59.832] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:77:0)
[01:44:59.832] Timer tick, asking Buildbucket for the build status
[01:45:00.144] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:00.144] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:78:0) after 1m0s
[01:46:00.310] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:78:0)
[01:46:00.310] Timer tick, asking Buildbucket for the build status
[01:46:00.450] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:00.450] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:79:0) after 1m0s
[01:47:00.629] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:79:0)
[01:47:00.629] Timer tick, asking Buildbucket for the build status
[01:47:00.727] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:00.727] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:80:0) after 1m0s
[01:48:01.099] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:80:0)
[01:48:01.099] Timer tick, asking Buildbucket for the build status
[01:48:01.229] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:01.229] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:81:0) after 1m0s
[01:49:01.444] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:81:0)
[01:49:01.444] Timer tick, asking Buildbucket for the build status
[01:49:01.739] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:01.739] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:82:0) after 1m0s
[01:50:01.784] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:82:0)
[01:50:01.784] Timer tick, asking Buildbucket for the build status
[01:50:03.098] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:03.098] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:83:0) after 1m0s
[01:51:03.126] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:83:0)
[01:51:03.126] Timer tick, asking Buildbucket for the build status
[01:51:03.234] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:03.234] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:84:0) after 1m0s
[01:52:03.298] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:84:0)
[01:52:03.298] Timer tick, asking Buildbucket for the build status
[01:52:03.436] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:03.436] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:85:0) after 1m0s
[01:53:03.491] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:85:0)
[01:53:03.491] Timer tick, asking Buildbucket for the build status
[01:53:03.555] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:03.555] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:86:0) after 1m0s
[01:54:03.596] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:86:0)
[01:54:03.596] Timer tick, asking Buildbucket for the build status
[01:54:04.176] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:04.176] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:87:0) after 1m0s
[01:55:04.229] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:87:0)
[01:55:04.229] Timer tick, asking Buildbucket for the build status
[01:55:04.498] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:04.498] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:88:0) after 1m0s
[01:56:04.607] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:88:0)
[01:56:04.607] Timer tick, asking Buildbucket for the build status
[01:56:05.155] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:05.155] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:89:0) after 1m0s
[01:57:05.255] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:89:0)
[01:57:05.255] Timer tick, asking Buildbucket for the build status
[01:57:05.372] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:05.372] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:90:0) after 1m0s
[01:58:05.400] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:90:0)
[01:58:05.400] Timer tick, asking Buildbucket for the build status
[01:58:05.610] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:05.610] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:91:0) after 1m0s
[01:59:05.669] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:91:0)
[01:59:05.669] Timer tick, asking Buildbucket for the build status
[01:59:05.740] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:05.740] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:92:0) after 1m0s
[02:00:05.764] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:92:0)
[02:00:05.764] Timer tick, asking Buildbucket for the build status
[02:00:05.919] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:05.919] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:93:0) after 1m0s
[02:01:05.949] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:93:0)
[02:01:05.949] Timer tick, asking Buildbucket for the build status
[02:01:06.605] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:06.605] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:94:0) after 1m0s
[02:02:06.670] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:94:0)
[02:02:06.670] Timer tick, asking Buildbucket for the build status
[02:02:06.832] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:06.832] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:95:0) after 1m0s
[02:03:06.892] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:95:0)
[02:03:06.892] Timer tick, asking Buildbucket for the build status
[02:03:07.122] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:07.122] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:96:0) after 1m0s
[02:04:07.154] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:96:0)
[02:04:07.154] Timer tick, asking Buildbucket for the build status
[02:04:07.292] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:07.292] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:97:0) after 1m0s
[02:05:07.333] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:97:0)
[02:05:07.333] Timer tick, asking Buildbucket for the build status
[02:05:07.513] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:07.513] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:98:0) after 1m0s
[02:06:07.545] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:98:0)
[02:06:07.545] Timer tick, asking Buildbucket for the build status
[02:06:07.675] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:07.675] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:99:0) after 1m0s
[02:07:07.838] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:99:0)
[02:07:07.838] Timer tick, asking Buildbucket for the build status
[02:07:08.127] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:08.127] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:100:0) after 1m0s
[02:08:08.359] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:100:0)
[02:08:08.359] Timer tick, asking Buildbucket for the build status
[02:08:08.588] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:08.588] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:101:0) after 1m0s
[02:09:08.637] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:101:0)
[02:09:08.637] Timer tick, asking Buildbucket for the build status
[02:09:09.142] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:09.142] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:102:0) after 1m0s
[02:10:09.253] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:102:0)
[02:10:09.253] Timer tick, asking Buildbucket for the build status
[02:10:09.538] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:09.538] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:103:0) after 1m0s
[02:11:09.596] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:103:0)
[02:11:09.596] Timer tick, asking Buildbucket for the build status
[02:11:09.664] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:09.664] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:104:0) after 1m0s
[02:12:09.722] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:104:0)
[02:12:09.722] Timer tick, asking Buildbucket for the build status
[02:12:11.719] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:11.719] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:105:0) after 1m0s
[02:13:11.909] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:105:0)
[02:13:11.909] Timer tick, asking Buildbucket for the build status
[02:13:12.056] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:12.056] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:106:0) after 1m0s
[02:14:12.177] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:106:0)
[02:14:12.177] Timer tick, asking Buildbucket for the build status
[02:14:12.247] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:12.247] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:107:0) after 1m0s
[02:15:12.274] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:107:0)
[02:15:12.274] Timer tick, asking Buildbucket for the build status
[02:15:12.959] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:12.959] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:108:0) after 1m0s
[02:16:13.094] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:108:0)
[02:16:13.094] Timer tick, asking Buildbucket for the build status
[02:16:13.216] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:13.216] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:109:0) after 1m0s
[02:17:13.279] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:109:0)
[02:17:13.279] Timer tick, asking Buildbucket for the build status
[02:17:13.375] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:13.375] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:110:0) after 1m0s
[02:18:13.479] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:110:0)
[02:18:13.479] Timer tick, asking Buildbucket for the build status
[02:18:14.263] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:14.263] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:111:0) after 1m0s
[02:19:14.337] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:111:0)
[02:19:14.337] Timer tick, asking Buildbucket for the build status
[02:19:15.094] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:15.094] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:112:0) after 1m0s
[02:20:15.187] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:112:0)
[02:20:15.187] Timer tick, asking Buildbucket for the build status
[02:20:15.345] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:15.345] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:113:0) after 1m0s
[02:21:15.428] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:113:0)
[02:21:15.428] Timer tick, asking Buildbucket for the build status
[02:21:15.615] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:15.615] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:114:0) after 1m0s
[02:22:15.789] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:114:0)
[02:22:15.789] Timer tick, asking Buildbucket for the build status
[02:22:15.887] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:15.887] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:115:0) after 1m0s
[02:23:15.953] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:115:0)
[02:23:15.953] Timer tick, asking Buildbucket for the build status
[02:23:16.093] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:16.093] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:116:0) after 1m0s
[02:24:16.151] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:116:0)
[02:24:16.151] Timer tick, asking Buildbucket for the build status
[02:24:16.280] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:16.280] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:117:0) after 1m0s
[02:25:16.373] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:117:0)
[02:25:16.373] Timer tick, asking Buildbucket for the build status
[02:25:16.599] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:16.600] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:118:0) after 1m0s
[02:26:16.664] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:118:0)
[02:26:16.664] Timer tick, asking Buildbucket for the build status
[02:26:16.753] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:16.753] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:119:0) after 1m0s
[02:27:16.802] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:119:0)
[02:27:16.802] Timer tick, asking Buildbucket for the build status
[02:27:16.875] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:16.875] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:120:0) after 1m0s
[02:28:16.964] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:120:0)
[02:28:16.964] Timer tick, asking Buildbucket for the build status
[02:28:17.040] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:17.040] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:121:0) after 1m0s
[02:29:17.088] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:121:0)
[02:29:17.088] Timer tick, asking Buildbucket for the build status
[02:29:17.195] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:17.195] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:122:0) after 1m0s
[02:30:17.394] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:122:0)
[02:30:17.394] Timer tick, asking Buildbucket for the build status
[02:30:17.611] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:17.611] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:123:0) after 1m0s
[02:31:17.744] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:123:0)
[02:31:17.744] Timer tick, asking Buildbucket for the build status
[02:31:17.856] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:17.856] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:124:0) after 1m0s
[02:32:18.006] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:124:0)
[02:32:18.006] Timer tick, asking Buildbucket for the build status
[02:32:18.073] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:18.073] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:125:0) after 1m0s
[02:33:18.391] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:125:0)
[02:33:18.391] Timer tick, asking Buildbucket for the build status
[02:33:18.794] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:18.794] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:126:0) after 1m0s
[02:34:18.979] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:126:0)
[02:34:18.979] Timer tick, asking Buildbucket for the build status
[02:34:19.660] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:19.660] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:127:0) after 1m0s
[02:35:19.660] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:127:0)
[02:35:19.660] Timer tick, asking Buildbucket for the build status
[02:35:19.983] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:19.983] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:128:0) after 1m0s
[02:36:20.691] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:128:0)
[02:36:20.691] Timer tick, asking Buildbucket for the build status
[02:36:20.781] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:20.782] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:129:0) after 1m0s
[02:37:21.420] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:129:0)
[02:37:21.420] Timer tick, asking Buildbucket for the build status
[02:37:21.805] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:21.805] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:130:0) after 1m0s
[02:38:21.914] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:130:0)
[02:38:21.914] Timer tick, asking Buildbucket for the build status
[02:38:22.043] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:22.043] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:131:0) after 1m0s
[02:39:22.146] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:131:0)
[02:39:22.146] Timer tick, asking Buildbucket for the build status
[02:39:22.246] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:22.246] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:132:0) after 1m0s
[02:40:22.333] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:132:0)
[02:40:22.333] Timer tick, asking Buildbucket for the build status
[02:40:22.500] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:22.500] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:133:0) after 1m0s
[02:41:22.625] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:133:0)
[02:41:22.625] Timer tick, asking Buildbucket for the build status
[02:41:23.359] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:23.359] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:134:0) after 1m0s
[02:42:23.442] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:134:0)
[02:42:23.442] Timer tick, asking Buildbucket for the build status
[02:42:24.111] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:24.111] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:135:0) after 1m0s
[02:43:24.205] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:135:0)
[02:43:24.205] Timer tick, asking Buildbucket for the build status
[02:43:24.295] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:24.296] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:136:0) after 1m0s
[02:44:24.469] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:136:0)
[02:44:24.469] Timer tick, asking Buildbucket for the build status
[02:44:24.600] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:24.600] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:137:0) after 1m0s
[02:45:24.716] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:137:0)
[02:45:24.716] Timer tick, asking Buildbucket for the build status
[02:45:24.871] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:24.871] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:138:0) after 1m0s
[02:46:24.998] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:138:0)
[02:46:24.998] Timer tick, asking Buildbucket for the build status
[02:46:25.797] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:25.797] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:139:0) after 1m0s
[02:47:25.818] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:139:0)
[02:47:25.818] Timer tick, asking Buildbucket for the build status
[02:47:26.170] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:26.170] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:140:0) after 1m0s
[02:48:26.232] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:140:0)
[02:48:26.232] Timer tick, asking Buildbucket for the build status
[02:48:26.417] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:26.417] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:141:0) after 1m0s
[02:49:26.446] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:141:0)
[02:49:26.446] Timer tick, asking Buildbucket for the build status
[02:49:26.702] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:26.702] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:142:0) after 1m0s
[02:50:26.794] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:142:0)
[02:50:26.794] Timer tick, asking Buildbucket for the build status
[02:50:27.010] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:27.011] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:143:0) after 1m0s
[02:51:27.056] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:143:0)
[02:51:27.056] Timer tick, asking Buildbucket for the build status
[02:51:27.152] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:27.152] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:144:0) after 1m0s
[02:52:27.227] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:144:0)
[02:52:27.227] Timer tick, asking Buildbucket for the build status
[02:52:27.417] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:27.417] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:145:0) after 1m0s
[02:53:27.449] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:145:0)
[02:53:27.449] Timer tick, asking Buildbucket for the build status
[02:53:27.535] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:27.535] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:146:0) after 1m0s
[02:54:27.590] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:146:0)
[02:54:27.590] Timer tick, asking Buildbucket for the build status
[02:54:27.678] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:27.678] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:147:0) after 1m0s
[02:55:27.787] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:147:0)
[02:55:27.787] Timer tick, asking Buildbucket for the build status
[02:55:28.241] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:28.241] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:148:0) after 1m0s
[02:56:28.271] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:148:0)
[02:56:28.271] Timer tick, asking Buildbucket for the build status
[02:56:28.362] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:28.362] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:149:0) after 1m0s
[02:57:28.405] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:149:0)
[02:57:28.405] Timer tick, asking Buildbucket for the build status
[02:57:28.471] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:28.471] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:150:0) after 1m0s
[02:58:28.506] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:150:0)
[02:58:28.506] Timer tick, asking Buildbucket for the build status
[02:58:28.608] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:28.608] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:151:0) after 1m0s
[02:59:28.705] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:151:0)
[02:59:28.705] Timer tick, asking Buildbucket for the build status
[02:59:28.793] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:28.793] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:152:0) after 1m0s
[03:00:28.869] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:152:0)
[03:00:28.869] Timer tick, asking Buildbucket for the build status
[03:00:29.075] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:29.075] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:153:0) after 1m0s
[03:01:29.159] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:153:0)
[03:01:29.159] Timer tick, asking Buildbucket for the build status
[03:01:29.257] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:29.257] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:154:0) after 1m0s
[03:02:29.323] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:154:0)
[03:02:29.323] Timer tick, asking Buildbucket for the build status
[03:02:29.817] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:29.817] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:155:0) after 1m0s
[03:03:30.143] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:155:0)
[03:03:30.143] Timer tick, asking Buildbucket for the build status
[03:03:30.263] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:30.263] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:156:0) after 1m0s
[03:04:30.876] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:156:0)
[03:04:30.876] Timer tick, asking Buildbucket for the build status
[03:04:31.017] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:31.017] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:157:0) after 1m0s
[03:05:31.163] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:157:0)
[03:05:31.164] Timer tick, asking Buildbucket for the build status
[03:05:31.278] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:31.278] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:158:0) after 1m0s
[03:06:31.401] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:158:0)
[03:06:31.401] Timer tick, asking Buildbucket for the build status
[03:06:31.477] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:31.477] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:159:0) after 1m0s
[03:07:31.578] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:159:0)
[03:07:31.578] Timer tick, asking Buildbucket for the build status
[03:07:31.674] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:31.674] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:160:0) after 1m0s
[03:08:31.707] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:160:0)
[03:08:31.707] Timer tick, asking Buildbucket for the build status
[03:08:32.000] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:32.000] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:161:0) after 1m0s
[03:09:32.064] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:161:0)
[03:09:32.064] Timer tick, asking Buildbucket for the build status
[03:09:32.213] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:32.213] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:162:0) after 1m0s
[03:10:32.255] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:162:0)
[03:10:32.255] Timer tick, asking Buildbucket for the build status
[03:10:32.656] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:32.656] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:163:0) after 1m0s
[03:11:32.690] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:163:0)
[03:11:32.691] Timer tick, asking Buildbucket for the build status
[03:11:32.764] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:32.764] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:164:0) after 1m0s
[03:12:32.855] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:164:0)
[03:12:32.855] Timer tick, asking Buildbucket for the build status
[03:12:33.380] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:33.380] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:165:0) after 1m0s
[03:13:33.525] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:165:0)
[03:13:33.525] Timer tick, asking Buildbucket for the build status
[03:13:33.615] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:33.615] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:166:0) after 1m0s
[03:14:33.668] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:166:0)
[03:14:33.668] Timer tick, asking Buildbucket for the build status
[03:14:33.802] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:33.802] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:167:0) after 1m0s
[03:15:33.866] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:167:0)
[03:15:33.866] Timer tick, asking Buildbucket for the build status
[03:15:34.281] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:34.281] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:168:0) after 1m0s
[03:16:34.359] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:168:0)
[03:16:34.359] Timer tick, asking Buildbucket for the build status
[03:16:34.528] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:34.528] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:169:0) after 1m0s
[03:17:34.598] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:169:0)
[03:17:34.598] Timer tick, asking Buildbucket for the build status
[03:17:34.676] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:34.676] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:170:0) after 1m0s
[03:18:34.705] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:170:0)
[03:18:34.705] Timer tick, asking Buildbucket for the build status
[03:18:35.599] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:35.599] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:171:0) after 1m0s
[03:19:35.677] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:171:0)
[03:19:35.677] Timer tick, asking Buildbucket for the build status
[03:19:35.757] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:35.757] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:172:0) after 1m0s
[03:20:35.842] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:172:0)
[03:20:35.842] Timer tick, asking Buildbucket for the build status
[03:20:36.045] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:36.045] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:173:0) after 1m0s
[03:21:36.110] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:173:0)
[03:21:36.110] Timer tick, asking Buildbucket for the build status
[03:21:36.181] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:36.181] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:174:0) after 1m0s
[03:22:36.216] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:174:0)
[03:22:36.216] Timer tick, asking Buildbucket for the build status
[03:22:36.297] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:36.297] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:175:0) after 1m0s
[03:23:36.391] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:175:0)
[03:23:36.391] Timer tick, asking Buildbucket for the build status
[03:23:36.736] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:36.736] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:176:0) after 1m0s
[03:24:36.773] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:176:0)
[03:24:36.773] Timer tick, asking Buildbucket for the build status
[03:24:36.858] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:36.858] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:177:0) after 1m0s
[03:25:36.901] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:177:0)
[03:25:36.901] Timer tick, asking Buildbucket for the build status
[03:25:37.142] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:37.142] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:178:0) after 1m0s
[03:26:37.210] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:178:0)
[03:26:37.210] Timer tick, asking Buildbucket for the build status
[03:26:37.320] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:37.320] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:179:0) after 1m0s
[03:27:37.381] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:179:0)
[03:27:37.381] Timer tick, asking Buildbucket for the build status
[03:27:37.460] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:37.460] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:180:0) after 1m0s
[03:28:37.492] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:180:0)
[03:28:37.492] Timer tick, asking Buildbucket for the build status
[03:28:37.580] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:37.580] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:181:0) after 1m0s
[03:29:37.711] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:181:0)
[03:29:37.711] Timer tick, asking Buildbucket for the build status
[03:29:37.900] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:37.900] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:182:0) after 1m0s
[03:30:37.972] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:182:0)
[03:30:37.972] Timer tick, asking Buildbucket for the build status
[03:30:38.137] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:38.137] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:183:0) after 1m0s
[03:31:38.212] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:183:0)
[03:31:38.212] Timer tick, asking Buildbucket for the build status
[03:31:38.283] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:38.283] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:184:0) after 1m0s
[03:32:38.437] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:184:0)
[03:32:38.437] Timer tick, asking Buildbucket for the build status
[03:32:38.534] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:38.534] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:185:0) after 1m0s
[03:33:38.622] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:185:0)
[03:33:38.622] Timer tick, asking Buildbucket for the build status
[03:33:38.706] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:38.706] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:186:0) after 1m0s
[03:34:38.861] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:186:0)
[03:34:38.861] Timer tick, asking Buildbucket for the build status
[03:34:38.944] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:38.944] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:187:0) after 1m0s
[03:35:39.151] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:187:0)
[03:35:39.151] Timer tick, asking Buildbucket for the build status
[03:35:39.365] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:39.365] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:188:0) after 1m0s
[03:36:39.464] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:188:0)
[03:36:39.464] Timer tick, asking Buildbucket for the build status
[03:36:39.544] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:39.544] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:189:0) after 1m0s
[03:37:39.707] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:189:0)
[03:37:39.707] Timer tick, asking Buildbucket for the build status
[03:37:39.977] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:39.977] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:190:0) after 1m0s
[03:38:40.517] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:190:0)
[03:38:40.517] Timer tick, asking Buildbucket for the build status
[03:38:40.704] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:40.704] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:191:0) after 1m0s
[03:39:40.807] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:191:0)
[03:39:40.807] Timer tick, asking Buildbucket for the build status
[03:39:40.940] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:40.940] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:192:0) after 1m0s
[03:40:41.017] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:192:0)
[03:40:41.017] Timer tick, asking Buildbucket for the build status
[03:40:41.157] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:41.157] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:193:0) after 1m0s
[03:41:41.242] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:193:0)
[03:41:41.242] Timer tick, asking Buildbucket for the build status
[03:41:41.498] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:41.498] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:194:0) after 1m0s
[03:42:41.579] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:194:0)
[03:42:41.579] Timer tick, asking Buildbucket for the build status
[03:42:44.293] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:44.293] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:195:0) after 1m0s
[03:43:44.378] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:195:0)
[03:43:44.378] Timer tick, asking Buildbucket for the build status
[03:43:44.474] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:44.474] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:196:0) after 1m0s
[03:44:44.571] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:196:0)
[03:44:44.571] Timer tick, asking Buildbucket for the build status
[03:44:44.722] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:44.722] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:197:0) after 1m0s
[03:45:44.873] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:197:0)
[03:45:44.873] Timer tick, asking Buildbucket for the build status
[03:45:44.963] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:44.963] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:198:0) after 1m0s
[03:46:45.057] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:198:0)
[03:46:45.057] Timer tick, asking Buildbucket for the build status
[03:46:45.162] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:45.163] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:199:0) after 1m0s
[03:47:45.251] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:199:0)
[03:47:45.251] Timer tick, asking Buildbucket for the build status
[03:47:45.492] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:45.492] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:200:0) after 1m0s
[03:48:45.591] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:200:0)
[03:48:45.591] Timer tick, asking Buildbucket for the build status
[03:48:45.920] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:45.920] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:201:0) after 1m0s
[03:49:46.130] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:201:0)
[03:49:46.130] Timer tick, asking Buildbucket for the build status
[03:49:46.284] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:46.284] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:202:0) after 1m0s
[03:50:46.360] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:202:0)
[03:50:46.360] Timer tick, asking Buildbucket for the build status
[03:50:46.452] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:46.452] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:203:0) after 1m0s
[03:51:46.513] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:203:0)
[03:51:46.513] Timer tick, asking Buildbucket for the build status
[03:51:46.681] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:46.681] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:204:0) after 1m0s
[03:52:46.763] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:204:0)
[03:52:46.763] Timer tick, asking Buildbucket for the build status
[03:52:46.842] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:46.843] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:205:0) after 1m0s
[03:53:46.924] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:205:0)
[03:53:46.924] Timer tick, asking Buildbucket for the build status
[03:53:47.006] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:47.006] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:206:0) after 1m0s
[03:54:47.112] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:206:0)
[03:54:47.112] Timer tick, asking Buildbucket for the build status
[03:54:47.231] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:47.231] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:207:0) after 1m0s
[03:55:47.326] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:207:0)
[03:55:47.326] Timer tick, asking Buildbucket for the build status
[03:55:47.466] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:47.466] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:208:0) after 1m0s
[03:56:47.690] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:208:0)
[03:56:47.690] Timer tick, asking Buildbucket for the build status
[03:56:47.787] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:47.787] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:209:0) after 1m0s
[03:57:47.822] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:209:0)
[03:57:47.822] Timer tick, asking Buildbucket for the build status
[03:57:47.932] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:47.932] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:210:0) after 1m0s
[03:58:48.093] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:210:0)
[03:58:48.093] Timer tick, asking Buildbucket for the build status
[03:58:48.170] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:48.170] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:211:0) after 1m0s
[03:59:48.225] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:211:0)
[03:59:48.226] Timer tick, asking Buildbucket for the build status
[03:59:48.561] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:48.561] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:212:0) after 1m0s
[04:00:48.697] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:212:0)
[04:00:48.697] Timer tick, asking Buildbucket for the build status
[04:00:48.903] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:48.903] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:213:0) after 1m0s
[04:01:49.112] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:213:0)
[04:01:49.112] Timer tick, asking Buildbucket for the build status
[04:01:49.448] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:49.448] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:214:0) after 1m0s
[04:02:49.435] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:214:0)
[04:02:49.436] Timer tick, asking Buildbucket for the build status
[04:02:49.584] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:49.584] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:215:0) after 1m0s
[04:03:50.162] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:215:0)
[04:03:50.162] Timer tick, asking Buildbucket for the build status
[04:03:50.323] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:50.323] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:216:0) after 1m0s
[04:04:50.845] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:216:0)
[04:04:50.845] Timer tick, asking Buildbucket for the build status
[04:04:51.371] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:51.371] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:217:0) after 1m0s
[04:05:51.470] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:217:0)
[04:05:51.470] Timer tick, asking Buildbucket for the build status
[04:05:51.549] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:51.549] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:218:0) after 1m0s
[04:06:51.742] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:218:0)
[04:06:51.742] Timer tick, asking Buildbucket for the build status
[04:06:51.931] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:51.931] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:219:0) after 1m0s
[04:07:52.136] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:219:0)
[04:07:52.136] Timer tick, asking Buildbucket for the build status
[04:07:52.221] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:52.221] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:220:0) after 1m0s
[04:08:52.404] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:220:0)
[04:08:52.404] Timer tick, asking Buildbucket for the build status
[04:08:52.698] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:52.698] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:221:0) after 1m0s
[04:09:52.779] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:221:0)
[04:09:52.779] Timer tick, asking Buildbucket for the build status
[04:09:53.190] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:53.190] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:222:0) after 1m0s
[04:10:53.255] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:222:0)
[04:10:53.255] Timer tick, asking Buildbucket for the build status
[04:10:53.571] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:53.571] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:223:0) after 1m0s
[04:11:53.597] Handling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:223:0)
[04:11:53.597] Timer tick, asking Buildbucket for the build status
[04:11:53.669] Build 8872306934175380192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:53.669] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9037736996162787120:224:0) after 1m0s
[04:12:35.855] Received PubSub notification, asking Buildbucket for the build status
[04:12:35.930] Build 8872306934175380192: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[04:12:35.931] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1597119155077973",
"created_by": "project:chromium",
"created_ts": "1597105771811136",
"id": "8872306934175380192",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"46daab5a64cf5b23b9b4aa4a8ac2681240480d59\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/chromium_tests\": {\"bucketed_triggers\": true}, \"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$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-0-j9yd\", \"branch\": \"refs/heads/master\", \"buildername\": \"win-official\", \"buildnumber\": 312, \"got_angle_revision\": \"559d54d0807eb6d1ae98f44f3bf5c8e160a61e59\", \"got_dawn_revision\": \"ccf01e74ec70fc0b5edc9a0dd87f902b6388afce\", \"got_nacl_revision\": \"3008f9e6de122325d8f9dbf02f7cdd51fa1ec306\", \"got_revision\": \"46daab5a64cf5b23b9b4aa4a8ac2681240480d59\", \"got_revision_cp\": \"refs/heads/master@{#796640}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"59b4828f293eb16f8983ae9ea0a8a0a84cf8174c\", \"got_v8_revision\": \"4f52dde736e657ac01cf74a6cdc38c752f9a5dae\", \"got_v8_revision_cp\": \"refs/heads/8.6.337@{#1}\", \"got_webrtc_revision\": \"582102c9b7f48f6ccad956fe17241668a90cb3fc\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31892}\", \"mastername\": \"chromium\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"46daab5a64cf5b23b9b4aa4a8ac2681240480d59\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_9b3ebe5fd1c5be87380c40d216747346a59b28cf26de183f0e8e2b32e944d3c8_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-0-j9yd\"], \"image\": [\"chrome-win10-1703-20073100-2eb11ddbc6e\"], \"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\": [\"5472-d0af7f3\"], \"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": "1597105831669183",
"status": "COMPLETED",
"status_changed_ts": "1597119155502943",
"tags": [
"build_address:luci.chromium.ci/win-official/312",
"builder:win-official",
"buildset:commit/git/46daab5a64cf5b23b9b4aa4a8ac2681240480d59",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/46daab5a64cf5b23b9b4aa4a8ac2681240480d59",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9037736996162787120",
"scheduler_job_id:chromium/win-official",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8872306934175380192/+/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:4df3bda21009e110",
"user_agent:luci-scheduler"
],
"updated_ts": "1597119155507717",
"url": "https://ci.chromium.org/b/8872306934175380192",
"utcnow_ts": "1597119155922262"
}
}
[04:12:35.931] Invocation finished in 3h43m5.398912771s with status SUCCEEDED