[21:21:03.230] New invocation is queued and will start shortly
[21:21:07.463] Starting the invocation (attempt 1)
[21:21:07.515] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:21:07.515] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:21:07.515] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029957513639292176",
"parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"7a322ca1d86378dc5328291db1bb948937dd18ad\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-official",
"scheduler_invocation_id:9029957513639292176",
"scheduler_job_id:chromium/win-official",
"user_agent:luci-scheduler",
"buildset:commit/git/7a322ca1d86378dc5328291db1bb948937dd18ad",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7a322ca1d86378dc5328291db1bb948937dd18ad",
"gitiles_ref:refs/heads/master"
]
}
[21:21:08.195] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604524867644936",
"id": "8864527448343938848",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7a322ca1d86378dc5328291db1bb948937dd18ad\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604524868035452",
"tags": [
"build_address:luci.chromium.ci/win-official/963",
"builder:win-official",
"buildset:commit/git/7a322ca1d86378dc5328291db1bb948937dd18ad",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7a322ca1d86378dc5328291db1bb948937dd18ad",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029957513639292176",
"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/8864527448343938848/+/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": "1604524868035598",
"url": "https://ci.chromium.org/b/8864527448343938848",
"utcnow_ts": "1604524868185912"
}
}
[21:21:08.195] Task URL: https://ci.chromium.org/b/8864527448343938848
[21:21:08.195] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:2:0) after 1m0s
[21:22:08.261] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:2:0)
[21:22:08.261] Timer tick, asking Buildbucket for the build status
[21:22:09.262] Build 8864527448343938848: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:22:09.262] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:3:0) after 1m0s
[21:22:42.771] Received PubSub notification, asking Buildbucket for the build status
[21:22:43.010] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:09.275] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:3:0)
[21:23:09.275] Timer tick, asking Buildbucket for the build status
[21:23:09.371] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:09.371] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:5:0) after 1m0s
[21:24:09.434] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:5:0)
[21:24:09.434] Timer tick, asking Buildbucket for the build status
[21:24:09.542] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:09.542] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:6:0) after 1m0s
[21:25:09.555] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:6:0)
[21:25:09.555] Timer tick, asking Buildbucket for the build status
[21:25:09.740] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:09.740] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:7:0) after 1m0s
[21:26:09.768] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:7:0)
[21:26:09.768] Timer tick, asking Buildbucket for the build status
[21:26:09.944] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:09.944] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:8:0) after 1m0s
[21:27:09.976] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:8:0)
[21:27:09.976] Timer tick, asking Buildbucket for the build status
[21:27:10.043] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:10.043] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:9:0) after 1m0s
[21:28:10.126] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:9:0)
[21:28:10.126] Timer tick, asking Buildbucket for the build status
[21:28:10.228] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:10.228] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:10:0) after 1m0s
[21:29:10.266] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:10:0)
[21:29:10.266] Timer tick, asking Buildbucket for the build status
[21:29:10.382] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:10.382] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:11:0) after 1m0s
[21:30:10.406] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:11:0)
[21:30:10.406] Timer tick, asking Buildbucket for the build status
[21:30:10.496] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:10.496] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:12:0) after 1m0s
[21:31:10.513] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:12:0)
[21:31:10.513] Timer tick, asking Buildbucket for the build status
[21:31:10.630] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:10.630] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:13:0) after 1m0s
[21:32:10.663] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:13:0)
[21:32:10.663] Timer tick, asking Buildbucket for the build status
[21:32:10.749] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:10.749] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:14:0) after 1m0s
[21:33:10.962] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:14:0)
[21:33:10.962] Timer tick, asking Buildbucket for the build status
[21:33:11.092] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:11.092] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:15:0) after 1m0s
[21:34:11.134] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:15:0)
[21:34:11.134] Timer tick, asking Buildbucket for the build status
[21:34:11.542] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:11.542] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:16:0) after 1m0s
[21:35:11.602] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:16:0)
[21:35:11.602] Timer tick, asking Buildbucket for the build status
[21:35:11.705] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:11.705] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:17:0) after 1m0s
[21:36:11.732] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:17:0)
[21:36:11.732] Timer tick, asking Buildbucket for the build status
[21:36:11.973] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:11.973] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:18:0) after 1m0s
[21:37:12.018] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:18:0)
[21:37:12.018] Timer tick, asking Buildbucket for the build status
[21:37:12.453] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:12.453] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:19:0) after 1m0s
[21:38:12.562] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:19:0)
[21:38:12.562] Timer tick, asking Buildbucket for the build status
[21:38:13.392] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:13.392] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:20:0) after 1m0s
[21:39:13.441] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:20:0)
[21:39:13.441] Timer tick, asking Buildbucket for the build status
[21:39:14.333] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:14.333] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:21:0) after 1m0s
[21:40:14.424] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:21:0)
[21:40:14.424] Timer tick, asking Buildbucket for the build status
[21:40:14.516] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:14.516] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:22:0) after 1m0s
[21:41:14.573] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:22:0)
[21:41:14.573] Timer tick, asking Buildbucket for the build status
[21:41:14.708] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:14.708] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:23:0) after 1m0s
[21:42:14.746] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:23:0)
[21:42:14.746] Timer tick, asking Buildbucket for the build status
[21:42:14.825] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:14.825] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:24:0) after 1m0s
[21:43:14.819] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:24:0)
[21:43:14.819] Timer tick, asking Buildbucket for the build status
[21:43:14.982] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:14.982] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:25:0) after 1m0s
[21:44:15.019] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:25:0)
[21:44:15.019] Timer tick, asking Buildbucket for the build status
[21:44:15.282] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:15.282] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:26:0) after 1m0s
[21:45:15.310] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:26:0)
[21:45:15.310] Timer tick, asking Buildbucket for the build status
[21:45:15.472] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:15.472] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:27:0) after 1m0s
[21:46:15.541] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:27:0)
[21:46:15.541] Timer tick, asking Buildbucket for the build status
[21:46:15.846] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:15.846] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:28:0) after 1m0s
[21:47:15.911] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:28:0)
[21:47:15.911] Timer tick, asking Buildbucket for the build status
[21:47:15.994] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:15.994] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:29:0) after 1m0s
[21:48:16.143] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:29:0)
[21:48:16.143] Timer tick, asking Buildbucket for the build status
[21:48:16.217] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:16.217] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:30:0) after 1m0s
[21:49:16.234] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:30:0)
[21:49:16.234] Timer tick, asking Buildbucket for the build status
[21:49:16.312] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:16.312] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:31:0) after 1m0s
[21:50:16.394] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:31:0)
[21:50:16.394] Timer tick, asking Buildbucket for the build status
[21:50:16.460] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:16.460] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:32:0) after 1m0s
[21:51:16.516] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:32:0)
[21:51:16.516] Timer tick, asking Buildbucket for the build status
[21:51:16.644] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:16.644] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:33:0) after 1m0s
[21:52:16.806] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:33:0)
[21:52:16.806] Timer tick, asking Buildbucket for the build status
[21:52:17.056] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:17.056] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:34:0) after 1m0s
[21:53:17.150] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:34:0)
[21:53:17.150] Timer tick, asking Buildbucket for the build status
[21:53:17.262] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:17.262] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:35:0) after 1m0s
[21:54:17.441] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:35:0)
[21:54:17.441] Timer tick, asking Buildbucket for the build status
[21:54:17.514] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:17.514] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:36:0) after 1m0s
[21:55:17.542] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:36:0)
[21:55:17.542] Timer tick, asking Buildbucket for the build status
[21:55:17.627] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:17.627] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:37:0) after 1m0s
[21:56:17.641] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:37:0)
[21:56:17.641] Timer tick, asking Buildbucket for the build status
[21:56:17.782] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:17.782] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:38:0) after 1m0s
[21:57:17.808] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:38:0)
[21:57:17.808] Timer tick, asking Buildbucket for the build status
[21:57:17.907] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:17.907] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:39:0) after 1m0s
[21:58:18.012] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:39:0)
[21:58:18.012] Timer tick, asking Buildbucket for the build status
[21:58:18.145] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:18.149] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:40:0) after 1m0s
[21:59:18.228] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:40:0)
[21:59:18.228] Timer tick, asking Buildbucket for the build status
[21:59:18.377] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:18.377] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:41:0) after 1m0s
[22:00:18.548] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:41:0)
[22:00:18.548] Timer tick, asking Buildbucket for the build status
[22:00:18.921] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:18.921] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:42:0) after 1m0s
[22:01:18.934] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:42:0)
[22:01:18.934] Timer tick, asking Buildbucket for the build status
[22:01:19.042] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:19.042] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:43:0) after 1m0s
[22:02:19.126] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:43:0)
[22:02:19.126] Timer tick, asking Buildbucket for the build status
[22:02:19.303] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:19.303] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:44:0) after 1m0s
[22:03:19.418] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:44:0)
[22:03:19.418] Timer tick, asking Buildbucket for the build status
[22:03:20.137] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:20.137] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:45:0) after 1m0s
[22:04:20.349] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:45:0)
[22:04:20.349] Timer tick, asking Buildbucket for the build status
[22:04:28.197] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:28.197] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:46:0) after 1m0s
[22:05:28.477] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:46:0)
[22:05:28.477] Timer tick, asking Buildbucket for the build status
[22:05:28.605] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:28.605] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:47:0) after 1m0s
[22:06:28.658] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:47:0)
[22:06:28.658] Timer tick, asking Buildbucket for the build status
[22:06:28.866] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:28.866] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:48:0) after 1m0s
[22:07:28.938] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:48:0)
[22:07:28.938] Timer tick, asking Buildbucket for the build status
[22:07:29.136] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:29.136] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:49:0) after 1m0s
[22:08:29.158] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:49:0)
[22:08:29.158] Timer tick, asking Buildbucket for the build status
[22:08:29.227] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:29.227] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:50:0) after 1m0s
[22:09:29.261] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:50:0)
[22:09:29.261] Timer tick, asking Buildbucket for the build status
[22:09:29.354] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:29.354] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:51:0) after 1m0s
[22:10:29.397] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:51:0)
[22:10:29.397] Timer tick, asking Buildbucket for the build status
[22:10:29.661] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:29.661] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:52:0) after 1m0s
[22:11:29.736] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:52:0)
[22:11:29.736] Timer tick, asking Buildbucket for the build status
[22:11:29.903] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:29.903] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:53:0) after 1m0s
[22:12:29.925] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:53:0)
[22:12:29.925] Timer tick, asking Buildbucket for the build status
[22:12:29.980] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:29.981] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:54:0) after 1m0s
[22:13:30.039] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:54:0)
[22:13:30.039] Timer tick, asking Buildbucket for the build status
[22:13:30.113] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:30.113] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:55:0) after 1m0s
[22:14:30.170] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:55:0)
[22:14:30.170] Timer tick, asking Buildbucket for the build status
[22:14:30.231] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:30.231] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:56:0) after 1m0s
[22:15:30.288] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:56:0)
[22:15:30.288] Timer tick, asking Buildbucket for the build status
[22:15:30.390] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:30.390] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:57:0) after 1m0s
[22:16:30.474] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:57:0)
[22:16:30.474] Timer tick, asking Buildbucket for the build status
[22:16:30.658] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:30.658] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:58:0) after 1m0s
[22:17:30.787] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:58:0)
[22:17:30.787] Timer tick, asking Buildbucket for the build status
[22:17:30.868] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:30.868] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:59:0) after 1m0s
[22:18:31.019] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:59:0)
[22:18:31.019] Timer tick, asking Buildbucket for the build status
[22:18:31.097] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:31.097] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:60:0) after 1m0s
[22:19:31.137] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:60:0)
[22:19:31.137] Timer tick, asking Buildbucket for the build status
[22:19:31.279] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:31.279] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:61:0) after 1m0s
[22:20:31.311] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:61:0)
[22:20:31.311] Timer tick, asking Buildbucket for the build status
[22:20:31.385] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:31.385] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:62:0) after 1m0s
[22:21:31.368] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:62:0)
[22:21:31.368] Timer tick, asking Buildbucket for the build status
[22:21:31.505] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:31.505] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:63:0) after 1m0s
[22:22:31.532] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:63:0)
[22:22:31.532] Timer tick, asking Buildbucket for the build status
[22:22:31.616] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:31.616] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:64:0) after 1m0s
[22:23:31.769] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:64:0)
[22:23:31.769] Timer tick, asking Buildbucket for the build status
[22:23:31.837] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:31.837] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:65:0) after 1m0s
[22:24:31.895] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:65:0)
[22:24:31.895] Timer tick, asking Buildbucket for the build status
[22:24:31.997] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:31.997] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:66:0) after 1m0s
[22:25:32.068] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:66:0)
[22:25:32.068] Timer tick, asking Buildbucket for the build status
[22:25:32.147] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:32.147] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:67:0) after 1m0s
[22:26:32.168] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:67:0)
[22:26:32.168] Timer tick, asking Buildbucket for the build status
[22:26:32.308] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:32.308] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:68:0) after 1m0s
[22:27:32.348] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:68:0)
[22:27:32.348] Timer tick, asking Buildbucket for the build status
[22:27:36.256] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:36.256] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:69:0) after 1m0s
[22:28:36.270] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:69:0)
[22:28:36.270] Timer tick, asking Buildbucket for the build status
[22:28:36.412] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:36.412] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:70:0) after 1m0s
[22:29:36.450] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:70:0)
[22:29:36.450] Timer tick, asking Buildbucket for the build status
[22:29:36.512] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:36.512] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:71:0) after 1m0s
[22:30:36.565] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:71:0)
[22:30:36.565] Timer tick, asking Buildbucket for the build status
[22:30:36.634] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:36.634] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:72:0) after 1m0s
[22:31:36.689] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:72:0)
[22:31:36.689] Timer tick, asking Buildbucket for the build status
[22:31:36.786] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:36.786] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:73:0) after 1m0s
[22:32:36.817] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:73:0)
[22:32:36.817] Timer tick, asking Buildbucket for the build status
[22:32:36.898] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:36.898] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:74:0) after 1m0s
[22:33:36.936] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:74:0)
[22:33:36.936] Timer tick, asking Buildbucket for the build status
[22:33:37.003] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:37.003] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:75:0) after 1m0s
[22:34:37.277] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:75:0)
[22:34:37.277] Timer tick, asking Buildbucket for the build status
[22:34:37.430] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:37.430] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:76:0) after 1m0s
[22:35:37.457] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:76:0)
[22:35:37.457] Timer tick, asking Buildbucket for the build status
[22:35:37.520] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:37.520] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:77:0) after 1m0s
[22:36:37.629] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:77:0)
[22:36:37.629] Timer tick, asking Buildbucket for the build status
[22:36:37.874] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:37.874] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:78:0) after 1m0s
[22:37:37.978] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:78:0)
[22:37:37.978] Timer tick, asking Buildbucket for the build status
[22:37:38.114] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:38.114] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:79:0) after 1m0s
[22:38:38.220] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:79:0)
[22:38:38.220] Timer tick, asking Buildbucket for the build status
[22:38:38.365] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:38.365] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:80:0) after 1m0s
[22:39:38.599] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:80:0)
[22:39:38.599] Timer tick, asking Buildbucket for the build status
[22:39:38.670] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:38.670] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:81:0) after 1m0s
[22:40:38.807] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:81:0)
[22:40:38.807] Timer tick, asking Buildbucket for the build status
[22:40:39.423] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:39.423] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:82:0) after 1m0s
[22:41:39.483] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:82:0)
[22:41:39.483] Timer tick, asking Buildbucket for the build status
[22:41:39.588] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:39.589] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:83:0) after 1m0s
[22:42:39.668] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:83:0)
[22:42:39.668] Timer tick, asking Buildbucket for the build status
[22:42:39.808] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:39.808] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:84:0) after 1m0s
[22:43:39.862] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:84:0)
[22:43:39.862] Timer tick, asking Buildbucket for the build status
[22:43:39.935] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:39.935] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:85:0) after 1m0s
[22:44:40.012] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:85:0)
[22:44:40.012] Timer tick, asking Buildbucket for the build status
[22:44:40.082] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:40.082] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:86:0) after 1m0s
[22:45:40.135] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:86:0)
[22:45:40.135] Timer tick, asking Buildbucket for the build status
[22:45:40.358] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:40.358] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:87:0) after 1m0s
[22:46:40.452] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:87:0)
[22:46:40.452] Timer tick, asking Buildbucket for the build status
[22:46:40.685] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:40.685] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:88:0) after 1m0s
[22:47:40.717] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:88:0)
[22:47:40.717] Timer tick, asking Buildbucket for the build status
[22:47:40.861] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:40.861] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:89:0) after 1m0s
[22:48:40.953] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:89:0)
[22:48:40.953] Timer tick, asking Buildbucket for the build status
[22:48:41.053] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:41.053] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:90:0) after 1m0s
[22:49:41.088] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:90:0)
[22:49:41.088] Timer tick, asking Buildbucket for the build status
[22:49:41.166] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:41.166] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:91:0) after 1m0s
[22:50:41.310] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:91:0)
[22:50:41.310] Timer tick, asking Buildbucket for the build status
[22:50:41.389] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:41.389] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:92:0) after 1m0s
[22:51:41.402] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:92:0)
[22:51:41.402] Timer tick, asking Buildbucket for the build status
[22:51:41.623] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:41.623] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:93:0) after 1m0s
[22:52:41.750] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:93:0)
[22:52:41.750] Timer tick, asking Buildbucket for the build status
[22:52:42.069] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:42.069] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:94:0) after 1m0s
[22:53:42.100] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:94:0)
[22:53:42.100] Timer tick, asking Buildbucket for the build status
[22:53:42.169] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:42.170] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:95:0) after 1m0s
[22:54:42.150] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:95:0)
[22:54:42.150] Timer tick, asking Buildbucket for the build status
[22:54:42.252] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:42.252] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:96:0) after 1m0s
[22:55:42.443] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:96:0)
[22:55:42.443] Timer tick, asking Buildbucket for the build status
[22:55:42.515] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:42.515] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:97:0) after 1m0s
[22:56:42.739] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:97:0)
[22:56:42.739] Timer tick, asking Buildbucket for the build status
[22:56:42.859] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:42.859] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:98:0) after 1m0s
[22:57:43.172] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:98:0)
[22:57:43.172] Timer tick, asking Buildbucket for the build status
[22:57:43.476] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:43.476] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:99:0) after 1m0s
[22:58:43.714] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:99:0)
[22:58:43.714] Timer tick, asking Buildbucket for the build status
[22:58:43.789] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:43.789] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:100:0) after 1m0s
[22:59:43.966] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:100:0)
[22:59:43.966] Timer tick, asking Buildbucket for the build status
[22:59:44.049] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:44.049] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:101:0) after 1m0s
[23:00:44.193] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:101:0)
[23:00:44.193] Timer tick, asking Buildbucket for the build status
[23:00:44.306] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:44.306] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:102:0) after 1m0s
[23:01:44.357] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:102:0)
[23:01:44.357] Timer tick, asking Buildbucket for the build status
[23:01:44.603] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:44.603] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:103:0) after 1m0s
[23:02:44.710] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:103:0)
[23:02:44.710] Timer tick, asking Buildbucket for the build status
[23:02:44.784] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:44.784] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:104:0) after 1m0s
[23:03:44.834] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:104:0)
[23:03:44.834] Timer tick, asking Buildbucket for the build status
[23:03:44.941] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:44.941] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:105:0) after 1m0s
[23:04:44.962] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:105:0)
[23:04:44.962] Timer tick, asking Buildbucket for the build status
[23:04:45.061] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:45.061] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:106:0) after 1m0s
[23:05:45.114] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:106:0)
[23:05:45.114] Timer tick, asking Buildbucket for the build status
[23:05:45.211] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:45.211] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:107:0) after 1m0s
[23:06:45.272] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:107:0)
[23:06:45.272] Timer tick, asking Buildbucket for the build status
[23:06:45.382] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:45.382] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:108:0) after 1m0s
[23:07:45.412] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:108:0)
[23:07:45.412] Timer tick, asking Buildbucket for the build status
[23:07:45.471] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:45.471] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:109:0) after 1m0s
[23:08:45.533] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:109:0)
[23:08:45.533] Timer tick, asking Buildbucket for the build status
[23:08:45.881] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:45.881] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:110:0) after 1m0s
[23:09:45.942] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:110:0)
[23:09:45.942] Timer tick, asking Buildbucket for the build status
[23:09:46.297] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:46.297] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:111:0) after 1m0s
[23:10:46.340] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:111:0)
[23:10:46.340] Timer tick, asking Buildbucket for the build status
[23:10:46.665] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:46.665] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:112:0) after 1m0s
[23:11:46.706] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:112:0)
[23:11:46.706] Timer tick, asking Buildbucket for the build status
[23:11:46.808] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:46.808] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:113:0) after 1m0s
[23:12:46.907] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:113:0)
[23:12:46.907] Timer tick, asking Buildbucket for the build status
[23:12:47.078] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:47.078] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:114:0) after 1m0s
[23:13:47.156] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:114:0)
[23:13:47.156] Timer tick, asking Buildbucket for the build status
[23:13:47.449] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:47.449] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:115:0) after 1m0s
[23:14:47.483] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:115:0)
[23:14:47.483] Timer tick, asking Buildbucket for the build status
[23:14:47.547] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:47.547] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:116:0) after 1m0s
[23:15:47.700] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:116:0)
[23:15:47.700] Timer tick, asking Buildbucket for the build status
[23:15:47.941] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:47.941] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:117:0) after 1m0s
[23:16:47.982] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:117:0)
[23:16:47.982] Timer tick, asking Buildbucket for the build status
[23:16:48.102] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:48.102] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:118:0) after 1m0s
[23:17:48.084] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:118:0)
[23:17:48.084] Timer tick, asking Buildbucket for the build status
[23:17:48.286] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:48.286] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:119:0) after 1m0s
[23:18:48.287] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:119:0)
[23:18:48.287] Timer tick, asking Buildbucket for the build status
[23:18:48.379] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:48.379] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:120:0) after 1m0s
[23:19:48.409] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:120:0)
[23:19:48.409] Timer tick, asking Buildbucket for the build status
[23:19:48.499] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:48.499] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:121:0) after 1m0s
[23:20:48.560] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:121:0)
[23:20:48.560] Timer tick, asking Buildbucket for the build status
[23:20:48.619] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:48.619] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:122:0) after 1m0s
[23:21:48.658] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:122:0)
[23:21:48.658] Timer tick, asking Buildbucket for the build status
[23:21:49.039] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:49.039] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:123:0) after 1m0s
[23:22:49.056] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:123:0)
[23:22:49.056] Timer tick, asking Buildbucket for the build status
[23:22:49.124] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:49.124] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:124:0) after 1m0s
[23:23:49.174] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:124:0)
[23:23:49.174] Timer tick, asking Buildbucket for the build status
[23:23:49.245] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:49.245] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:125:0) after 1m0s
[23:24:49.290] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:125:0)
[23:24:49.290] Timer tick, asking Buildbucket for the build status
[23:24:49.353] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:49.353] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:126:0) after 1m0s
[23:25:49.388] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:126:0)
[23:25:49.388] Timer tick, asking Buildbucket for the build status
[23:25:49.596] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:49.596] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:127:0) after 1m0s
[23:26:49.627] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:127:0)
[23:26:49.627] Timer tick, asking Buildbucket for the build status
[23:26:49.860] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:49.861] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:128:0) after 1m0s
[23:27:49.893] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:128:0)
[23:27:49.893] Timer tick, asking Buildbucket for the build status
[23:27:49.968] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:49.968] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:129:0) after 1m0s
[23:28:50.009] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:129:0)
[23:28:50.010] Timer tick, asking Buildbucket for the build status
[23:28:50.415] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:50.415] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:130:0) after 1m0s
[23:29:50.488] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:130:0)
[23:29:50.488] Timer tick, asking Buildbucket for the build status
[23:29:50.622] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:50.622] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:131:0) after 1m0s
[23:30:50.654] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:131:0)
[23:30:50.654] Timer tick, asking Buildbucket for the build status
[23:30:50.744] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:50.744] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:132:0) after 1m0s
[23:31:50.775] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:132:0)
[23:31:50.775] Timer tick, asking Buildbucket for the build status
[23:31:50.896] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:50.896] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:133:0) after 1m0s
[23:32:50.969] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:133:0)
[23:32:50.969] Timer tick, asking Buildbucket for the build status
[23:32:51.096] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:51.096] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:134:0) after 1m0s
[23:33:51.188] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:134:0)
[23:33:51.188] Timer tick, asking Buildbucket for the build status
[23:33:51.287] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:51.287] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:135:0) after 1m0s
[23:34:51.328] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:135:0)
[23:34:51.328] Timer tick, asking Buildbucket for the build status
[23:34:53.881] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:53.881] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:136:0) after 1m0s
[23:35:54.117] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:136:0)
[23:35:54.117] Timer tick, asking Buildbucket for the build status
[23:35:54.196] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:54.196] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:137:0) after 1m0s
[23:36:54.243] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:137:0)
[23:36:54.243] Timer tick, asking Buildbucket for the build status
[23:36:54.363] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:54.363] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:138:0) after 1m0s
[23:37:54.433] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:138:0)
[23:37:54.433] Timer tick, asking Buildbucket for the build status
[23:37:54.500] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:54.500] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:139:0) after 1m0s
[23:38:54.638] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:139:0)
[23:38:54.638] Timer tick, asking Buildbucket for the build status
[23:38:54.923] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:54.923] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:140:0) after 1m0s
[23:39:55.095] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:140:0)
[23:39:55.095] Timer tick, asking Buildbucket for the build status
[23:39:55.810] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:55.810] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:141:0) after 1m0s
[23:40:55.856] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:141:0)
[23:40:55.856] Timer tick, asking Buildbucket for the build status
[23:40:55.914] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:55.914] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:142:0) after 1m0s
[23:41:55.949] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:142:0)
[23:41:55.949] Timer tick, asking Buildbucket for the build status
[23:41:56.080] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:56.080] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:143:0) after 1m0s
[23:42:56.129] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:143:0)
[23:42:56.129] Timer tick, asking Buildbucket for the build status
[23:42:56.332] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:56.332] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:144:0) after 1m0s
[23:43:56.411] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:144:0)
[23:43:56.411] Timer tick, asking Buildbucket for the build status
[23:43:56.543] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:56.543] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:145:0) after 1m0s
[23:44:56.621] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:145:0)
[23:44:56.621] Timer tick, asking Buildbucket for the build status
[23:44:56.686] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:56.686] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:146:0) after 1m0s
[23:45:56.949] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:146:0)
[23:45:56.949] Timer tick, asking Buildbucket for the build status
[23:45:57.115] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:57.115] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:147:0) after 1m0s
[23:46:57.301] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:147:0)
[23:46:57.301] Timer tick, asking Buildbucket for the build status
[23:46:58.811] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:58.811] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:148:0) after 1m0s
[23:47:58.915] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:148:0)
[23:47:58.915] Timer tick, asking Buildbucket for the build status
[23:47:58.996] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:58.996] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:149:0) after 1m0s
[23:48:59.096] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:149:0)
[23:48:59.096] Timer tick, asking Buildbucket for the build status
[23:48:59.641] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:59.641] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:150:0) after 1m0s
[23:49:59.735] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:150:0)
[23:49:59.735] Timer tick, asking Buildbucket for the build status
[23:49:59.802] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:59.802] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:151:0) after 1m0s
[23:50:59.879] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:151:0)
[23:50:59.879] Timer tick, asking Buildbucket for the build status
[23:51:00.595] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:00.595] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:152:0) after 1m0s
[23:52:00.629] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:152:0)
[23:52:00.629] Timer tick, asking Buildbucket for the build status
[23:52:00.722] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:00.722] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:153:0) after 1m0s
[23:53:00.758] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:153:0)
[23:53:00.758] Timer tick, asking Buildbucket for the build status
[23:53:00.828] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:00.828] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:154:0) after 1m0s
[23:54:00.844] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:154:0)
[23:54:00.844] Timer tick, asking Buildbucket for the build status
[23:54:00.946] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:00.946] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:155:0) after 1m0s
[23:55:01.430] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:155:0)
[23:55:01.430] Timer tick, asking Buildbucket for the build status
[23:55:01.639] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:01.639] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:156:0) after 1m0s
[23:56:02.472] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:156:0)
[23:56:02.472] Timer tick, asking Buildbucket for the build status
[23:56:02.681] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:02.681] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:157:0) after 1m0s
[23:57:02.743] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:157:0)
[23:57:02.743] Timer tick, asking Buildbucket for the build status
[23:57:02.875] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:02.875] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:158:0) after 1m0s
[23:58:02.975] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:158:0)
[23:58:02.975] Timer tick, asking Buildbucket for the build status
[23:58:03.562] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:03.562] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:159:0) after 1m0s
[23:59:03.601] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:159:0)
[23:59:03.601] Timer tick, asking Buildbucket for the build status
[23:59:03.660] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:03.660] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:160:0) after 1m0s
[00:00:04.144] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:160:0)
[00:00:04.144] Timer tick, asking Buildbucket for the build status
[00:00:04.261] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:04.261] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:161:0) after 1m0s
[00:01:04.469] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:161:0)
[00:01:04.469] Timer tick, asking Buildbucket for the build status
[00:01:04.587] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:04.587] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:162:0) after 1m0s
[00:02:04.699] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:162:0)
[00:02:04.699] Timer tick, asking Buildbucket for the build status
[00:02:04.841] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:04.841] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:163:0) after 1m0s
[00:03:05.004] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:163:0)
[00:03:05.004] Timer tick, asking Buildbucket for the build status
[00:03:05.074] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:05.074] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:164:0) after 1m0s
[00:04:05.136] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:164:0)
[00:04:05.136] Timer tick, asking Buildbucket for the build status
[00:04:05.797] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:05.797] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:165:0) after 1m0s
[00:05:05.912] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:165:0)
[00:05:05.912] Timer tick, asking Buildbucket for the build status
[00:05:06.003] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:06.003] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:166:0) after 1m0s
[00:06:06.092] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:166:0)
[00:06:06.092] Timer tick, asking Buildbucket for the build status
[00:06:06.174] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:06.174] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:167:0) after 1m0s
[00:07:06.208] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:167:0)
[00:07:06.208] Timer tick, asking Buildbucket for the build status
[00:07:06.323] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:06.323] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:168:0) after 1m0s
[00:08:06.858] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:168:0)
[00:08:06.858] Timer tick, asking Buildbucket for the build status
[00:08:07.822] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:07.823] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:169:0) after 1m0s
[00:09:07.981] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:169:0)
[00:09:07.981] Timer tick, asking Buildbucket for the build status
[00:09:08.136] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:08.136] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:170:0) after 1m0s
[00:10:08.234] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:170:0)
[00:10:08.234] Timer tick, asking Buildbucket for the build status
[00:10:10.915] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:10.915] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:171:0) after 1m0s
[00:11:10.945] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:171:0)
[00:11:10.945] Timer tick, asking Buildbucket for the build status
[00:11:11.037] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:11.037] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:172:0) after 1m0s
[00:12:11.136] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:172:0)
[00:12:11.136] Timer tick, asking Buildbucket for the build status
[00:12:11.264] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:11.264] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:173:0) after 1m0s
[00:13:11.307] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:173:0)
[00:13:11.307] Timer tick, asking Buildbucket for the build status
[00:13:11.530] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:11.530] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:174:0) after 1m0s
[00:14:11.578] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:174:0)
[00:14:11.578] Timer tick, asking Buildbucket for the build status
[00:14:11.736] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:11.736] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:175:0) after 1m0s
[00:15:11.812] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:175:0)
[00:15:11.812] Timer tick, asking Buildbucket for the build status
[00:15:12.110] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:12.110] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:176:0) after 1m0s
[00:16:12.169] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:176:0)
[00:16:12.169] Timer tick, asking Buildbucket for the build status
[00:16:12.280] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:12.280] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:177:0) after 1m0s
[00:17:12.323] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:177:0)
[00:17:12.323] Timer tick, asking Buildbucket for the build status
[00:17:12.466] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:12.466] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:178:0) after 1m0s
[00:18:12.538] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:178:0)
[00:18:12.538] Timer tick, asking Buildbucket for the build status
[00:18:12.662] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:12.662] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:179:0) after 1m0s
[00:19:12.704] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:179:0)
[00:19:12.704] Timer tick, asking Buildbucket for the build status
[00:19:12.813] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:12.813] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:180:0) after 1m0s
[00:20:12.889] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:180:0)
[00:20:12.889] Timer tick, asking Buildbucket for the build status
[00:20:13.050] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:13.050] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:181:0) after 1m0s
[00:21:13.111] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:181:0)
[00:21:13.111] Timer tick, asking Buildbucket for the build status
[00:21:13.378] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:13.378] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:182:0) after 1m0s
[00:22:13.408] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:182:0)
[00:22:13.408] Timer tick, asking Buildbucket for the build status
[00:22:13.856] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:13.856] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:183:0) after 1m0s
[00:23:13.897] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:183:0)
[00:23:13.898] Timer tick, asking Buildbucket for the build status
[00:23:13.963] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:13.963] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:184:0) after 1m0s
[00:24:13.991] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:184:0)
[00:24:13.991] Timer tick, asking Buildbucket for the build status
[00:24:14.134] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:14.134] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:185:0) after 1m0s
[00:25:14.148] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:185:0)
[00:25:14.148] Timer tick, asking Buildbucket for the build status
[00:25:14.226] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:14.226] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:186:0) after 1m0s
[00:26:14.276] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:186:0)
[00:26:14.276] Timer tick, asking Buildbucket for the build status
[00:26:14.412] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:14.412] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:187:0) after 1m0s
[00:27:14.448] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:187:0)
[00:27:14.448] Timer tick, asking Buildbucket for the build status
[00:27:14.557] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:14.557] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:188:0) after 1m0s
[00:28:14.620] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:188:0)
[00:28:14.620] Timer tick, asking Buildbucket for the build status
[00:28:14.700] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:14.700] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:189:0) after 1m0s
[00:29:14.730] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:189:0)
[00:29:14.730] Timer tick, asking Buildbucket for the build status
[00:29:15.034] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:15.034] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:190:0) after 1m0s
[00:30:15.106] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:190:0)
[00:30:15.106] Timer tick, asking Buildbucket for the build status
[00:30:15.192] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:15.192] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:191:0) after 1m0s
[00:31:15.224] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:191:0)
[00:31:15.224] Timer tick, asking Buildbucket for the build status
[00:31:15.287] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:15.287] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:192:0) after 1m0s
[00:32:15.413] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:192:0)
[00:32:15.413] Timer tick, asking Buildbucket for the build status
[00:32:15.584] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:15.584] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:193:0) after 1m0s
[00:33:15.633] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:193:0)
[00:33:15.633] Timer tick, asking Buildbucket for the build status
[00:33:15.748] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:15.748] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:194:0) after 1m0s
[00:34:15.790] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:194:0)
[00:34:15.790] Timer tick, asking Buildbucket for the build status
[00:34:16.651] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:16.651] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:195:0) after 1m0s
[00:35:16.708] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:195:0)
[00:35:16.708] Timer tick, asking Buildbucket for the build status
[00:35:16.896] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:16.896] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:196:0) after 1m0s
[00:36:16.933] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:196:0)
[00:36:16.933] Timer tick, asking Buildbucket for the build status
[00:36:16.996] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:16.996] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:197:0) after 1m0s
[00:37:17.023] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:197:0)
[00:37:17.023] Timer tick, asking Buildbucket for the build status
[00:37:17.139] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:17.139] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:198:0) after 1m0s
[00:38:17.211] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:198:0)
[00:38:17.211] Timer tick, asking Buildbucket for the build status
[00:38:17.438] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:17.438] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:199:0) after 1m0s
[00:39:17.483] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:199:0)
[00:39:17.483] Timer tick, asking Buildbucket for the build status
[00:39:17.573] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:17.573] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:200:0) after 1m0s
[00:40:18.609] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:200:0)
[00:40:18.609] Timer tick, asking Buildbucket for the build status
[00:40:18.913] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:18.913] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:201:0) after 1m0s
[00:41:19.172] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:201:0)
[00:41:19.172] Timer tick, asking Buildbucket for the build status
[00:41:19.304] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:19.304] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:202:0) after 1m0s
[00:42:19.513] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:202:0)
[00:42:19.513] Timer tick, asking Buildbucket for the build status
[00:42:19.634] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:19.634] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:203:0) after 1m0s
[00:43:19.693] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:203:0)
[00:43:19.693] Timer tick, asking Buildbucket for the build status
[00:43:20.451] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:20.451] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:204:0) after 1m0s
[00:44:20.580] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:204:0)
[00:44:20.580] Timer tick, asking Buildbucket for the build status
[00:44:20.713] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:20.713] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:205:0) after 1m0s
[00:45:20.932] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:205:0)
[00:45:20.932] Timer tick, asking Buildbucket for the build status
[00:45:21.139] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:21.139] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:206:0) after 1m0s
[00:46:21.211] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:206:0)
[00:46:21.211] Timer tick, asking Buildbucket for the build status
[00:46:21.772] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:21.772] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:207:0) after 1m0s
[00:47:22.702] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:207:0)
[00:47:22.702] Timer tick, asking Buildbucket for the build status
[00:47:22.932] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:22.932] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:208:0) after 1m0s
[00:48:23.010] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:208:0)
[00:48:23.010] Timer tick, asking Buildbucket for the build status
[00:48:23.075] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:23.075] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:209:0) after 1m0s
[00:49:23.206] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:209:0)
[00:49:23.206] Timer tick, asking Buildbucket for the build status
[00:49:23.270] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:23.270] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:210:0) after 1m0s
[00:50:25.135] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:210:0)
[00:50:25.135] Timer tick, asking Buildbucket for the build status
[00:50:25.320] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:25.320] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:211:0) after 1m0s
[00:51:25.566] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:211:0)
[00:51:25.566] Timer tick, asking Buildbucket for the build status
[00:51:25.680] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:25.680] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:212:0) after 1m0s
[00:52:25.776] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:212:0)
[00:52:25.776] Timer tick, asking Buildbucket for the build status
[00:52:25.862] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:25.862] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:213:0) after 1m0s
[00:53:26.009] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:213:0)
[00:53:26.009] Timer tick, asking Buildbucket for the build status
[00:53:26.100] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:26.100] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:214:0) after 1m0s
[00:54:26.222] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:214:0)
[00:54:26.222] Timer tick, asking Buildbucket for the build status
[00:54:26.283] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:26.283] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:215:0) after 1m0s
[00:55:26.484] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:215:0)
[00:55:26.484] Timer tick, asking Buildbucket for the build status
[00:55:26.966] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:26.966] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:216:0) after 1m0s
[00:56:27.124] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:216:0)
[00:56:27.124] Timer tick, asking Buildbucket for the build status
[00:56:27.254] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:27.254] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:217:0) after 1m0s
[00:57:27.451] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:217:0)
[00:57:27.451] Timer tick, asking Buildbucket for the build status
[00:57:27.712] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:27.712] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:218:0) after 1m0s
[00:58:27.873] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:218:0)
[00:58:27.873] Timer tick, asking Buildbucket for the build status
[00:58:28.497] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:28.497] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:219:0) after 1m0s
[00:59:28.692] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:219:0)
[00:59:28.692] Timer tick, asking Buildbucket for the build status
[00:59:28.762] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:28.762] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:220:0) after 1m0s
[01:00:29.008] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:220:0)
[01:00:29.008] Timer tick, asking Buildbucket for the build status
[01:00:29.085] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:29.085] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:221:0) after 1m0s
[01:01:29.171] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:221:0)
[01:01:29.171] Timer tick, asking Buildbucket for the build status
[01:01:29.277] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:29.277] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:222:0) after 1m0s
[01:02:29.340] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:222:0)
[01:02:29.340] Timer tick, asking Buildbucket for the build status
[01:02:29.428] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:29.428] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:223:0) after 1m0s
[01:03:29.565] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:223:0)
[01:03:29.565] Timer tick, asking Buildbucket for the build status
[01:03:29.652] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:29.652] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:224:0) after 1m0s
[01:04:30.026] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:224:0)
[01:04:30.026] Timer tick, asking Buildbucket for the build status
[01:04:30.094] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:30.094] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:225:0) after 1m0s
[01:05:30.363] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:225:0)
[01:05:30.363] Timer tick, asking Buildbucket for the build status
[01:05:30.494] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:30.494] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:226:0) after 1m0s
[01:06:30.650] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:226:0)
[01:06:30.650] Timer tick, asking Buildbucket for the build status
[01:06:30.812] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:30.812] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:227:0) after 1m0s
[01:07:30.931] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:227:0)
[01:07:30.931] Timer tick, asking Buildbucket for the build status
[01:07:31.012] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:31.012] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:228:0) after 1m0s
[01:08:31.229] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:228:0)
[01:08:31.229] Timer tick, asking Buildbucket for the build status
[01:08:31.370] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:31.370] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:229:0) after 1m0s
[01:09:31.517] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:229:0)
[01:09:31.517] Timer tick, asking Buildbucket for the build status
[01:09:32.139] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:32.139] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:230:0) after 1m0s
[01:10:32.253] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:230:0)
[01:10:32.253] Timer tick, asking Buildbucket for the build status
[01:10:32.328] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:32.329] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:231:0) after 1m0s
[01:11:32.414] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:231:0)
[01:11:32.414] Timer tick, asking Buildbucket for the build status
[01:11:32.758] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:32.758] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:232:0) after 1m0s
[01:12:32.748] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:232:0)
[01:12:32.748] Timer tick, asking Buildbucket for the build status
[01:12:32.952] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:32.952] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:233:0) after 1m0s
[01:13:33.024] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:233:0)
[01:13:33.024] Timer tick, asking Buildbucket for the build status
[01:13:33.106] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:33.106] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:234:0) after 1m0s
[01:14:33.175] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:234:0)
[01:14:33.175] Timer tick, asking Buildbucket for the build status
[01:14:36.330] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:36.330] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:235:0) after 1m0s
[01:15:36.533] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:235:0)
[01:15:36.533] Timer tick, asking Buildbucket for the build status
[01:15:36.617] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:36.617] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:236:0) after 1m0s
[01:16:36.736] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:236:0)
[01:16:36.736] Timer tick, asking Buildbucket for the build status
[01:16:36.899] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:36.899] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:237:0) after 1m0s
[01:17:37.098] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:237:0)
[01:17:37.098] Timer tick, asking Buildbucket for the build status
[01:17:37.172] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:37.172] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:238:0) after 1m0s
[01:18:37.248] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:238:0)
[01:18:37.248] Timer tick, asking Buildbucket for the build status
[01:18:37.344] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:37.344] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:239:0) after 1m0s
[01:19:37.403] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:239:0)
[01:19:37.403] Timer tick, asking Buildbucket for the build status
[01:19:37.460] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:37.460] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:240:0) after 1m0s
[01:20:37.499] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:240:0)
[01:20:37.499] Timer tick, asking Buildbucket for the build status
[01:20:37.581] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:37.581] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:241:0) after 1m0s
[01:21:37.646] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:241:0)
[01:21:37.646] Timer tick, asking Buildbucket for the build status
[01:21:37.751] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:37.751] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:242:0) after 1m0s
[01:22:37.934] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:242:0)
[01:22:37.934] Timer tick, asking Buildbucket for the build status
[01:22:38.011] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:38.012] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:243:0) after 1m0s
[01:23:38.121] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:243:0)
[01:23:38.121] Timer tick, asking Buildbucket for the build status
[01:23:38.185] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:38.185] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:244:0) after 1m0s
[01:24:38.291] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:244:0)
[01:24:38.291] Timer tick, asking Buildbucket for the build status
[01:24:38.379] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:38.379] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:245:0) after 1m0s
[01:25:38.436] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:245:0)
[01:25:38.436] Timer tick, asking Buildbucket for the build status
[01:25:38.512] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:38.512] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:246:0) after 1m0s
[01:26:38.607] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:246:0)
[01:26:38.607] Timer tick, asking Buildbucket for the build status
[01:26:39.260] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:39.260] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:247:0) after 1m0s
[01:27:39.313] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:247:0)
[01:27:39.313] Timer tick, asking Buildbucket for the build status
[01:27:39.417] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:39.417] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:248:0) after 1m0s
[01:28:39.474] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:248:0)
[01:28:39.474] Timer tick, asking Buildbucket for the build status
[01:28:39.669] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:39.669] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:249:0) after 1m0s
[01:29:39.714] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:249:0)
[01:29:39.714] Timer tick, asking Buildbucket for the build status
[01:29:39.786] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:39.786] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:250:0) after 1m0s
[01:30:39.876] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:250:0)
[01:30:39.876] Timer tick, asking Buildbucket for the build status
[01:30:39.941] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:39.941] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:251:0) after 1m0s
[01:31:39.959] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:251:0)
[01:31:39.959] Timer tick, asking Buildbucket for the build status
[01:31:40.182] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:40.182] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:252:0) after 1m0s
[01:32:40.186] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:252:0)
[01:32:40.186] Timer tick, asking Buildbucket for the build status
[01:32:42.351] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:42.351] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:253:0) after 1m0s
[01:33:42.513] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:253:0)
[01:33:42.513] Timer tick, asking Buildbucket for the build status
[01:33:42.578] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:42.578] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:254:0) after 1m0s
[01:34:42.733] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:254:0)
[01:34:42.733] Timer tick, asking Buildbucket for the build status
[01:34:42.820] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:42.820] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:255:0) after 1m0s
[01:35:42.924] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:255:0)
[01:35:42.924] Timer tick, asking Buildbucket for the build status
[01:35:44.210] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:44.210] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:256:0) after 1m0s
[01:36:44.287] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:256:0)
[01:36:44.287] Timer tick, asking Buildbucket for the build status
[01:36:44.386] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:44.386] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:257:0) after 1m0s
[01:37:44.441] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:257:0)
[01:37:44.441] Timer tick, asking Buildbucket for the build status
[01:37:44.512] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:44.512] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:258:0) after 1m0s
[01:38:44.546] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:258:0)
[01:38:44.546] Timer tick, asking Buildbucket for the build status
[01:38:45.705] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:45.705] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:259:0) after 1m0s
[01:39:45.741] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:259:0)
[01:39:45.741] Timer tick, asking Buildbucket for the build status
[01:39:45.831] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:45.831] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:260:0) after 1m0s
[01:40:45.867] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:260:0)
[01:40:45.867] Timer tick, asking Buildbucket for the build status
[01:40:45.941] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:45.941] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:261:0) after 1m0s
[01:41:46.023] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:261:0)
[01:41:46.023] Timer tick, asking Buildbucket for the build status
[01:41:46.153] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:46.153] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:262:0) after 1m0s
[01:42:46.180] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:262:0)
[01:42:46.180] Timer tick, asking Buildbucket for the build status
[01:42:46.306] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:46.306] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:263:0) after 1m0s
[01:43:46.399] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:263:0)
[01:43:46.399] Timer tick, asking Buildbucket for the build status
[01:43:46.892] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:46.892] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:264:0) after 1m0s
[01:44:46.987] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:264:0)
[01:44:46.987] Timer tick, asking Buildbucket for the build status
[01:44:47.059] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:47.059] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:265:0) after 1m0s
[01:45:47.137] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:265:0)
[01:45:47.137] Timer tick, asking Buildbucket for the build status
[01:45:47.341] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:47.341] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:266:0) after 1m0s
[01:46:47.448] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:266:0)
[01:46:47.448] Timer tick, asking Buildbucket for the build status
[01:46:47.564] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:47.564] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:267:0) after 1m0s
[01:47:47.677] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:267:0)
[01:47:47.677] Timer tick, asking Buildbucket for the build status
[01:47:47.744] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:47.744] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:268:0) after 1m0s
[01:48:47.836] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:268:0)
[01:48:47.836] Timer tick, asking Buildbucket for the build status
[01:48:48.148] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:48.148] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:269:0) after 1m0s
[01:49:48.315] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:269:0)
[01:49:48.315] Timer tick, asking Buildbucket for the build status
[01:49:48.439] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:48.439] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:270:0) after 1m0s
[01:50:48.518] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:270:0)
[01:50:48.518] Timer tick, asking Buildbucket for the build status
[01:50:48.826] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:48.826] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:271:0) after 1m0s
[01:51:48.855] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:271:0)
[01:51:48.855] Timer tick, asking Buildbucket for the build status
[01:51:48.963] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:48.963] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:272:0) after 1m0s
[01:52:49.148] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:272:0)
[01:52:49.148] Timer tick, asking Buildbucket for the build status
[01:52:49.228] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:49.228] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:273:0) after 1m0s
[01:53:49.296] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:273:0)
[01:53:49.296] Timer tick, asking Buildbucket for the build status
[01:53:49.382] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:49.382] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:274:0) after 1m0s
[01:54:49.471] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:274:0)
[01:54:49.471] Timer tick, asking Buildbucket for the build status
[01:54:49.550] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:49.550] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:275:0) after 1m0s
[01:55:49.547] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:275:0)
[01:55:49.547] Timer tick, asking Buildbucket for the build status
[01:55:49.600] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:49.600] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:276:0) after 1m0s
[01:56:49.763] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:276:0)
[01:56:49.763] Timer tick, asking Buildbucket for the build status
[01:56:49.943] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:49.943] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:277:0) after 1m0s
[01:57:50.000] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:277:0)
[01:57:50.000] Timer tick, asking Buildbucket for the build status
[01:57:50.069] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:50.069] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:278:0) after 1m0s
[01:58:50.159] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:278:0)
[01:58:50.159] Timer tick, asking Buildbucket for the build status
[01:58:50.253] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:50.253] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:279:0) after 1m0s
[01:59:50.353] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:279:0)
[01:59:50.353] Timer tick, asking Buildbucket for the build status
[01:59:50.426] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:50.426] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:280:0) after 1m0s
[02:00:50.515] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:280:0)
[02:00:50.515] Timer tick, asking Buildbucket for the build status
[02:00:50.735] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:50.735] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:281:0) after 1m0s
[02:01:50.799] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:281:0)
[02:01:50.799] Timer tick, asking Buildbucket for the build status
[02:01:51.011] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:51.011] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:282:0) after 1m0s
[02:02:51.092] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:282:0)
[02:02:51.092] Timer tick, asking Buildbucket for the build status
[02:02:51.175] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:51.175] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:283:0) after 1m0s
[02:03:51.216] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:283:0)
[02:03:51.216] Timer tick, asking Buildbucket for the build status
[02:03:51.289] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:51.289] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:284:0) after 1m0s
[02:04:51.331] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:284:0)
[02:04:51.331] Timer tick, asking Buildbucket for the build status
[02:04:51.397] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:51.397] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:285:0) after 1m0s
[02:05:51.430] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:285:0)
[02:05:51.430] Timer tick, asking Buildbucket for the build status
[02:05:51.508] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:51.508] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:286:0) after 1m0s
[02:06:51.551] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:286:0)
[02:06:51.551] Timer tick, asking Buildbucket for the build status
[02:06:51.659] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:51.659] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:287:0) after 1m0s
[02:07:51.706] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:287:0)
[02:07:51.706] Timer tick, asking Buildbucket for the build status
[02:07:51.777] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:51.777] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:288:0) after 1m0s
[02:08:51.836] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:288:0)
[02:08:51.836] Timer tick, asking Buildbucket for the build status
[02:08:52.283] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:52.283] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:289:0) after 1m0s
[02:09:52.410] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:289:0)
[02:09:52.410] Timer tick, asking Buildbucket for the build status
[02:09:52.526] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:52.526] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:290:0) after 1m0s
[02:10:52.600] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:290:0)
[02:10:52.600] Timer tick, asking Buildbucket for the build status
[02:10:53.285] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:53.285] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:291:0) after 1m0s
[02:11:53.335] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:291:0)
[02:11:53.335] Timer tick, asking Buildbucket for the build status
[02:11:53.431] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:53.431] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:292:0) after 1m0s
[02:12:53.503] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:292:0)
[02:12:53.503] Timer tick, asking Buildbucket for the build status
[02:12:53.566] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:53.566] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:293:0) after 1m0s
[02:13:53.626] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:293:0)
[02:13:53.626] Timer tick, asking Buildbucket for the build status
[02:13:53.702] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:53.703] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:294:0) after 1m0s
[02:14:53.904] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:294:0)
[02:14:53.904] Timer tick, asking Buildbucket for the build status
[02:14:53.990] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:53.990] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:295:0) after 1m0s
[02:15:54.078] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:295:0)
[02:15:54.078] Timer tick, asking Buildbucket for the build status
[02:15:54.139] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:54.139] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:296:0) after 1m0s
[02:16:54.201] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:296:0)
[02:16:54.201] Timer tick, asking Buildbucket for the build status
[02:16:54.395] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:54.395] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:297:0) after 1m0s
[02:17:54.464] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:297:0)
[02:17:54.464] Timer tick, asking Buildbucket for the build status
[02:17:54.532] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:54.532] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:298:0) after 1m0s
[02:18:54.666] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:298:0)
[02:18:54.666] Timer tick, asking Buildbucket for the build status
[02:18:54.883] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:54.884] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:299:0) after 1m0s
[02:19:55.256] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:299:0)
[02:19:55.256] Timer tick, asking Buildbucket for the build status
[02:19:55.633] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:55.633] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:300:0) after 1m0s
[02:20:55.717] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:300:0)
[02:20:55.717] Timer tick, asking Buildbucket for the build status
[02:20:55.812] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:55.812] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:301:0) after 1m0s
[02:21:55.879] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:301:0)
[02:21:55.879] Timer tick, asking Buildbucket for the build status
[02:21:56.019] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:56.019] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:302:0) after 1m0s
[02:22:56.109] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:302:0)
[02:22:56.109] Timer tick, asking Buildbucket for the build status
[02:22:56.192] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:56.192] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:303:0) after 1m0s
[02:23:56.276] Handling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:303:0)
[02:23:56.276] Timer tick, asking Buildbucket for the build status
[02:23:56.341] Build 8864527448343938848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:56.341] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9029957513639292176:304:0) after 1m0s
[02:24:15.105] Received PubSub notification, asking Buildbucket for the build status
[02:24:15.178] Build 8864527448343938848: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:24:15.178] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604543054329628",
"created_by": "project:chromium",
"created_ts": "1604524867644936",
"id": "8864527448343938848",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7a322ca1d86378dc5328291db1bb948937dd18ad\"}}",
"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\": \"7a322ca1d86378dc5328291db1bb948937dd18ad\", \"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-diqk\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 963, \"got_angle_revision\": \"4989667a9c4c8f093a539ac45b9c93798e093890\", \"got_dawn_revision\": \"6564890116fd5629ad76948f12ad158d6f111cc3\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"7a322ca1d86378dc5328291db1bb948937dd18ad\", \"got_revision_cp\": \"refs/heads/master@{#824149}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"419b7d7bd1645705b1bf87f5d56c97bdaee85e89\", \"got_v8_revision\": \"7ae0bc9f7258d206e0de93911c5987c3e04979b8\", \"got_v8_revision_cp\": \"refs/heads/8.8.228@{#1}\", \"got_webrtc_revision\": \"42cafa5696f516712bbe6709fedeedffac61544c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32540}\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7a322ca1d86378dc5328291db1bb948937dd18ad\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_9b3ebe5fd1c5be87380c40d216747346a59b28cf26de183f0e8e2b32e944d3c8_v2\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-2-diqk\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5614-d862eaa\"], \"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": "1604524962266310",
"status": "COMPLETED",
"status_changed_ts": "1604543054834359",
"tags": [
"build_address:luci.chromium.ci/win-official/963",
"builder:win-official",
"buildset:commit/git/7a322ca1d86378dc5328291db1bb948937dd18ad",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7a322ca1d86378dc5328291db1bb948937dd18ad",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029957513639292176",
"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/8864527448343938848/+/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:4fadf40b9e879010",
"user_agent:luci-scheduler"
],
"updated_ts": "1604543054838284",
"url": "https://ci.chromium.org/b/8864527448343938848",
"utcnow_ts": "1604543055168615"
}
}
[02:24:15.178] Invocation finished in 5h3m11.96828259s with status SUCCEEDED