[04:50:34.097] New invocation is queued and will start shortly
[04:50:35.119] Starting the invocation (attempt 1)
[04:50:35.152] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:50:35.152] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:50:35.152] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018966999695161184",
"parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"2abedeb596d2b0bed8bc8a5e02bab506aa843b1a\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-official",
"scheduler_invocation_id:9018966999695161184",
"scheduler_job_id:chromium/win-official",
"user_agent:luci-scheduler",
"buildset:commit/git/2abedeb596d2b0bed8bc8a5e02bab506aa843b1a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2abedeb596d2b0bed8bc8a5e02bab506aa843b1a",
"gitiles_ref:refs/heads/master"
]
}
[04:50:35.802] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615006235293370",
"id": "8853536937779812496",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2abedeb596d2b0bed8bc8a5e02bab506aa843b1a\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615006235617834",
"tags": [
"build_address:luci.chromium.ci/win-official/1698",
"builder:win-official",
"buildset:commit/git/2abedeb596d2b0bed8bc8a5e02bab506aa843b1a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2abedeb596d2b0bed8bc8a5e02bab506aa843b1a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018966999695161184",
"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/8853536937779812496/+/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": "1615006235617985",
"url": "https://ci.chromium.org/b/8853536937779812496",
"utcnow_ts": "1615006235752284"
}
}
[04:50:35.802] Task URL: https://ci.chromium.org/b/8853536937779812496
[04:50:35.802] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:2:0) after 1m0s
[04:50:38.792] Received PubSub notification, asking Buildbucket for the build status
[04:50:38.868] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:35.985] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:2:0)
[04:51:35.985] Timer tick, asking Buildbucket for the build status
[04:51:36.058] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:36.058] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:4:0) after 1m0s
[04:52:36.110] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:4:0)
[04:52:36.110] Timer tick, asking Buildbucket for the build status
[04:52:36.327] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:36.327] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:5:0) after 1m0s
[04:53:36.377] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:5:0)
[04:53:36.377] Timer tick, asking Buildbucket for the build status
[04:53:36.625] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:36.625] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:6:0) after 1m0s
[04:54:36.677] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:6:0)
[04:54:36.677] Timer tick, asking Buildbucket for the build status
[04:54:36.756] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:36.756] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:7:0) after 1m0s
[04:55:36.781] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:7:0)
[04:55:36.781] Timer tick, asking Buildbucket for the build status
[04:55:36.861] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:36.861] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:8:0) after 1m0s
[04:56:36.919] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:8:0)
[04:56:36.919] Timer tick, asking Buildbucket for the build status
[04:56:36.984] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:36.984] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:9:0) after 1m0s
[04:57:37.002] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:9:0)
[04:57:37.002] Timer tick, asking Buildbucket for the build status
[04:57:37.113] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:37.113] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:10:0) after 1m0s
[04:58:37.144] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:10:0)
[04:58:37.144] Timer tick, asking Buildbucket for the build status
[04:58:37.250] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:37.250] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:11:0) after 1m0s
[04:59:37.269] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:11:0)
[04:59:37.269] Timer tick, asking Buildbucket for the build status
[04:59:37.415] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:37.415] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:12:0) after 1m0s
[05:00:37.442] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:12:0)
[05:00:37.442] Timer tick, asking Buildbucket for the build status
[05:00:37.581] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:37.582] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:13:0) after 1m0s
[05:01:37.550] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:13:0)
[05:01:37.550] Timer tick, asking Buildbucket for the build status
[05:01:37.625] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:37.625] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:14:0) after 1m0s
[05:02:37.647] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:14:0)
[05:02:37.647] Timer tick, asking Buildbucket for the build status
[05:02:37.714] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:37.714] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:15:0) after 1m0s
[05:03:37.802] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:15:0)
[05:03:37.802] Timer tick, asking Buildbucket for the build status
[05:03:37.908] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:37.909] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:16:0) after 1m0s
[05:04:37.933] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:16:0)
[05:04:37.933] Timer tick, asking Buildbucket for the build status
[05:04:38.094] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:38.094] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:17:0) after 1m0s
[05:05:38.124] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:17:0)
[05:05:38.124] Timer tick, asking Buildbucket for the build status
[05:05:38.223] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:38.223] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:18:0) after 1m0s
[05:06:38.365] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:18:0)
[05:06:38.365] Timer tick, asking Buildbucket for the build status
[05:06:38.438] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:38.438] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:19:0) after 1m0s
[05:07:38.468] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:19:0)
[05:07:38.468] Timer tick, asking Buildbucket for the build status
[05:07:38.560] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:38.560] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:20:0) after 1m0s
[05:08:38.643] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:20:0)
[05:08:38.643] Timer tick, asking Buildbucket for the build status
[05:08:38.903] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:38.903] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:21:0) after 1m0s
[05:09:39.030] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:21:0)
[05:09:39.030] Timer tick, asking Buildbucket for the build status
[05:09:39.110] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:39.110] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:22:0) after 1m0s
[05:10:39.280] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:22:0)
[05:10:39.280] Timer tick, asking Buildbucket for the build status
[05:10:39.405] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:39.405] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:23:0) after 1m0s
[05:11:39.504] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:23:0)
[05:11:39.504] Timer tick, asking Buildbucket for the build status
[05:11:39.776] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:39.776] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:24:0) after 1m0s
[05:12:39.855] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:24:0)
[05:12:39.855] Timer tick, asking Buildbucket for the build status
[05:12:39.939] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:39.939] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:25:0) after 1m0s
[05:13:40.060] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:25:0)
[05:13:40.060] Timer tick, asking Buildbucket for the build status
[05:13:40.131] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:40.132] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:26:0) after 1m0s
[05:14:40.213] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:26:0)
[05:14:40.213] Timer tick, asking Buildbucket for the build status
[05:14:40.293] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:40.293] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:27:0) after 1m0s
[05:15:40.309] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:27:0)
[05:15:40.309] Timer tick, asking Buildbucket for the build status
[05:15:40.471] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:40.471] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:28:0) after 1m0s
[05:16:40.504] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:28:0)
[05:16:40.504] Timer tick, asking Buildbucket for the build status
[05:16:40.580] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:40.580] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:29:0) after 1m0s
[05:17:40.691] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:29:0)
[05:17:40.691] Timer tick, asking Buildbucket for the build status
[05:17:40.775] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:40.775] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:30:0) after 1m0s
[05:18:40.807] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:30:0)
[05:18:40.807] Timer tick, asking Buildbucket for the build status
[05:18:40.869] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:40.869] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:31:0) after 1m0s
[05:19:40.889] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:31:0)
[05:19:40.889] Timer tick, asking Buildbucket for the build status
[05:19:40.953] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:40.953] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:32:0) after 1m0s
[05:20:40.992] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:32:0)
[05:20:40.992] Timer tick, asking Buildbucket for the build status
[05:20:41.072] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:41.072] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:33:0) after 1m0s
[05:21:41.091] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:33:0)
[05:21:41.091] Timer tick, asking Buildbucket for the build status
[05:21:41.228] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:41.228] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:34:0) after 1m0s
[05:22:41.246] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:34:0)
[05:22:41.246] Timer tick, asking Buildbucket for the build status
[05:22:41.341] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:41.341] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:35:0) after 1m0s
[05:23:41.315] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:35:0)
[05:23:41.315] Timer tick, asking Buildbucket for the build status
[05:23:41.627] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:41.627] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:36:0) after 1m0s
[05:24:41.673] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:36:0)
[05:24:41.673] Timer tick, asking Buildbucket for the build status
[05:24:41.732] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:41.732] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:37:0) after 1m0s
[05:25:41.727] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:37:0)
[05:25:41.727] Timer tick, asking Buildbucket for the build status
[05:25:41.799] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:41.799] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:38:0) after 1m0s
[05:26:41.818] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:38:0)
[05:26:41.818] Timer tick, asking Buildbucket for the build status
[05:26:41.939] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:41.939] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:39:0) after 1m0s
[05:27:41.958] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:39:0)
[05:27:41.958] Timer tick, asking Buildbucket for the build status
[05:27:42.029] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:42.029] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:40:0) after 1m0s
[05:28:42.116] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:40:0)
[05:28:42.116] Timer tick, asking Buildbucket for the build status
[05:28:42.178] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:42.179] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:41:0) after 1m0s
[05:29:42.234] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:41:0)
[05:29:42.234] Timer tick, asking Buildbucket for the build status
[05:29:42.304] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:42.304] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:42:0) after 1m0s
[05:30:42.319] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:42:0)
[05:30:42.319] Timer tick, asking Buildbucket for the build status
[05:30:42.450] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:42.450] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:43:0) after 1m0s
[05:31:42.492] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:43:0)
[05:31:42.493] Timer tick, asking Buildbucket for the build status
[05:31:42.571] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:42.571] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:44:0) after 1m0s
[05:32:42.635] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:44:0)
[05:32:42.635] Timer tick, asking Buildbucket for the build status
[05:32:42.818] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:42.818] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:45:0) after 1m0s
[05:33:42.838] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:45:0)
[05:33:42.838] Timer tick, asking Buildbucket for the build status
[05:33:42.911] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:42.911] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:46:0) after 1m0s
[05:34:42.904] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:46:0)
[05:34:42.904] Timer tick, asking Buildbucket for the build status
[05:34:42.975] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:42.975] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:47:0) after 1m0s
[05:35:42.979] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:47:0)
[05:35:42.979] Timer tick, asking Buildbucket for the build status
[05:35:43.113] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:43.113] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:48:0) after 1m0s
[05:36:43.162] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:48:0)
[05:36:43.162] Timer tick, asking Buildbucket for the build status
[05:36:43.229] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:43.229] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:49:0) after 1m0s
[05:37:43.248] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:49:0)
[05:37:43.248] Timer tick, asking Buildbucket for the build status
[05:37:43.316] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:43.316] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:50:0) after 1m0s
[05:38:43.423] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:50:0)
[05:38:43.423] Timer tick, asking Buildbucket for the build status
[05:38:43.485] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:43.485] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:51:0) after 1m0s
[05:39:43.480] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:51:0)
[05:39:43.480] Timer tick, asking Buildbucket for the build status
[05:39:43.655] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:43.655] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:52:0) after 1m0s
[05:40:43.708] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:52:0)
[05:40:43.708] Timer tick, asking Buildbucket for the build status
[05:40:44.052] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:44.052] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:53:0) after 1m0s
[05:41:44.109] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:53:0)
[05:41:44.109] Timer tick, asking Buildbucket for the build status
[05:41:44.606] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:44.606] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:54:0) after 1m0s
[05:42:44.674] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:54:0)
[05:42:44.674] Timer tick, asking Buildbucket for the build status
[05:42:44.761] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:44.761] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:55:0) after 1m0s
[05:43:44.778] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:55:0)
[05:43:44.778] Timer tick, asking Buildbucket for the build status
[05:43:44.856] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:44.856] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:56:0) after 1m0s
[05:44:44.950] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:56:0)
[05:44:44.950] Timer tick, asking Buildbucket for the build status
[05:44:45.205] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:45.205] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:57:0) after 1m0s
[05:45:45.280] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:57:0)
[05:45:45.281] Timer tick, asking Buildbucket for the build status
[05:45:46.060] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:46.060] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:58:0) after 1m0s
[05:46:46.131] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:58:0)
[05:46:46.131] Timer tick, asking Buildbucket for the build status
[05:46:46.215] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:46.215] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:59:0) after 1m0s
[05:47:46.260] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:59:0)
[05:47:46.260] Timer tick, asking Buildbucket for the build status
[05:47:46.662] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:46.662] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:60:0) after 1m0s
[05:48:46.734] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:60:0)
[05:48:46.734] Timer tick, asking Buildbucket for the build status
[05:48:46.815] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:46.815] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:61:0) after 1m0s
[05:49:46.836] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:61:0)
[05:49:46.836] Timer tick, asking Buildbucket for the build status
[05:49:46.905] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:46.905] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:62:0) after 1m0s
[05:50:46.984] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:62:0)
[05:50:46.984] Timer tick, asking Buildbucket for the build status
[05:50:47.165] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:47.165] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:63:0) after 1m0s
[05:51:47.174] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:63:0)
[05:51:47.174] Timer tick, asking Buildbucket for the build status
[05:51:47.346] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:47.346] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:64:0) after 1m0s
[05:52:47.374] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:64:0)
[05:52:47.374] Timer tick, asking Buildbucket for the build status
[05:52:47.454] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:47.454] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:65:0) after 1m0s
[05:53:47.473] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:65:0)
[05:53:47.473] Timer tick, asking Buildbucket for the build status
[05:53:47.547] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:47.547] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:66:0) after 1m0s
[05:54:47.597] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:66:0)
[05:54:47.597] Timer tick, asking Buildbucket for the build status
[05:54:47.665] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:47.665] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:67:0) after 1m0s
[05:55:47.693] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:67:0)
[05:55:47.693] Timer tick, asking Buildbucket for the build status
[05:55:47.768] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:47.768] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:68:0) after 1m0s
[05:56:47.768] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:68:0)
[05:56:47.768] Timer tick, asking Buildbucket for the build status
[05:56:47.856] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:47.856] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:69:0) after 1m0s
[05:57:47.875] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:69:0)
[05:57:47.875] Timer tick, asking Buildbucket for the build status
[05:57:47.953] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:47.953] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:70:0) after 1m0s
[05:58:47.970] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:70:0)
[05:58:47.970] Timer tick, asking Buildbucket for the build status
[05:58:48.034] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:48.034] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:71:0) after 1m0s
[05:59:48.055] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:71:0)
[05:59:48.055] Timer tick, asking Buildbucket for the build status
[05:59:48.117] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:48.117] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:72:0) after 1m0s
[06:00:48.127] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:72:0)
[06:00:48.127] Timer tick, asking Buildbucket for the build status
[06:00:48.324] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:48.324] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:73:0) after 1m0s
[06:01:48.395] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:73:0)
[06:01:48.395] Timer tick, asking Buildbucket for the build status
[06:01:48.549] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:48.549] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:74:0) after 1m0s
[06:02:48.559] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:74:0)
[06:02:48.559] Timer tick, asking Buildbucket for the build status
[06:02:48.628] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:48.628] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:75:0) after 1m0s
[06:03:48.693] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:75:0)
[06:03:48.693] Timer tick, asking Buildbucket for the build status
[06:03:48.772] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:48.772] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:76:0) after 1m0s
[06:04:48.818] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:76:0)
[06:04:48.818] Timer tick, asking Buildbucket for the build status
[06:04:49.005] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:49.005] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:77:0) after 1m0s
[06:05:49.026] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:77:0)
[06:05:49.026] Timer tick, asking Buildbucket for the build status
[06:05:49.108] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:49.108] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:78:0) after 1m0s
[06:06:49.146] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:78:0)
[06:06:49.146] Timer tick, asking Buildbucket for the build status
[06:06:49.492] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:49.492] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:79:0) after 1m0s
[06:07:49.534] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:79:0)
[06:07:49.534] Timer tick, asking Buildbucket for the build status
[06:07:49.701] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:49.701] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:80:0) after 1m0s
[06:08:49.757] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:80:0)
[06:08:49.757] Timer tick, asking Buildbucket for the build status
[06:08:50.036] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:50.036] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:81:0) after 1m0s
[06:09:50.010] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:81:0)
[06:09:50.010] Timer tick, asking Buildbucket for the build status
[06:09:50.086] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:50.086] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:82:0) after 1m0s
[06:10:50.124] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:82:0)
[06:10:50.124] Timer tick, asking Buildbucket for the build status
[06:10:50.507] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:50.507] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:83:0) after 1m0s
[06:11:50.530] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:83:0)
[06:11:50.530] Timer tick, asking Buildbucket for the build status
[06:11:50.744] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:50.744] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:84:0) after 1m0s
[06:12:50.741] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:84:0)
[06:12:50.741] Timer tick, asking Buildbucket for the build status
[06:12:50.796] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:50.797] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:85:0) after 1m0s
[06:13:50.854] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:85:0)
[06:13:50.854] Timer tick, asking Buildbucket for the build status
[06:13:51.009] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:51.009] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:86:0) after 1m0s
[06:14:51.080] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:86:0)
[06:14:51.080] Timer tick, asking Buildbucket for the build status
[06:14:51.154] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:51.154] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:87:0) after 1m0s
[06:15:51.137] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:87:0)
[06:15:51.137] Timer tick, asking Buildbucket for the build status
[06:15:51.234] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:51.234] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:88:0) after 1m0s
[06:16:51.285] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:88:0)
[06:16:51.285] Timer tick, asking Buildbucket for the build status
[06:16:51.524] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:51.524] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:89:0) after 1m0s
[06:17:51.542] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:89:0)
[06:17:51.542] Timer tick, asking Buildbucket for the build status
[06:17:51.682] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:51.682] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:90:0) after 1m0s
[06:18:51.679] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:90:0)
[06:18:51.679] Timer tick, asking Buildbucket for the build status
[06:18:51.854] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:51.854] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:91:0) after 1m0s
[06:19:51.915] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:91:0)
[06:19:51.915] Timer tick, asking Buildbucket for the build status
[06:19:52.196] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:52.196] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:92:0) after 1m0s
[06:20:52.226] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:92:0)
[06:20:52.226] Timer tick, asking Buildbucket for the build status
[06:20:52.521] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:52.521] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:93:0) after 1m0s
[06:21:52.495] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:93:0)
[06:21:52.495] Timer tick, asking Buildbucket for the build status
[06:21:52.557] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:52.557] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:94:0) after 1m0s
[06:22:52.582] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:94:0)
[06:22:52.582] Timer tick, asking Buildbucket for the build status
[06:22:52.743] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:52.743] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:95:0) after 1m0s
[06:23:52.762] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:95:0)
[06:23:52.762] Timer tick, asking Buildbucket for the build status
[06:23:52.887] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:52.888] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:96:0) after 1m0s
[06:24:52.907] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:96:0)
[06:24:52.907] Timer tick, asking Buildbucket for the build status
[06:24:53.259] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:53.259] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:97:0) after 1m0s
[06:25:53.279] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:97:0)
[06:25:53.279] Timer tick, asking Buildbucket for the build status
[06:25:53.421] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:53.421] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:98:0) after 1m0s
[06:26:53.440] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:98:0)
[06:26:53.440] Timer tick, asking Buildbucket for the build status
[06:26:53.502] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:53.502] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:99:0) after 1m0s
[06:27:53.492] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:99:0)
[06:27:53.492] Timer tick, asking Buildbucket for the build status
[06:27:53.582] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:53.582] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:100:0) after 1m0s
[06:28:53.626] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:100:0)
[06:28:53.626] Timer tick, asking Buildbucket for the build status
[06:28:53.707] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:53.707] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:101:0) after 1m0s
[06:29:53.751] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:101:0)
[06:29:53.751] Timer tick, asking Buildbucket for the build status
[06:29:53.818] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:53.818] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:102:0) after 1m0s
[06:30:53.834] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:102:0)
[06:30:53.834] Timer tick, asking Buildbucket for the build status
[06:30:54.114] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:54.114] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:103:0) after 1m0s
[06:31:54.129] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:103:0)
[06:31:54.129] Timer tick, asking Buildbucket for the build status
[06:31:54.216] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:54.216] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:104:0) after 1m0s
[06:32:54.290] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:104:0)
[06:32:54.290] Timer tick, asking Buildbucket for the build status
[06:32:54.454] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:54.454] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:105:0) after 1m0s
[06:33:54.499] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:105:0)
[06:33:54.499] Timer tick, asking Buildbucket for the build status
[06:33:56.971] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:56.971] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:106:0) after 1m0s
[06:34:57.026] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:106:0)
[06:34:57.026] Timer tick, asking Buildbucket for the build status
[06:34:57.091] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:57.091] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:107:0) after 1m0s
[06:35:57.102] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:107:0)
[06:35:57.102] Timer tick, asking Buildbucket for the build status
[06:35:57.178] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:57.178] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:108:0) after 1m0s
[06:36:57.185] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:108:0)
[06:36:57.185] Timer tick, asking Buildbucket for the build status
[06:36:57.259] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:57.259] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:109:0) after 1m0s
[06:37:57.298] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:109:0)
[06:37:57.298] Timer tick, asking Buildbucket for the build status
[06:37:57.360] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:57.360] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:110:0) after 1m0s
[06:38:57.465] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:110:0)
[06:38:57.465] Timer tick, asking Buildbucket for the build status
[06:38:57.537] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:57.537] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:111:0) after 1m0s
[06:39:57.526] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:111:0)
[06:39:57.526] Timer tick, asking Buildbucket for the build status
[06:39:57.591] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:57.591] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:112:0) after 1m0s
[06:40:57.628] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:112:0)
[06:40:57.628] Timer tick, asking Buildbucket for the build status
[06:40:57.776] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:57.776] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:113:0) after 1m0s
[06:41:57.823] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:113:0)
[06:41:57.823] Timer tick, asking Buildbucket for the build status
[06:41:57.881] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:57.881] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:114:0) after 1m0s
[06:42:58.020] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:114:0)
[06:42:58.020] Timer tick, asking Buildbucket for the build status
[06:42:58.106] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:58.106] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:115:0) after 1m0s
[06:43:58.128] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:115:0)
[06:43:58.128] Timer tick, asking Buildbucket for the build status
[06:43:58.309] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:58.309] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:116:0) after 1m0s
[06:44:58.346] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:116:0)
[06:44:58.346] Timer tick, asking Buildbucket for the build status
[06:44:58.450] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:58.450] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:117:0) after 1m0s
[06:45:58.535] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:117:0)
[06:45:58.535] Timer tick, asking Buildbucket for the build status
[06:45:58.624] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:58.624] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:118:0) after 1m0s
[06:46:58.633] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:118:0)
[06:46:58.633] Timer tick, asking Buildbucket for the build status
[06:46:58.835] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:58.835] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:119:0) after 1m0s
[06:47:58.874] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:119:0)
[06:47:58.874] Timer tick, asking Buildbucket for the build status
[06:47:58.947] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:58.947] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:120:0) after 1m0s
[06:48:58.985] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:120:0)
[06:48:58.985] Timer tick, asking Buildbucket for the build status
[06:48:59.244] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:59.244] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:121:0) after 1m0s
[06:49:59.329] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:121:0)
[06:49:59.329] Timer tick, asking Buildbucket for the build status
[06:49:59.397] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:59.397] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:122:0) after 1m0s
[06:50:59.414] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:122:0)
[06:50:59.414] Timer tick, asking Buildbucket for the build status
[06:50:59.486] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:59.486] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:123:0) after 1m0s
[06:51:59.528] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:123:0)
[06:51:59.528] Timer tick, asking Buildbucket for the build status
[06:51:59.591] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:59.591] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:124:0) after 1m0s
[06:52:59.685] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:124:0)
[06:52:59.685] Timer tick, asking Buildbucket for the build status
[06:52:59.755] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:59.755] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:125:0) after 1m0s
[06:53:59.777] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:125:0)
[06:53:59.777] Timer tick, asking Buildbucket for the build status
[06:53:59.852] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:59.852] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:126:0) after 1m0s
[06:54:59.879] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:126:0)
[06:54:59.879] Timer tick, asking Buildbucket for the build status
[06:55:00.178] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:00.178] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:127:0) after 1m0s
[06:56:00.194] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:127:0)
[06:56:00.194] Timer tick, asking Buildbucket for the build status
[06:56:00.345] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:00.345] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:128:0) after 1m0s
[06:57:00.372] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:128:0)
[06:57:00.372] Timer tick, asking Buildbucket for the build status
[06:57:00.441] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:00.441] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:129:0) after 1m0s
[06:58:00.929] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:129:0)
[06:58:00.929] Timer tick, asking Buildbucket for the build status
[06:58:01.454] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:01.454] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:130:0) after 1m0s
[06:59:01.471] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:130:0)
[06:59:01.471] Timer tick, asking Buildbucket for the build status
[06:59:01.558] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:01.558] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:131:0) after 1m0s
[07:00:01.615] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:131:0)
[07:00:01.615] Timer tick, asking Buildbucket for the build status
[07:00:01.846] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:01.846] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:132:0) after 1m0s
[07:01:01.873] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:132:0)
[07:01:01.873] Timer tick, asking Buildbucket for the build status
[07:01:02.134] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:02.134] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:133:0) after 1m0s
[07:02:02.271] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:133:0)
[07:02:02.271] Timer tick, asking Buildbucket for the build status
[07:02:02.356] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:02.356] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:134:0) after 1m0s
[07:03:02.387] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:134:0)
[07:03:02.387] Timer tick, asking Buildbucket for the build status
[07:03:02.449] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:02.449] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:135:0) after 1m0s
[07:04:02.475] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:135:0)
[07:04:02.475] Timer tick, asking Buildbucket for the build status
[07:04:02.548] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:02.548] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:136:0) after 1m0s
[07:05:02.560] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:136:0)
[07:05:02.560] Timer tick, asking Buildbucket for the build status
[07:05:02.632] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:02.632] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:137:0) after 1m0s
[07:06:02.692] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:137:0)
[07:06:02.692] Timer tick, asking Buildbucket for the build status
[07:06:02.913] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:02.913] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:138:0) after 1m0s
[07:07:03.030] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:138:0)
[07:07:03.030] Timer tick, asking Buildbucket for the build status
[07:07:03.316] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:03.316] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:139:0) after 1m0s
[07:08:03.353] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:139:0)
[07:08:03.353] Timer tick, asking Buildbucket for the build status
[07:08:03.422] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:03.422] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:140:0) after 1m0s
[07:09:03.445] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:140:0)
[07:09:03.445] Timer tick, asking Buildbucket for the build status
[07:09:03.516] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:03.516] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:141:0) after 1m0s
[07:10:03.569] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:141:0)
[07:10:03.569] Timer tick, asking Buildbucket for the build status
[07:10:03.630] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:03.630] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:142:0) after 1m0s
[07:11:04.294] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:142:0)
[07:11:04.294] Timer tick, asking Buildbucket for the build status
[07:11:04.397] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:04.397] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:143:0) after 1m0s
[07:12:04.542] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:143:0)
[07:12:04.542] Timer tick, asking Buildbucket for the build status
[07:12:04.616] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:04.616] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:144:0) after 1m0s
[07:13:04.634] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:144:0)
[07:13:04.634] Timer tick, asking Buildbucket for the build status
[07:13:04.816] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:04.816] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:145:0) after 1m0s
[07:14:04.888] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:145:0)
[07:14:04.888] Timer tick, asking Buildbucket for the build status
[07:14:05.115] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:05.115] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:146:0) after 1m0s
[07:15:05.173] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:146:0)
[07:15:05.173] Timer tick, asking Buildbucket for the build status
[07:15:05.234] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:05.234] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:147:0) after 1m0s
[07:16:05.240] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:147:0)
[07:16:05.240] Timer tick, asking Buildbucket for the build status
[07:16:06.005] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:06.005] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:148:0) after 1m0s
[07:17:06.025] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:148:0)
[07:17:06.025] Timer tick, asking Buildbucket for the build status
[07:17:06.268] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:06.268] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:149:0) after 1m0s
[07:18:06.288] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:149:0)
[07:18:06.288] Timer tick, asking Buildbucket for the build status
[07:18:06.350] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:06.350] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:150:0) after 1m0s
[07:19:06.495] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:150:0)
[07:19:06.495] Timer tick, asking Buildbucket for the build status
[07:19:06.663] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:06.663] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:151:0) after 1m0s
[07:20:06.730] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:151:0)
[07:20:06.730] Timer tick, asking Buildbucket for the build status
[07:20:06.801] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:06.801] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:152:0) after 1m0s
[07:21:06.872] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:152:0)
[07:21:06.872] Timer tick, asking Buildbucket for the build status
[07:21:07.540] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:07.540] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:153:0) after 1m0s
[07:22:07.750] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:153:0)
[07:22:07.750] Timer tick, asking Buildbucket for the build status
[07:22:07.907] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:07.907] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:154:0) after 1m0s
[07:23:07.986] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:154:0)
[07:23:07.986] Timer tick, asking Buildbucket for the build status
[07:23:08.063] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:08.063] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:155:0) after 1m0s
[07:24:08.157] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:155:0)
[07:24:08.157] Timer tick, asking Buildbucket for the build status
[07:24:08.330] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:08.330] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:156:0) after 1m0s
[07:25:08.355] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:156:0)
[07:25:08.355] Timer tick, asking Buildbucket for the build status
[07:25:08.429] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:08.429] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:157:0) after 1m0s
[07:26:08.471] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:157:0)
[07:26:08.471] Timer tick, asking Buildbucket for the build status
[07:26:08.633] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:08.633] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:158:0) after 1m0s
[07:27:09.122] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:158:0)
[07:27:09.122] Timer tick, asking Buildbucket for the build status
[07:27:09.185] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:09.185] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:159:0) after 1m0s
[07:28:09.318] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:159:0)
[07:28:09.318] Timer tick, asking Buildbucket for the build status
[07:28:09.391] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:09.391] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:160:0) after 1m0s
[07:29:09.474] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:160:0)
[07:29:09.474] Timer tick, asking Buildbucket for the build status
[07:29:09.739] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:09.739] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:161:0) after 1m0s
[07:30:09.762] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:161:0)
[07:30:09.762] Timer tick, asking Buildbucket for the build status
[07:30:09.848] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:09.848] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:162:0) after 1m0s
[07:31:09.920] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:162:0)
[07:31:09.920] Timer tick, asking Buildbucket for the build status
[07:31:10.246] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:10.246] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:163:0) after 1m0s
[07:32:10.415] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:163:0)
[07:32:10.415] Timer tick, asking Buildbucket for the build status
[07:32:10.617] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:10.617] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:164:0) after 1m0s
[07:33:10.644] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:164:0)
[07:33:10.644] Timer tick, asking Buildbucket for the build status
[07:33:10.738] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:10.739] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:165:0) after 1m0s
[07:34:10.803] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:165:0)
[07:34:10.803] Timer tick, asking Buildbucket for the build status
[07:34:10.882] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:10.882] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:166:0) after 1m0s
[07:35:10.938] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:166:0)
[07:35:10.938] Timer tick, asking Buildbucket for the build status
[07:35:11.007] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:11.007] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:167:0) after 1m0s
[07:36:11.041] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:167:0)
[07:36:11.041] Timer tick, asking Buildbucket for the build status
[07:36:11.122] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:11.122] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:168:0) after 1m0s
[07:37:11.145] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:168:0)
[07:37:11.145] Timer tick, asking Buildbucket for the build status
[07:37:11.211] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:11.211] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:169:0) after 1m0s
[07:38:11.229] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:169:0)
[07:38:11.229] Timer tick, asking Buildbucket for the build status
[07:38:11.303] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:11.303] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:170:0) after 1m0s
[07:39:11.323] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:170:0)
[07:39:11.323] Timer tick, asking Buildbucket for the build status
[07:39:11.430] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:11.430] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:171:0) after 1m0s
[07:40:11.463] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:171:0)
[07:40:11.463] Timer tick, asking Buildbucket for the build status
[07:40:11.529] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:11.529] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:172:0) after 1m0s
[07:41:11.549] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:172:0)
[07:41:11.549] Timer tick, asking Buildbucket for the build status
[07:41:11.631] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:11.632] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:173:0) after 1m0s
[07:42:11.669] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:173:0)
[07:42:11.669] Timer tick, asking Buildbucket for the build status
[07:42:11.747] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:11.747] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:174:0) after 1m0s
[07:43:11.812] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:174:0)
[07:43:11.812] Timer tick, asking Buildbucket for the build status
[07:43:12.009] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:12.009] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:175:0) after 1m0s
[07:44:12.040] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:175:0)
[07:44:12.040] Timer tick, asking Buildbucket for the build status
[07:44:12.235] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:12.235] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:176:0) after 1m0s
[07:45:12.285] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:176:0)
[07:45:12.285] Timer tick, asking Buildbucket for the build status
[07:45:12.999] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:12.999] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:177:0) after 1m0s
[07:46:13.026] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:177:0)
[07:46:13.026] Timer tick, asking Buildbucket for the build status
[07:46:13.365] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:13.365] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:178:0) after 1m0s
[07:47:13.389] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:178:0)
[07:47:13.389] Timer tick, asking Buildbucket for the build status
[07:47:13.626] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:13.626] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:179:0) after 1m0s
[07:48:13.693] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:179:0)
[07:48:13.693] Timer tick, asking Buildbucket for the build status
[07:48:13.764] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:13.764] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:180:0) after 1m0s
[07:49:13.821] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:180:0)
[07:49:13.821] Timer tick, asking Buildbucket for the build status
[07:49:14.125] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:14.125] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:181:0) after 1m0s
[07:50:14.148] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:181:0)
[07:50:14.148] Timer tick, asking Buildbucket for the build status
[07:50:14.222] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:14.222] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:182:0) after 1m0s
[07:51:14.246] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:182:0)
[07:51:14.246] Timer tick, asking Buildbucket for the build status
[07:51:14.343] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:14.343] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:183:0) after 1m0s
[07:52:14.366] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:183:0)
[07:52:14.366] Timer tick, asking Buildbucket for the build status
[07:52:14.447] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:14.447] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:184:0) after 1m0s
[07:53:14.480] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:184:0)
[07:53:14.480] Timer tick, asking Buildbucket for the build status
[07:53:14.600] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:14.600] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:185:0) after 1m0s
[07:54:14.650] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:185:0)
[07:54:14.650] Timer tick, asking Buildbucket for the build status
[07:54:14.709] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:14.709] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:186:0) after 1m0s
[07:55:14.806] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:186:0)
[07:55:14.806] Timer tick, asking Buildbucket for the build status
[07:55:15.062] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:15.062] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:187:0) after 1m0s
[07:56:15.055] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:187:0)
[07:56:15.055] Timer tick, asking Buildbucket for the build status
[07:56:15.208] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:15.208] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:188:0) after 1m0s
[07:57:15.271] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:188:0)
[07:57:15.271] Timer tick, asking Buildbucket for the build status
[07:57:15.378] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:15.378] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:189:0) after 1m0s
[07:58:15.380] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:189:0)
[07:58:15.380] Timer tick, asking Buildbucket for the build status
[07:58:15.458] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:15.458] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:190:0) after 1m0s
[07:59:15.500] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:190:0)
[07:59:15.500] Timer tick, asking Buildbucket for the build status
[07:59:15.572] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:15.572] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:191:0) after 1m0s
[08:00:15.602] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:191:0)
[08:00:15.602] Timer tick, asking Buildbucket for the build status
[08:00:15.666] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:15.666] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:192:0) after 1m0s
[08:01:15.668] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:192:0)
[08:01:15.668] Timer tick, asking Buildbucket for the build status
[08:01:15.805] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:15.805] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:193:0) after 1m0s
[08:02:15.872] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:193:0)
[08:02:15.872] Timer tick, asking Buildbucket for the build status
[08:02:16.105] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:16.105] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:194:0) after 1m0s
[08:03:16.141] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:194:0)
[08:03:16.141] Timer tick, asking Buildbucket for the build status
[08:03:16.207] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:16.207] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:195:0) after 1m0s
[08:04:16.275] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:195:0)
[08:04:16.275] Timer tick, asking Buildbucket for the build status
[08:04:16.348] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:16.348] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:196:0) after 1m0s
[08:05:16.444] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:196:0)
[08:05:16.444] Timer tick, asking Buildbucket for the build status
[08:05:16.502] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:16.502] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:197:0) after 1m0s
[08:06:16.549] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:197:0)
[08:06:16.549] Timer tick, asking Buildbucket for the build status
[08:06:16.625] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:16.625] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:198:0) after 1m0s
[08:07:16.767] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:198:0)
[08:07:16.767] Timer tick, asking Buildbucket for the build status
[08:07:16.911] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:16.911] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:199:0) after 1m0s
[08:08:17.447] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:199:0)
[08:08:17.447] Timer tick, asking Buildbucket for the build status
[08:08:17.544] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:17.544] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:200:0) after 1m0s
[08:09:17.570] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:200:0)
[08:09:17.570] Timer tick, asking Buildbucket for the build status
[08:09:17.705] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:17.705] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:201:0) after 1m0s
[08:10:17.794] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:201:0)
[08:10:17.794] Timer tick, asking Buildbucket for the build status
[08:10:17.883] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:17.883] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:202:0) after 1m0s
[08:11:17.951] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:202:0)
[08:11:17.951] Timer tick, asking Buildbucket for the build status
[08:11:18.031] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:18.031] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:203:0) after 1m0s
[08:12:18.234] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:203:0)
[08:12:18.234] Timer tick, asking Buildbucket for the build status
[08:12:18.398] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:18.398] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:204:0) after 1m0s
[08:13:18.535] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:204:0)
[08:13:18.535] Timer tick, asking Buildbucket for the build status
[08:13:18.597] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:18.597] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:205:0) after 1m0s
[08:14:18.674] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:205:0)
[08:14:18.674] Timer tick, asking Buildbucket for the build status
[08:14:18.740] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:18.740] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:206:0) after 1m0s
[08:15:18.735] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:206:0)
[08:15:18.735] Timer tick, asking Buildbucket for the build status
[08:15:18.792] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:18.792] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:207:0) after 1m0s
[08:16:18.895] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:207:0)
[08:16:18.895] Timer tick, asking Buildbucket for the build status
[08:16:18.990] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:18.990] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:208:0) after 1m0s
[08:17:19.129] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:208:0)
[08:17:19.129] Timer tick, asking Buildbucket for the build status
[08:17:19.192] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:19.192] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:209:0) after 1m0s
[08:18:19.377] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:209:0)
[08:18:19.378] Timer tick, asking Buildbucket for the build status
[08:18:19.452] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:19.452] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:210:0) after 1m0s
[08:19:19.471] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:210:0)
[08:19:19.471] Timer tick, asking Buildbucket for the build status
[08:19:19.544] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:19.544] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:211:0) after 1m0s
[08:20:19.603] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:211:0)
[08:20:19.604] Timer tick, asking Buildbucket for the build status
[08:20:19.678] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:19.678] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:212:0) after 1m0s
[08:21:19.680] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:212:0)
[08:21:19.680] Timer tick, asking Buildbucket for the build status
[08:21:19.773] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:19.773] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:213:0) after 1m0s
[08:22:19.831] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:213:0)
[08:22:19.831] Timer tick, asking Buildbucket for the build status
[08:22:20.048] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:20.048] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:214:0) after 1m0s
[08:23:20.109] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:214:0)
[08:23:20.109] Timer tick, asking Buildbucket for the build status
[08:23:20.202] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:20.202] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:215:0) after 1m0s
[08:24:20.303] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:215:0)
[08:24:20.303] Timer tick, asking Buildbucket for the build status
[08:24:20.422] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:20.422] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:216:0) after 1m0s
[08:25:20.506] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:216:0)
[08:25:20.506] Timer tick, asking Buildbucket for the build status
[08:25:20.574] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:20.574] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:217:0) after 1m0s
[08:26:20.644] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:217:0)
[08:26:20.644] Timer tick, asking Buildbucket for the build status
[08:26:20.808] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:20.808] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:218:0) after 1m0s
[08:27:21.014] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:218:0)
[08:27:21.014] Timer tick, asking Buildbucket for the build status
[08:27:21.109] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:21.109] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:219:0) after 1m0s
[08:28:21.165] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:219:0)
[08:28:21.165] Timer tick, asking Buildbucket for the build status
[08:28:21.233] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:21.233] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:220:0) after 1m0s
[08:29:21.317] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:220:0)
[08:29:21.317] Timer tick, asking Buildbucket for the build status
[08:29:21.435] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:21.435] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:221:0) after 1m0s
[08:30:21.760] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:221:0)
[08:30:21.760] Timer tick, asking Buildbucket for the build status
[08:30:21.860] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:21.860] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:222:0) after 1m0s
[08:31:22.081] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:222:0)
[08:31:22.081] Timer tick, asking Buildbucket for the build status
[08:31:22.168] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:22.168] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:223:0) after 1m0s
[08:32:22.313] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:223:0)
[08:32:22.313] Timer tick, asking Buildbucket for the build status
[08:32:22.440] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:22.440] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:224:0) after 1m0s
[08:33:22.538] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:224:0)
[08:33:22.538] Timer tick, asking Buildbucket for the build status
[08:33:22.820] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:22.820] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:225:0) after 1m0s
[08:34:22.893] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:225:0)
[08:34:22.893] Timer tick, asking Buildbucket for the build status
[08:34:23.790] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:23.790] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:226:0) after 1m0s
[08:35:23.793] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:226:0)
[08:35:23.793] Timer tick, asking Buildbucket for the build status
[08:35:23.866] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:23.866] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:227:0) after 1m0s
[08:36:23.862] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:227:0)
[08:36:23.862] Timer tick, asking Buildbucket for the build status
[08:36:24.127] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:24.127] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:228:0) after 1m0s
[08:37:24.248] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:228:0)
[08:37:24.248] Timer tick, asking Buildbucket for the build status
[08:37:24.434] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:24.434] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:229:0) after 1m0s
[08:38:24.599] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:229:0)
[08:38:24.599] Timer tick, asking Buildbucket for the build status
[08:38:24.666] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:24.666] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:230:0) after 1m0s
[08:39:24.993] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:230:0)
[08:39:24.993] Timer tick, asking Buildbucket for the build status
[08:39:25.064] Build 8853536937779812496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:25.064] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018966999695161184:231:0) after 1m0s
[08:39:40.431] Received PubSub notification, asking Buildbucket for the build status
[08:39:40.563] Build 8853536937779812496: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[08:39:40.563] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615019979701987",
"created_by": "project:chromium",
"created_ts": "1615006235293370",
"id": "8853536937779812496",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2abedeb596d2b0bed8bc8a5e02bab506aa843b1a\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"2abedeb596d2b0bed8bc8a5e02bab506aa843b1a\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"win-dbg-2-bv67\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 1698, \"got_angle_revision\": \"8a48f4de1b6f20676b72e81e099993c3f570b345\", \"got_dawn_revision\": \"010fd1a8d7c7dd4e8fabe73546be78c45b6419c2\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"2abedeb596d2b0bed8bc8a5e02bab506aa843b1a\", \"got_revision_cp\": \"refs/heads/master@{#860508}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"de7d5775ab25234a2c14d061e0cda342248a0e6d\", \"got_v8_revision\": \"c1278b27dbd782403537d921f7c6c23fe56c5b10\", \"got_v8_revision_cp\": \"refs/heads/9.1.56@{#1}\", \"got_webrtc_revision\": \"3208bf102b75e8ec1eaa6640dfa3b545310b1e02\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33382}\", \"is_cached\": true, \"mirrored_builders\": [\"tryserver.chromium:win-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2abedeb596d2b0bed8bc8a5e02bab506aa843b1a\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_1daffed6dde8d2010ab2a7aee555237ff999d968966bfcf42bbce4ac98bb7a23_v2\", \"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-2-bv67\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5725-1a0d85e\"], \"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": "1615006237938422",
"status": "COMPLETED",
"status_changed_ts": "1615019980028193",
"tags": [
"build_address:luci.chromium.ci/win-official/1698",
"builder:win-official",
"buildset:commit/git/2abedeb596d2b0bed8bc8a5e02bab506aa843b1a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2abedeb596d2b0bed8bc8a5e02bab506aa843b1a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018966999695161184",
"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/8853536937779812496/+/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:521eb105b762ad10",
"user_agent:luci-scheduler"
],
"updated_ts": "1615019980032492",
"url": "https://ci.chromium.org/b/8853536937779812496",
"utcnow_ts": "1615019980553414"
}
}
[08:39:40.563] Invocation finished in 3h49m6.480454663s with status SUCCEEDED