This job view page is being replaced by Spyglass soon. Check out the new job view.
PRasychev: Add Priority Class support for catalog Helm Chart
ResultFAILURE
Tests 0 failed / 0 succeeded
Started2020-08-24 17:55
Elapsed14m5s
Revision3786707d9d67134928cb1966b59ac23dad1deceb
Refs 2832

No Test Failures!


Error lines from build-log.txt

... skipping 200 lines ...
+ /go/src/github.com/kubernetes-sigs/service-catalog/bin/deepcopy-gen --v 1 --logtostderr --go-header-file contrib/hack/boilerplate.go.txt --input-dirs github.com/kubernetes-sigs/service-catalog/pkg/apis/servicecatalog/v1beta1 --bounding-dirs github.com/kubernetes-sigs/service-catalog --output-file-base zz_generated.deepcopy
+ /go/src/github.com/kubernetes-sigs/service-catalog/bin/defaulter-gen --v 1 --logtostderr --go-header-file contrib/hack/boilerplate.go.txt --input-dirs github.com/kubernetes-sigs/service-catalog/pkg/apis/settings --input-dirs github.com/kubernetes-sigs/service-catalog/pkg/apis/settings/v1alpha1 --extra-peer-dirs github.com/kubernetes-sigs/service-catalog/pkg/apis/settings --extra-peer-dirs github.com/kubernetes-sigs/service-catalog/pkg/apis/settings/v1alpha1 --output-file-base zz_generated.defaults
+ /go/src/github.com/kubernetes-sigs/service-catalog/bin/deepcopy-gen --v 1 --logtostderr --go-header-file contrib/hack/boilerplate.go.txt --input-dirs github.com/kubernetes-sigs/service-catalog/pkg/apis/settings --input-dirs github.com/kubernetes-sigs/service-catalog/pkg/apis/settings/v1alpha1 --bounding-dirs github.com/kubernetes-sigs/service-catalog --output-file-base zz_generated.deepcopy
+ /go/src/github.com/kubernetes-sigs/service-catalog/bin/conversion-gen --v 1 --logtostderr --extra-peer-dirs k8s.io/api/core/v1,k8s.io/apimachinery/pkg/apis/meta/v1,k8s.io/apimachinery/pkg/conversion,k8s.io/apimachinery/pkg/runtime --go-header-file contrib/hack/boilerplate.go.txt --input-dirs github.com/kubernetes-sigs/service-catalog/pkg/apis/settings --input-dirs github.com/kubernetes-sigs/service-catalog/pkg/apis/settings/v1alpha1 --output-file-base zz_generated.conversion
+ REPORT_FILENAME=./api_violations.txt
+ KNOWN_VIOLATION_FILENAME=./contrib/build/violation_exceptions.txt
+ API_RULE_CHECK_FAILURE_MESSAGE='Error: API rules check failed. Reported violations "./api_violations.txt" differ from known violations "./contrib/build/violation_exceptions.txt". Please fix API source file if new violation is detected, or update known violations "./contrib/build/violation_exceptions.txt" if existing violation is being fixed. Please refer to k8s.io/kubernetes/api/api-rules/README.md and https://github.com/kubernetes/kube-openapi/tree/master/pkg/generators/rules for more information about the API rules being enforced.'
+ /go/src/github.com/kubernetes-sigs/service-catalog/bin/openapi-gen --v 3 --logtostderr --go-header-file contrib/hack/boilerplate.go.txt --input-dirs github.com/kubernetes-sigs/service-catalog/pkg/apis/servicecatalog/v1beta1,k8s.io/api/core/v1,k8s.io/apimachinery/pkg/api/resource,k8s.io/apimachinery/pkg/apis/meta/v1,k8s.io/apimachinery/pkg/version,k8s.io/apimachinery/pkg/runtime --input-dirs github.com/kubernetes-sigs/service-catalog/pkg/apis/settings/v1alpha1 --output-package github.com/kubernetes-sigs/service-catalog/pkg/openapi --report-filename ./api_violations.txt
I0824 17:59:27.032972    2890 openapi.go:461] [k8s.io/api/core/v1.PodSpec] Volumes []k8s.io/api/core/v1.Volume: [merge,retainKeys] not allowed for patchStrategy. Allowed values: [merge retainKeys]
I0824 17:59:27.310307    2890 openapi.go:461] [k8s.io/apimachinery/pkg/apis/meta/v1.LabelSelectorRequirement] Key string: tag patchMergeKey on type Builtin; only allowed on type Slice
I0824 17:59:27.310818    2890 openapi.go:461] [k8s.io/apimachinery/pkg/apis/meta/v1.LabelSelectorRequirement] Key string: tag patchStrategy on type Builtin; only allowed on type Slice
I0824 17:59:28.759732    2890 api_linter.go:44] Assembling file "./api_violations.txt"
+ diff -u ./api_violations.txt ./contrib/build/violation_exceptions.txt
... skipping 126 lines ...
I0824 18:07:13.551666       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Unbind request for ServiceBinding in-flight to Broker
I0824 18:07:13.551797       1 controller_binding.go:712] ServiceBinding "test-ns/test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:13.551635498 +0000 UTC m=+0.299359999
I0824 18:07:13.552248       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": The binding was deleted successfully
I0824 18:07:13.552384       1 controller_binding.go:1534] ServiceBinding "test-ns/test-binding": Status updated
I0824 18:07:13.552460       1 controller_binding.go:1545] ServiceBinding "test-ns/test-binding": Cleared finalizer
I0824 18:07:13.638666       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": The binding is being created asynchronously (testdescr)
I0824 18:07:13.673854       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Bind call failed: testdescr
I0824 18:07:13.673972       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Bind call failed: testdescr
W0824 18:07:13.699969       1 controller_binding.go:1095] ServiceBinding "test-ns/test-binding": Got invalid state in LastOperationResponse: "test invalid state"
I0824 18:07:13.726256       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": The asynchronous Bind operation timed out and will not be retried
I0824 18:07:13.726378       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Stopping reconciliation retries because too much time has elapsed
I0824 18:07:13.726483       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Starting orphan mitigation
W0824 18:07:13.746893       1 controller_binding.go:1095] ServiceBinding "test-ns/test-binding": Got invalid state in LastOperationResponse: "test invalid state"
I0824 18:07:13.746998       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": The asynchronous Bind operation timed out and will not be retried
I0824 18:07:13.747067       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Stopping reconciliation retries because too much time has elapsed
I0824 18:07:13.747177       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Starting orphan mitigation
I0824 18:07:13.769454       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Could not do a GET on binding resource: some error
I0824 18:07:13.769580       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Could not do a GET on binding resource: some error
I0824 18:07:13.769659       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Starting orphan mitigation
I0824 18:07:13.804189       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Error injecting bind results: Secret "test-ns/test-binding" is not owned by ServiceBinding, controllerRef: nil
I0824 18:07:13.804302       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Error injecting bind results: Secret "test-ns/test-binding" is not owned by ServiceBinding, controllerRef: nil
I0824 18:07:13.804388       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Starting orphan mitigation
I0824 18:07:13.836028       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Injected bind result
I0824 18:07:13.859607       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": The binding was deleted successfully
I0824 18:07:13.859800       1 controller_binding.go:1534] ServiceBinding "test-ns/test-binding": Status updated
I0824 18:07:13.859888       1 controller_binding.go:1545] ServiceBinding "test-ns/test-binding": Cleared finalizer
I0824 18:07:13.874681       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": The binding was deleted successfully
I0824 18:07:13.874849       1 controller_binding.go:1534] ServiceBinding "test-ns/test-binding": Status updated
I0824 18:07:13.874909       1 controller_binding.go:1545] ServiceBinding "test-ns/test-binding": Cleared finalizer
I0824 18:07:13.903751       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": The binding is being deleted asynchronously (testdescr)
I0824 18:07:13.961193       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Unbind call failed: testdescr
W0824 18:07:13.993861       1 controller_binding.go:1095] ServiceBinding "test-ns/test-binding": Got invalid state in LastOperationResponse: "test invalid state"
I0824 18:07:14.025024       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": The asynchronous Unbind operation timed out and will not be retried
I0824 18:07:14.025204       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Stopping reconciliation retries because too much time has elapsed
W0824 18:07:14.059650       1 controller_binding.go:1095] ServiceBinding "test-ns/test-binding": Got invalid state in LastOperationResponse: "test invalid state"
I0824 18:07:14.059784       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": The asynchronous Unbind operation timed out and will not be retried
I0824 18:07:14.059939       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Stopping reconciliation retries because too much time has elapsed
I0824 18:07:14.109498       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Unbind call failed: testdescr
I0824 18:07:14.109680       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Stopping reconciliation retries because too much time has elapsed
I0824 18:07:14.132622       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Orphan mitigation was completed successfully
I0824 18:07:14.161274       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Orphan mitigation was completed successfully
I0824 18:07:14.193118       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": The binding is being deleted asynchronously (testdescr)
I0824 18:07:14.261421       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Unbind call failed: testdescr
W0824 18:07:14.288483       1 controller_binding.go:1095] ServiceBinding "test-ns/test-binding": Got invalid state in LastOperationResponse: "test invalid state"
I0824 18:07:14.328509       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": The asynchronous Unbind operation timed out and will not be retried
I0824 18:07:14.328711       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Orphan mitigation failed: Stopping reconciliation retries because too much time has elapsed
W0824 18:07:14.369112       1 controller_binding.go:1095] ServiceBinding "test-ns/test-binding": Got invalid state in LastOperationResponse: "test invalid state"
I0824 18:07:14.369263       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": The asynchronous Unbind operation timed out and will not be retried
I0824 18:07:14.370083       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Orphan mitigation failed: Stopping reconciliation retries because too much time has elapsed
I0824 18:07:14.422866       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Unbind call failed: testdescr
I0824 18:07:14.423097       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Orphan mitigation failed: Stopping reconciliation retries because too much time has elapsed
I0824 18:07:14.468781       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Unbind request for ServiceBinding in-flight to Broker
I0824 18:07:14.468950       1 controller_binding.go:712] ServiceBinding "test-ns/test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:14.468747963 +0000 UTC m=+1.216472471
I0824 18:07:14.469413       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": The binding is being deleted asynchronously
I0824 18:07:14.539221       1 controller_binding.go:698] ServiceBinding "test-binding": References a non-existent ServiceInstance "/nothere"
I0824 18:07:14.539391       1 controller_binding.go:712] ServiceBinding "test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:14.539141088 +0000 UTC m=+1.286865607
I0824 18:07:14.564377       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Binding cannot begin because ClusterServiceClass and ClusterServicePlan references for ServiceInstance "test-ns/test-instance" have not been resolved yet
... skipping 2 lines ...
I0824 18:07:14.593305       1 controller_binding.go:712] ServiceBinding "test-ns/test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:14.593059441 +0000 UTC m=+1.340792602
W0824 18:07:14.621787       1 controller.go:585] ServiceInstance "test-ns/test-instance": References a non-existent ClusterServiceClass "nosuchclassid" - {ClusterServiceClassExternalName:"nothere"}
I0824 18:07:14.621939       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": The binding references a ClusterServiceClass that does not exist. References a non-existent ClusterServiceClass "nosuchclassid" - {ClusterServiceClassExternalName:"nothere"}
I0824 18:07:14.622031       1 controller_binding.go:712] ServiceBinding "test-ns/test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:14.621911337 +0000 UTC m=+1.369635856
I0824 18:07:14.657562       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Binding request for ServiceBinding in-flight to Broker
I0824 18:07:14.657762       1 controller_binding.go:712] ServiceBinding "test-ns/test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:14.657541493 +0000 UTC m=+1.405265999
I0824 18:07:14.658342       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Error injecting bind result: Secret "test-ns/test-binding" is not owned by ServiceBinding, controllerRef: nil
I0824 18:07:14.696949       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Binding request for ServiceBinding in-flight to Broker
I0824 18:07:14.697161       1 controller_binding.go:712] ServiceBinding "test-ns/test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:14.696933187 +0000 UTC m=+1.444657685
I0824 18:07:14.698649       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Injected bind result
I0824 18:07:14.736225       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Binding request for ServiceBinding in-flight to Broker
I0824 18:07:14.736399       1 controller_binding.go:712] ServiceBinding "test-ns/test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:14.736205185 +0000 UTC m=+1.483929690
I0824 18:07:14.736791       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Injected bind result
... skipping 6 lines ...
I0824 18:07:14.859806       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": References a non-bindable ClusterServiceClass (K8S: "cscguid" ExternalName: "test-clusterserviceclass") and Plan ("test-unbindable-clusterserviceplan") combination
I0824 18:07:14.860010       1 controller_binding.go:712] ServiceBinding "test-ns/test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:14.859784979 +0000 UTC m=+1.607509493
I0824 18:07:14.860071       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": References a non-bindable ClusterServiceClass (K8S: "cscguid" ExternalName: "test-clusterserviceclass") and Plan ("test-unbindable-clusterserviceplan") combination
I0824 18:07:14.904633       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Binding cannot begin because referenced ServiceInstance "test-ns/test-instance" is not ready
I0824 18:07:14.904804       1 controller_binding.go:712] ServiceBinding "test-ns/test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:14.904613535 +0000 UTC m=+1.652338047
I0824 18:07:14.951636       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": 
I0824 18:07:14.952108       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Failed to get namespace "test-ns" during binding: No namespace
I0824 18:07:14.952208       1 controller_binding.go:712] ServiceBinding "test-ns/test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:14.952091817 +0000 UTC m=+1.699816328
I0824 18:07:14.996729       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Unbind request for ServiceBinding in-flight to Broker
I0824 18:07:14.997000       1 controller_binding.go:712] ServiceBinding "test-ns/test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:14.996690635 +0000 UTC m=+1.744415137
I0824 18:07:15.000978       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": The binding was deleted successfully
I0824 18:07:15.001128       1 controller_binding.go:1534] ServiceBinding "test-ns/test-binding": Status updated
I0824 18:07:15.001232       1 controller_binding.go:1545] ServiceBinding "test-ns/test-binding": Cleared finalizer
... skipping 15 lines ...
I0824 18:07:15.103264       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Unbind request for ServiceBinding in-flight to Broker
I0824 18:07:15.103819       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": The binding was deleted successfully
I0824 18:07:15.104066       1 controller_binding.go:1534] ServiceBinding "test-ns/test-binding": Status updated
I0824 18:07:15.104170       1 controller_binding.go:1545] ServiceBinding "test-ns/test-binding": Cleared finalizer
I0824 18:07:15.134801       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Binding request for ServiceBinding in-flight to Broker
I0824 18:07:15.134989       1 controller_binding.go:712] ServiceBinding "test-ns/test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:15.13478434 +0000 UTC m=+1.882508838
I0824 18:07:15.135480       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Error creating ServiceBinding for ServiceInstance "test-ns/test-instance" of ClusterServiceClass (K8S: "cscguid" ExternalName: "test-clusterserviceclass") at ClusterServiceBroker "test-clusterservicebroker": Unexpected action
I0824 18:07:15.173775       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Binding request for ServiceBinding in-flight to Broker
I0824 18:07:15.173987       1 controller_binding.go:712] ServiceBinding "test-ns/test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:15.173747072 +0000 UTC m=+1.921471584
I0824 18:07:15.175666       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": ServiceBroker returned failure; bind operation will not be retried: Status: 422; ErrorMessage: AsyncRequired; Description: This service plan requires client support for asynchronous service operations.; ResponseError: <nil>
I0824 18:07:15.176191       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": ServiceBroker returned failure; bind operation will not be retried: Status: 422; ErrorMessage: AsyncRequired; Description: This service plan requires client support for asynchronous service operations.; ResponseError: <nil>
I0824 18:07:15.286173       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Binding request for ServiceBinding in-flight to Broker
I0824 18:07:15.286387       1 controller_binding.go:712] ServiceBinding "test-ns/test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:15.286156056 +0000 UTC m=+2.033880554
I0824 18:07:15.286942       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Error creating ServiceBinding for ServiceInstance "test-ns/test-instance" of ClusterServiceClass (K8S: "cscguid" ExternalName: "test-clusterserviceclass") at ClusterServiceBroker "test-clusterservicebroker": fake creation failure
I0824 18:07:15.332652       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Binding request for ServiceBinding in-flight to Broker
I0824 18:07:15.332876       1 controller_binding.go:712] ServiceBinding "test-ns/test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:15.332633101 +0000 UTC m=+2.080357605
I0824 18:07:15.333385       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": ServiceBroker returned failure; bind operation will not be retried: Status: 409; ErrorMessage: ServiceBindingExists; Description: Service binding with the same id, for the same service instance already exists.; ResponseError: <nil>
I0824 18:07:15.333529       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": ServiceBroker returned failure; bind operation will not be retried: Status: 409; ErrorMessage: ServiceBindingExists; Description: Service binding with the same id, for the same service instance already exists.; ResponseError: <nil>
I0824 18:07:15.375753       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": 
I0824 18:07:15.375962       1 controller_binding.go:712] ServiceBinding "test-ns/test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:15.375725505 +0000 UTC m=+2.123450016
I0824 18:07:15.417479       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": 
I0824 18:07:15.483622       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": bar
I0824 18:07:15.531546       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": 
I0824 18:07:15.584212       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": 
I0824 18:07:15.625779       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": 
I0824 18:07:15.701147       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Unbind request for ServiceBinding in-flight to Broker
I0824 18:07:15.701401       1 controller_binding.go:712] ServiceBinding "test-ns/test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:15.701122588 +0000 UTC m=+2.448847085
I0824 18:07:15.708143       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Error unbinding from ServiceInstance "test-ns/test-instance" of ClusterServiceClass (K8S: "cscguid" ExternalName: "test-clusterserviceclass") at ClusterServiceBroker "test-clusterservicebroker": Unexpected action
I0824 18:07:15.759934       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Unbind request for ServiceBinding in-flight to Broker
I0824 18:07:15.760195       1 controller_binding.go:712] ServiceBinding "test-ns/test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:15.75991672 +0000 UTC m=+2.507641218
I0824 18:07:15.767018       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Error unbinding from ServiceInstance "test-ns/test-instance" of ClusterServiceClass (K8S: "cscguid" ExternalName: "test-clusterserviceclass") at ClusterServiceBroker "test-clusterservicebroker": Status: 410; ErrorMessage: <nil>; Description: <nil>; ResponseError: <nil>
W0824 18:07:15.772952       1 feature_gate.go:235] Setting GA feature gate OriginatingIdentity=false. It will be removed in a future release.
I0824 18:07:15.816242       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Binding request for ServiceBinding in-flight to Broker
I0824 18:07:15.816418       1 controller_binding.go:712] ServiceBinding "test-ns/test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:15.816226479 +0000 UTC m=+2.563950985
I0824 18:07:15.816986       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Injected bind result
W0824 18:07:15.823044       1 feature_gate.go:235] Setting GA feature gate OriginatingIdentity=true. It will be removed in a future release.
I0824 18:07:15.878934       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Binding request for ServiceBinding in-flight to Broker
... skipping 22 lines ...
I0824 18:07:16.063793       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": The binding was deleted successfully
I0824 18:07:16.063925       1 controller_binding.go:1534] ServiceBinding "test-ns/test-binding": Status updated
I0824 18:07:16.064057       1 controller_binding.go:1545] ServiceBinding "test-ns/test-binding": Cleared finalizer
W0824 18:07:16.064459       1 feature_gate.go:235] Setting GA feature gate OriginatingIdentity=true. It will be removed in a future release.
I0824 18:07:16.109880       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Injected bind result
I0824 18:07:16.110529       1 controller_binding.go:712] ServiceBinding "test-ns/test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:16.109855655 +0000 UTC m=+2.857580169
I0824 18:07:16.151609       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Error creating ServiceBinding for ServiceInstance "test-ns/test-instance" of ClusterServiceClass (K8S: "cscguid" ExternalName: "test-clusterserviceclass") at ClusterServiceBroker "test-clusterservicebroker": Unexpected action
I0824 18:07:16.151841       1 controller_binding.go:712] ServiceBinding "test-ns/test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:16.151569192 +0000 UTC m=+2.899293724
I0824 18:07:16.151905       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Stopping reconciliation retries, too much time has elapsed
I0824 18:07:16.183700       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Error injecting bind result: Secret "test-ns/test-binding" is not owned by ServiceBinding, controllerRef: nil
I0824 18:07:16.183866       1 controller_binding.go:712] ServiceBinding "test-ns/test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:16.183679828 +0000 UTC m=+2.931404340
I0824 18:07:16.183935       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Stopping reconciliation retries, too much time has elapsed
I0824 18:07:16.184092       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Starting orphan mitigation
I0824 18:07:16.231824       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Binding request for ServiceBinding in-flight to Broker
I0824 18:07:16.232048       1 controller_binding.go:712] ServiceBinding "test-ns/test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:16.231804942 +0000 UTC m=+2.979529441
E0824 18:07:16.232907       1 controller_binding.go:751] ServiceBinding "test-ns/test-binding": Error updating status: update error
I0824 18:07:16.294416       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Binding request for ServiceBinding in-flight to Broker
I0824 18:07:16.294996       1 controller_binding.go:712] ServiceBinding "test-ns/test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:16.294365348 +0000 UTC m=+3.042089862
I0824 18:07:16.296578       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Injected bind result
I0824 18:07:16.348392       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Binding request for ServiceBinding in-flight to Broker
I0824 18:07:16.348669       1 controller_binding.go:712] ServiceBinding "test-ns/test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:16.34837191 +0000 UTC m=+3.096096429
I0824 18:07:16.349731       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Error creating ServiceBinding for ServiceInstance "test-ns/test-instance" of ClusterServiceClass (K8S: "cscguid" ExternalName: "test-clusterserviceclass") at ClusterServiceBroker "test-clusterservicebroker": timed out
I0824 18:07:16.407616       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Binding request for ServiceBinding in-flight to Broker
I0824 18:07:16.407878       1 controller_binding.go:712] ServiceBinding "test-ns/test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:16.407583998 +0000 UTC m=+3.155308509
I0824 18:07:16.408600       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": ServiceBroker returned failure; bind operation will not be retried: Status: 200; ErrorMessage: <nil>; Description: <nil>; ResponseError: <nil>
I0824 18:07:16.408712       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": ServiceBroker returned failure; bind operation will not be retried: Status: 200; ErrorMessage: <nil>; Description: <nil>; ResponseError: <nil>
I0824 18:07:16.461205       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Binding request for ServiceBinding in-flight to Broker
I0824 18:07:16.461439       1 controller_binding.go:712] ServiceBinding "test-ns/test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:16.461162952 +0000 UTC m=+3.208887466
... skipping 21 lines ...
I0824 18:07:16.750818       1 controller_binding.go:712] ServiceBinding "test-ns/test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:16.750281935 +0000 UTC m=+3.498006442
I0824 18:07:16.752883       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": ServiceBroker returned failure; bind operation will not be retried: Status: 501; ErrorMessage: <nil>; Description: <nil>; ResponseError: <nil>
I0824 18:07:16.753030       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": ServiceBroker returned failure; bind operation will not be retried: Status: 501; ErrorMessage: <nil>; Description: <nil>; ResponseError: <nil>
I0824 18:07:16.753118       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Starting orphan mitigation
I0824 18:07:16.798299       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Orphan mitigation was completed successfully
I0824 18:07:16.798571       1 controller_binding.go:712] ServiceBinding "test-ns/test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:16.798263522 +0000 UTC m=+3.545988063
I0824 18:07:16.841149       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Error unbinding from ServiceInstance "test-ns/test-instance" of ClusterServiceClass (K8S: "cscguid" ExternalName: "test-clusterserviceclass") at ClusterServiceBroker "test-clusterservicebroker": timed out
I0824 18:07:16.844479       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Orphan mitigation failed: Stopping reconciliation retries, too much time has elapsed
I0824 18:07:16.874973       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Unbind request for ServiceBinding in-flight to Broker
I0824 18:07:16.875411       1 controller_binding.go:712] ServiceBinding "test-ns/test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:16.87494305 +0000 UTC m=+3.622667549
I0824 18:07:16.876502       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": The binding was deleted successfully
I0824 18:07:16.876787       1 controller_binding.go:1534] ServiceBinding "test-ns/test-binding": Status updated
I0824 18:07:16.876944       1 controller_binding.go:1545] ServiceBinding "test-ns/test-binding": Cleared finalizer
I0824 18:07:16.919482       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Unbind request for ServiceBinding in-flight to Broker
... skipping 5 lines ...
I0824 18:07:16.964606       1 controller_binding.go:712] ServiceBinding "test-ns/test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:16.964280135 +0000 UTC m=+3.712004653
I0824 18:07:16.968556       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": The binding is being created asynchronously
I0824 18:07:17.011963       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Unbind request for ServiceBinding in-flight to Broker
I0824 18:07:17.012214       1 controller_binding.go:712] ServiceBinding "test-ns/test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:17.011941737 +0000 UTC m=+3.759666236
I0824 18:07:17.013344       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": The binding is being deleted asynchronously
I0824 18:07:17.148568       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": The binding is being created asynchronously (testdescr)
I0824 18:07:17.187116       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Bind call failed: testdescr
I0824 18:07:17.187413       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Bind call failed: testdescr
W0824 18:07:17.219811       1 controller_binding.go:1095] ServiceBinding "test-ns/test-binding": Got invalid state in LastOperationResponse: "test invalid state"
I0824 18:07:17.271002       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": The asynchronous Bind operation timed out and will not be retried
I0824 18:07:17.271270       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Stopping reconciliation retries because too much time has elapsed
I0824 18:07:17.271433       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Starting orphan mitigation
W0824 18:07:17.306160       1 controller_binding.go:1095] ServiceBinding "test-ns/test-binding": Got invalid state in LastOperationResponse: "test invalid state"
I0824 18:07:17.306787       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": The asynchronous Bind operation timed out and will not be retried
I0824 18:07:17.306923       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Stopping reconciliation retries because too much time has elapsed
I0824 18:07:17.307071       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Starting orphan mitigation
I0824 18:07:17.321428       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Could not do a GET on binding resource: some error
I0824 18:07:17.321721       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Could not do a GET on binding resource: some error
I0824 18:07:17.321843       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Starting orphan mitigation
I0824 18:07:17.339220       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Error injecting bind results: Secret "test-ns/test-binding" is not owned by ServiceBinding, controllerRef: nil
I0824 18:07:17.339445       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Error injecting bind results: Secret "test-ns/test-binding" is not owned by ServiceBinding, controllerRef: nil
I0824 18:07:17.339554       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Starting orphan mitigation
I0824 18:07:17.398263       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Injected bind result
I0824 18:07:17.453378       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": The binding was deleted successfully
I0824 18:07:17.453653       1 controller_binding.go:1534] ServiceBinding "test-ns/test-binding": Status updated
I0824 18:07:17.453763       1 controller_binding.go:1545] ServiceBinding "test-ns/test-binding": Cleared finalizer
I0824 18:07:17.505140       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": The binding was deleted successfully
I0824 18:07:17.506029       1 controller_binding.go:1534] ServiceBinding "test-ns/test-binding": Status updated
I0824 18:07:17.506709       1 controller_binding.go:1545] ServiceBinding "test-ns/test-binding": Cleared finalizer
I0824 18:07:17.546363       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": The binding is being deleted asynchronously (testdescr)
I0824 18:07:17.639107       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Unbind call failed: testdescr
W0824 18:07:17.688132       1 controller_binding.go:1095] ServiceBinding "test-ns/test-binding": Got invalid state in LastOperationResponse: "test invalid state"
I0824 18:07:17.745512       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": The asynchronous Unbind operation timed out and will not be retried
I0824 18:07:17.745836       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Stopping reconciliation retries because too much time has elapsed
W0824 18:07:17.780690       1 controller_binding.go:1095] ServiceBinding "test-ns/test-binding": Got invalid state in LastOperationResponse: "test invalid state"
I0824 18:07:17.780868       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": The asynchronous Unbind operation timed out and will not be retried
I0824 18:07:17.781100       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Stopping reconciliation retries because too much time has elapsed
I0824 18:07:17.857783       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Unbind call failed: testdescr
I0824 18:07:17.858135       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Stopping reconciliation retries because too much time has elapsed
I0824 18:07:17.910272       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Orphan mitigation was completed successfully
I0824 18:07:17.972658       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Orphan mitigation was completed successfully
I0824 18:07:18.042288       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": The binding is being deleted asynchronously (testdescr)
I0824 18:07:18.144524       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Unbind call failed: testdescr
W0824 18:07:18.190359       1 controller_binding.go:1095] ServiceBinding "test-ns/test-binding": Got invalid state in LastOperationResponse: "test invalid state"
I0824 18:07:18.247114       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": The asynchronous Unbind operation timed out and will not be retried
I0824 18:07:18.247434       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Orphan mitigation failed: Stopping reconciliation retries because too much time has elapsed
W0824 18:07:18.304252       1 controller_binding.go:1095] ServiceBinding "test-ns/test-binding": Got invalid state in LastOperationResponse: "test invalid state"
I0824 18:07:18.304485       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": The asynchronous Unbind operation timed out and will not be retried
I0824 18:07:18.304680       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Orphan mitigation failed: Stopping reconciliation retries because too much time has elapsed
I0824 18:07:18.339718       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Unbind call failed: testdescr
I0824 18:07:18.340019       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Orphan mitigation failed: Stopping reconciliation retries because too much time has elapsed
I0824 18:07:19.284118       1 controller_clusterservicebroker.go:749] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServiceClasses
I0824 18:07:19.285714       1 controller_clusterservicebroker.go:766] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServicePlans
I0824 18:07:19.287102       1 controller_clusterservicebroker.go:654] ClusterServiceBroker "test-clusterservicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:19.287025067 +0000 UTC m=+6.034749589
I0824 18:07:19.329529       1 controller_clusterservicebroker.go:749] ClusterServiceBroker "test-clusterservicebroker": Found 1 ClusterServiceClasses
I0824 18:07:19.336551       1 controller_clusterservicebroker.go:766] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServicePlans
I0824 18:07:19.337417       1 controller_clusterservicebroker.go:654] ClusterServiceBroker "test-clusterservicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:19.33735759 +0000 UTC m=+6.085082149
... skipping 6 lines ...
I0824 18:07:19.539366       1 controller_clusterservicebroker.go:749] ClusterServiceBroker "test-clusterservicebroker": Found 1 ClusterServiceClasses
I0824 18:07:19.545845       1 controller_clusterservicebroker.go:766] ClusterServiceBroker "test-clusterservicebroker": Found 1 ClusterServicePlans
I0824 18:07:19.552691       1 controller_clusterservicebroker.go:654] ClusterServiceBroker "test-clusterservicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:19.552602235 +0000 UTC m=+6.300326779
I0824 18:07:19.595959       1 controller_clusterservicebroker.go:749] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServiceClasses
I0824 18:07:19.596968       1 controller_clusterservicebroker.go:766] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServicePlans
E0824 18:07:19.597371       1 controller_clusterservicebroker.go:484] ClusterServiceBroker "test-clusterservicebroker": ClusterServiceClass (K8S: "cscguid" ExternalName: "test-clusterserviceclass") already exists for Broker "notTheSame"
W0824 18:07:19.597723       1 controller_clusterservicebroker.go:267] ClusterServiceBroker "test-clusterservicebroker": Error reconciling ClusterServiceClass (K8S: "cscguid" ExternalName: "test-clusterserviceclass") (broker "test-clusterservicebroker"): ClusterServiceClass (K8S: "cscguid" ExternalName: "test-clusterserviceclass") already exists for Broker "notTheSame"
I0824 18:07:19.597987       1 controller_clusterservicebroker.go:654] ClusterServiceBroker "test-clusterservicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:19.597886023 +0000 UTC m=+6.345610561
I0824 18:07:19.649356       1 controller_clusterservicebroker.go:749] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServiceClasses
I0824 18:07:19.654857       1 controller_clusterservicebroker.go:766] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServicePlans
E0824 18:07:19.655363       1 controller_clusterservicebroker.go:572] ClusterServiceBroker "test-clusterservicebroker": ClusterServicePlan (K8S: "cspguid" ExternalName: "test-clusterserviceplan") already exists for Broker "notTheSame"
W0824 18:07:19.655578       1 controller_clusterservicebroker.go:327] ClusterServiceBroker "test-clusterservicebroker": Error reconciling ClusterServicePlan (K8S: "cspguid" ExternalName: "test-clusterserviceplan"): ClusterServicePlan (K8S: "cspguid" ExternalName: "test-clusterserviceplan") already exists for Broker "notTheSame"
I0824 18:07:19.655754       1 controller_clusterservicebroker.go:654] ClusterServiceBroker "test-clusterservicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:19.655689117 +0000 UTC m=+6.403413651
I0824 18:07:19.719902       1 controller_clusterservicebroker.go:749] ClusterServiceBroker "test-clusterservicebroker": Found 1 ClusterServiceClasses
I0824 18:07:19.721137       1 controller_clusterservicebroker.go:766] ClusterServiceBroker "test-clusterservicebroker": Found 1 ClusterServicePlans
I0824 18:07:19.723498       1 controller_clusterservicebroker.go:654] ClusterServiceBroker "test-clusterservicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:19.723395044 +0000 UTC m=+6.471119569
I0824 18:07:19.798391       1 controller_clusterservicebroker.go:749] ClusterServiceBroker "test-clusterservicebroker": Found 1 ClusterServiceClasses
I0824 18:07:19.799536       1 controller_clusterservicebroker.go:766] ClusterServiceBroker "test-clusterservicebroker": Found 1 ClusterServicePlans
I0824 18:07:19.799964       1 controller_clusterservicebroker.go:654] ClusterServiceBroker "test-clusterservicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:19.799904178 +0000 UTC m=+6.547628701
I0824 18:07:19.882473       1 controller_clusterservicebroker.go:749] ClusterServiceBroker "test-clusterservicebroker": Found 1 ClusterServiceClasses
I0824 18:07:19.889553       1 controller_clusterservicebroker.go:766] ClusterServiceBroker "test-clusterservicebroker": Found 1 ClusterServicePlans
I0824 18:07:19.889859       1 controller_clusterservicebroker.go:654] ClusterServiceBroker "test-clusterservicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:19.88980911 +0000 UTC m=+6.637533636
W0824 18:07:19.972066       1 controller_clusterservicebroker.go:184] ClusterServiceBroker "test-clusterservicebroker": Error getting broker catalog: ooops
I0824 18:07:19.972391       1 controller_clusterservicebroker.go:654] ClusterServiceBroker "test-clusterservicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:19.972315149 +0000 UTC m=+6.720039691
I0824 18:07:20.027090       1 controller_clusterservicebroker.go:749] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServiceClasses
I0824 18:07:20.034625       1 controller_clusterservicebroker.go:766] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServicePlans
I0824 18:07:20.035169       1 controller_clusterservicebroker.go:654] ClusterServiceBroker "test-clusterservicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:20.035108985 +0000 UTC m=+6.782833538
I0824 18:07:20.370171       1 controller_clusterservicebroker.go:135] ClusterServiceBroker "test-clusterservicebroker": Error getting broker auth credentials: auth secret didn't contain token
I0824 18:07:20.371748       1 controller_clusterservicebroker.go:654] ClusterServiceBroker "test-clusterservicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:20.371663201 +0000 UTC m=+7.119387735
I0824 18:07:20.436714       1 controller_clusterservicebroker.go:135] ClusterServiceBroker "test-clusterservicebroker": Error getting broker auth credentials: auth secret didn't contain token
I0824 18:07:20.438912       1 controller_clusterservicebroker.go:654] ClusterServiceBroker "test-clusterservicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:20.437127904 +0000 UTC m=+7.184852438
I0824 18:07:20.440768       1 controller_clusterservicebroker.go:135] ClusterServiceBroker "test-clusterservicebroker": Error getting broker auth credentials: auth secret didn't contain token
I0824 18:07:20.453290       1 controller_clusterservicebroker.go:654] ClusterServiceBroker "test-clusterservicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:20.45317237 +0000 UTC m=+7.200896954
I0824 18:07:20.459313       1 controller_clusterservicebroker.go:135] ClusterServiceBroker "test-clusterservicebroker": Error getting broker auth credentials: auth secret didn't contain token
I0824 18:07:20.459796       1 controller_clusterservicebroker.go:654] ClusterServiceBroker "test-clusterservicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:20.45971501 +0000 UTC m=+7.207439535
I0824 18:07:20.516832       1 controller_clusterservicebroker.go:135] ClusterServiceBroker "test-clusterservicebroker": Error getting broker auth credentials: auth secret didn't contain token
I0824 18:07:20.516892       1 controller_clusterservicebroker.go:135] ClusterServiceBroker "test-clusterservicebroker": Error getting broker auth credentials: auth secret didn't contain token
I0824 18:07:20.520087       1 controller_clusterservicebroker.go:654] ClusterServiceBroker "test-clusterservicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:20.519984691 +0000 UTC m=+7.267709256
I0824 18:07:20.521605       1 controller_clusterservicebroker.go:654] ClusterServiceBroker "test-clusterservicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:20.521519814 +0000 UTC m=+7.269244328
I0824 18:07:20.597342       1 controller_clusterservicebroker.go:749] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServiceClasses
I0824 18:07:20.607788       1 controller_clusterservicebroker.go:766] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServicePlans
E0824 18:07:20.608465       1 controller_clusterservicebroker.go:493] ClusterServiceBroker "test-clusterservicebroker": Error creating ClusterServiceClass (K8S: "cscguid" ExternalName: "test-clusterserviceclass"): error creating serviceclass
W0824 18:07:20.608730       1 controller_clusterservicebroker.go:267] ClusterServiceBroker "test-clusterservicebroker": Error reconciling ClusterServiceClass (K8S: "cscguid" ExternalName: "test-clusterserviceclass") (broker "test-clusterservicebroker"): error creating serviceclass
I0824 18:07:20.609024       1 controller_clusterservicebroker.go:654] ClusterServiceBroker "test-clusterservicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:20.608918827 +0000 UTC m=+7.356643366
I0824 18:07:20.668384       1 controller_clusterservicebroker.go:749] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServiceClasses
I0824 18:07:20.680985       1 controller_clusterservicebroker.go:766] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServicePlans
I0824 18:07:20.681889       1 controller_clusterservicebroker.go:654] ClusterServiceBroker "test-clusterservicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:20.68181293 +0000 UTC m=+7.429537505
W0824 18:07:20.732605       1 controller_clusterservicebroker.go:184] ClusterServiceBroker "test-clusterservicebroker": Error getting broker catalog: ooops
I0824 18:07:20.732950       1 controller_clusterservicebroker.go:654] ClusterServiceBroker "test-clusterservicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:20.732846992 +0000 UTC m=+7.480571527
I0824 18:07:20.737265       1 controller_clusterservicebroker.go:198] ClusterServiceBroker "test-clusterservicebroker": Stopping reconciliation retries because too much time has elapsed
I0824 18:07:20.737462       1 controller_clusterservicebroker.go:654] ClusterServiceBroker "test-clusterservicebroker": Setting lastTransitionTime for condition "Failed" to 2020-08-24 18:07:20.737373813 +0000 UTC m=+7.485098334
I0824 18:07:20.840319       1 controller_clusterservicebroker.go:749] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServiceClasses
I0824 18:07:20.846392       1 controller_clusterservicebroker.go:766] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServicePlans
I0824 18:07:20.852971       1 controller_clusterservicebroker.go:654] ClusterServiceBroker "test-clusterservicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:20.852887505 +0000 UTC m=+7.600612016
E0824 18:07:20.853109       1 controller_clusterservicebroker.go:688] ClusterServiceBroker "test-clusterservicebroker": Error updating ready condition: update error
I0824 18:07:20.932076       1 controller_clusterservicebroker.go:654] ClusterServiceBroker "test-clusterservicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:20.931937874 +0000 UTC m=+7.679662406
I0824 18:07:21.100087       1 controller_clusterservicebroker.go:661] ClusterServiceBroker "test-clusterservicebroker": Found status change for condition "Ready": "False" -> "True"; setting lastTransitionTime to 2020-08-24 18:07:21.099956163 +0000 UTC m=+7.847680724
I0824 18:07:21.196365       1 controller_clusterservicebroker.go:661] ClusterServiceBroker "test-clusterservicebroker": Found status change for condition "Ready": "True" -> "False"; setting lastTransitionTime to 2020-08-24 18:07:21.196222552 +0000 UTC m=+7.943947081
E0824 18:07:21.423825       1 controller_clusterservicebroker.go:616] ClusterServiceBroker "test-clusterservicebroker": Error updating ClusterServicePlan (K8S: "cspguid" ExternalName: "new-value"): oops
I0824 18:07:21.507860       1 controller_clusterservicebroker.go:749] ClusterServiceBroker "test-clusterservicebroker": Found 1 ClusterServiceClasses
I0824 18:07:21.520927       1 controller_clusterservicebroker.go:766] ClusterServiceBroker "test-clusterservicebroker": Found 1 ClusterServicePlans
I0824 18:07:21.522471       1 controller_clusterservicebroker.go:654] ClusterServiceBroker "test-clusterservicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:21.522371196 +0000 UTC m=+8.270095733
I0824 18:07:21.621315       1 controller_clusterservicebroker.go:749] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServiceClasses
I0824 18:07:21.636576       1 controller_clusterservicebroker.go:766] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServicePlans
I0824 18:07:21.637891       1 controller_clusterservicebroker.go:654] ClusterServiceBroker "test-clusterservicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:21.63781038 +0000 UTC m=+8.385534896
... skipping 30 lines ...
I0824 18:07:22.349586       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" v42w74hbv4g: Provision request for ServiceInstance in-flight to Broker
I0824 18:07:22.350927       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" v42w74hbv4g: The instance was provisioned successfully
I0824 18:07:22.408897       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" v6qtqp4bxwc: Provision request for ServiceInstance in-flight to Broker
I0824 18:07:22.410152       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" v6qtqp4bxwc: The instance is being provisioned asynchronously
I0824 18:07:22.490323       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance is being provisioned asynchronously (testdescr)
I0824 18:07:22.536660       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance was provisioned successfully
I0824 18:07:22.588599       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Provision call failed: (no description provided)
I0824 18:07:22.588961       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Provision call failed: (no description provided)
I0824 18:07:22.589596       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Provision call failed: (no description provided)
I0824 18:07:22.589796       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance provision call failed with an ambiguous error; attempting to deprovision the instance in order to mitigate an orphaned resource
I0824 18:07:22.646787       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Deprovision request for ServiceInstance in-flight to Broker
I0824 18:07:22.648726       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance was deprovisioned successfully
I0824 18:07:22.650219       1 controller_instance.go:2656] ServiceInstance "test-ns/test-instance": Cleared finalizer
I0824 18:07:22.697477       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Deprovision request for ServiceInstance in-flight to Broker
I0824 18:07:22.702659       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance is being deprovisioned asynchronously
I0824 18:07:22.777249       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance is being deprovisioned asynchronously (testdescr)
I0824 18:07:22.861999       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance is being deprovisioned asynchronously (testdescr)
I0824 18:07:22.934090       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance was deprovisioned successfully
I0824 18:07:22.934525       1 controller_instance.go:2656] ServiceInstance "test-ns/test-instance": Cleared finalizer
I0824 18:07:22.984474       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Deprovision call failed: (no description provided)
I0824 18:07:23.032443       1 controller_instance.go:1491] ServiceInstance "test-ns/test-instance": Found 1 ServiceClasses
I0824 18:07:23.047031       1 controller_instance.go:1612] ServiceInstance "test-ns/test-instance": Found 1 ServicePlans
I0824 18:07:23.176160       1 controller_instance.go:1417] ServiceInstance "test-instance": Found 0 ClusterServiceClasses
W0824 18:07:23.176579       1 controller_instance.go:1281] ServiceInstance "test-instance": References a non-existent ClusterServiceClass {ClusterServiceClassExternalName:"nothere"} or there is more than one (found: 0)
I0824 18:07:23.177022       1 controller_instance.go:1829] ServiceInstance "test-instance": The instance references a ClusterServiceClass that does not exist. References a non-existent ClusterServiceClass {ClusterServiceClassExternalName:"nothere"} or there is more than one (found: 0)
W0824 18:07:23.240346       1 controller_instance.go:1281] ServiceInstance "test-instance": References a non-existent ClusterServiceClass {ClusterServiceClassName:"nothereclass"}
... skipping 10 lines ...
I0824 18:07:24.106921       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vzdhms5p8pv: Provision request for ServiceInstance in-flight to Broker
I0824 18:07:24.115309       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vzdhms5p8pv: The instance was provisioned successfully
I0824 18:07:24.313216       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vkmdnwmcf8r: Provision request for ServiceInstance in-flight to Broker
I0824 18:07:24.322165       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vkmdnwmcf8r: The instance was provisioned successfully
I0824 18:07:24.460668       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" v6s2lwvfbfr: Provision request for ServiceInstance in-flight to Broker
I0824 18:07:24.471092       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" v6s2lwvfbfr: The instance was provisioned successfully
I0824 18:07:24.535386       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" v6mwkj446qx: failed to prepare parameters &RawExtension{Raw:*[98 97 100],}: error unmarshaling JSON: while decoding JSON: json: cannot unmarshal string into Go value of type map[string]interface {}
I0824 18:07:24.643970       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vtq9krpx8vl: failed to prepare parameters nil: failed to unmarshal parameters as JSON object: unexpected end of JSON input
I0824 18:07:24.747186       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" v46dzd6r5cs: failed to prepare parameters nil: failed to unmarshal parameters as JSON object: unexpected end of JSON input
I0824 18:07:24.834445       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vd5kfchk6qm: failed to prepare parameters nil: failed to unmarshal parameters as JSON object: unexpected end of JSON input
I0824 18:07:24.913371       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vgsk7k4jffn: failed to prepare parameters nil: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:07:24.990400       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vj6bh7qcb7v: Provision request for ServiceInstance in-flight to Broker
I0824 18:07:24.996804       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vj6bh7qcb7v: The instance was provisioned successfully
I0824 18:07:25.112896       1 controller_instance.go:1417] ServiceInstance "test-ns/test-instance": Found 1 ClusterServiceClasses
I0824 18:07:25.149738       1 controller_instance.go:1552] ServiceInstance "test-ns/test-instance": Found 1 ClusterServicePlans
I0824 18:07:25.312666       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vtllp8mjps6: Provision request for ServiceInstance in-flight to Broker
I0824 18:07:25.499208       1 controller_instance.go:1552] ServiceInstance "test-ns/test-instance": Found 1 ClusterServicePlans
I0824 18:07:25.592169       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vcmkh72mxxr: Provision request for ServiceInstance in-flight to Broker
I0824 18:07:25.594889       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vcmkh72mxxr: The provision call failed and will be retried: Error communicating with broker for provisioning: fake creation failure
I0824 18:07:25.699344       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" v9nxhxbv5zp: Provision request for ServiceInstance in-flight to Broker
I0824 18:07:25.707569       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" v9nxhxbv5zp: Error provisioning ServiceInstance of ClusterServiceClass (K8S: "cscguid" ExternalName: "test-clusterserviceclass") at ClusterServiceBroker "test-clusterservicebroker": Status: 500; ErrorMessage: InternalServerError; Description: Something went wrong!; ResponseError: <nil>
I0824 18:07:25.707784       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" v9nxhxbv5zp: Error provisioning ServiceInstance of ClusterServiceClass (K8S: "cscguid" ExternalName: "test-clusterserviceclass") at ClusterServiceBroker "test-clusterservicebroker": Status: 500; ErrorMessage: InternalServerError; Description: Something went wrong!; ResponseError: <nil>
I0824 18:07:25.708054       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" v9nxhxbv5zp: The instance provision call failed with an ambiguous error; attempting to deprovision the instance in order to mitigate an orphaned resource
I0824 18:07:25.779564       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vmdz9blv2pf: Provision request for ServiceInstance in-flight to Broker
I0824 18:07:25.780770       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vmdz9blv2pf: Error provisioning ServiceInstance of ClusterServiceClass (K8S: "cscguid" ExternalName: "test-clusterserviceclass") at ClusterServiceBroker "test-clusterservicebroker": Status: 400; ErrorMessage: BadRequest; Description: Your parameters are incorrect!; ResponseError: <nil>
I0824 18:07:25.780902       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vmdz9blv2pf: Error provisioning ServiceInstance of ClusterServiceClass (K8S: "cscguid" ExternalName: "test-clusterserviceclass") at ClusterServiceBroker "test-clusterservicebroker": Status: 400; ErrorMessage: BadRequest; Description: Your parameters are incorrect!; ResponseError: <nil>
I0824 18:07:25.876832       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" v2xzmcp4gck: Provision request for ServiceInstance in-flight to Broker
I0824 18:07:25.877999       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" v2xzmcp4gck: The instance was provisioned successfully
I0824 18:07:25.982363       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vcvq4crj6s2: ClusterServicePlan (K8S: "cspguid" ExternalName: "test-clusterserviceplan") has been deleted; cannot provision.
I0824 18:07:26.105584       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" v8tllhmv96g: ClusterServiceClass (K8S: "cscguid" ExternalName: "test-clusterserviceclass") has been deleted; cannot provision.
I0824 18:07:26.284483       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vnknr2hd8wz: Provision request for ServiceInstance in-flight to Broker
I0824 18:07:26.291772       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vnknr2hd8wz: The instance was provisioned successfully
I0824 18:07:26.368885       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vk9ngs7zt6b: Provision request for ServiceInstance in-flight to Broker
I0824 18:07:26.374912       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vk9ngs7zt6b: The instance is being provisioned asynchronously
I0824 18:07:26.488401       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vhmjwd7zgkj: Provision request for ServiceInstance in-flight to Broker
I0824 18:07:26.495280       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vhmjwd7zgkj: The instance is being provisioned asynchronously
I0824 18:07:26.605069       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" v2xmzggsxzc: Failed to get namespace "test-ns": No namespace
I0824 18:07:26.636801       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Deprovision request for ServiceInstance in-flight to Broker
I0824 18:07:26.644271       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance was deprovisioned successfully
I0824 18:07:26.644619       1 controller_instance.go:2656] ServiceInstance "test-ns/test-instance": Cleared finalizer
I0824 18:07:26.686423       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": All associated ServiceBindings must be removed before this ServiceInstance can be deleted
I0824 18:07:26.687318       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Deprovision request for ServiceInstance in-flight to Broker
I0824 18:07:26.688117       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance was deprovisioned successfully
... skipping 16 lines ...
I0824 18:07:27.886336       1 controller_instance.go:2656] ServiceInstance "test-ns/test-instance": Cleared finalizer
I0824 18:07:28.076758       1 controller_instance.go:2656] ServiceInstance "test-ns/test-instance" v1: Cleared finalizer
I0824 18:07:28.160987       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vd4qwczxncm: Provision request for ServiceInstance in-flight to Broker
I0824 18:07:28.169695       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vd4qwczxncm: The instance was provisioned successfully
I0824 18:07:28.278615       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance is being provisioned asynchronously (testdescr)
I0824 18:07:28.355180       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance was provisioned successfully
I0824 18:07:28.488221       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Provision call failed: (no description provided)
I0824 18:07:28.489193       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Provision call failed: (no description provided)
I0824 18:07:28.515489       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Provision call failed: (no description provided)
I0824 18:07:28.515809       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance provision call failed with an ambiguous error; attempting to deprovision the instance in order to mitigate an orphaned resource
I0824 18:07:28.584225       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance is being deprovisioned asynchronously (testdescr)
I0824 18:07:28.675912       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance is being deprovisioned asynchronously (testdescr)
I0824 18:07:28.762325       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance was deprovisioned successfully
I0824 18:07:28.762971       1 controller_instance.go:2656] ServiceInstance "test-ns/test-instance": Cleared finalizer
I0824 18:07:28.873203       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Deprovision call failed: (no description provided)
I0824 18:07:28.921508       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Deprovision call failed: (no description provided)
I0824 18:07:28.921984       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Stopping reconciliation retries because too much time has elapsed
I0824 18:07:28.981799       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance was deprovisioned successfully
I0824 18:07:28.982538       1 controller_instance.go:2656] ServiceInstance "test-ns/test-instance": Cleared finalizer
I0824 18:07:29.105373       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Error polling last operation: Status: 403; ErrorMessage: <nil>; Description: <nil>; ResponseError: <nil>
I0824 18:07:29.204897       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Error polling last operation: Status: 400; ErrorMessage: <nil>; Description: <nil>; ResponseError: <nil>
I0824 18:07:29.205515       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Error polling last operation: Status: 400; ErrorMessage: <nil>; Description: <nil>; ResponseError: <nil>
I0824 18:07:29.333144       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance was deprovisioned successfully
I0824 18:07:29.334043       1 controller_instance.go:2656] ServiceInstance "test-ns/test-instance": Cleared finalizer
I0824 18:07:29.476993       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vg9k84qgxx5: The instance was provisioned successfully
I0824 18:07:29.614678       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vfsfmf7g9j4: Provision request for ServiceInstance in-flight to Broker
I0824 18:07:29.725765       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vqkvbc2v6ml: The provision call failed and will be retried: Error communicating with broker for provisioning: fake creation failure
I0824 18:07:29.726324       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vqkvbc2v6ml: Stopping reconciliation retries because too much time has elapsed
I0824 18:07:29.858047       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance was provisioned successfully
I0824 18:07:29.920422       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance is being provisioned asynchronously (testdescr)
I0824 18:07:29.920932       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Stopping reconciliation retries because too much time has elapsed
I0824 18:07:29.928461       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance is being provisioned asynchronously (testdescr)
I0824 18:07:29.928728       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance provision call failed with an ambiguous error; attempting to deprovision the instance in order to mitigate an orphaned resource
I0824 18:07:30.004979       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Provision request for ServiceInstance in-flight to Broker
E0824 18:07:30.005792       1 controller_instance.go:1985] ServiceInstance "test-ns/test-instance": Failed to update status: update error
I0824 18:07:30.013347       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Message
I0824 18:07:30.013929       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Message
I0824 18:07:30.015106       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": DifferentMessage
I0824 18:07:30.015354       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Message
I0824 18:07:30.015678       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Message
I0824 18:07:30.016316       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Message
... skipping 33 lines ...
W0824 18:07:31.605534       1 feature_gate.go:235] Setting GA feature gate OriginatingIdentity=true. It will be removed in a future release.
I0824 18:07:31.701211       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance is being provisioned asynchronously (testdescr)
W0824 18:07:31.704356       1 feature_gate.go:235] Setting GA feature gate OriginatingIdentity=true. It will be removed in a future release.
I0824 18:07:31.837111       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance is being provisioned asynchronously (testdescr)
W0824 18:07:31.839121       1 feature_gate.go:235] Setting GA feature gate OriginatingIdentity=true. It will be removed in a future release.
I0824 18:07:31.991900       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vkkwtshvkhm: Provision request for ServiceInstance in-flight to Broker
I0824 18:07:32.002592       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vkkwtshvkhm: Error provisioning ServiceInstance of ClusterServiceClass (K8S: "cscguid" ExternalName: "test-clusterserviceclass") at ClusterServiceBroker "test-clusterservicebroker": Status: 200; ErrorMessage: <nil>; Description: <nil>; ResponseError: <nil>
I0824 18:07:32.108375       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vf6kqssqrcn: Provision request for ServiceInstance in-flight to Broker
I0824 18:07:32.110091       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vf6kqssqrcn: Error provisioning ServiceInstance of ClusterServiceClass (K8S: "cscguid" ExternalName: "test-clusterserviceclass") at ClusterServiceBroker "test-clusterservicebroker": Status: 201; ErrorMessage: <nil>; Description: <nil>; ResponseError: <nil>
I0824 18:07:32.111150       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vf6kqssqrcn: Error provisioning ServiceInstance of ClusterServiceClass (K8S: "cscguid" ExternalName: "test-clusterserviceclass") at ClusterServiceBroker "test-clusterservicebroker": Status: 201; ErrorMessage: <nil>; Description: <nil>; ResponseError: <nil>
I0824 18:07:32.111438       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vf6kqssqrcn: The instance provision call failed with an ambiguous error; attempting to deprovision the instance in order to mitigate an orphaned resource
I0824 18:07:32.213588       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" v4pgc8qtj9r: Provision request for ServiceInstance in-flight to Broker
I0824 18:07:32.231594       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" v4pgc8qtj9r: Error provisioning ServiceInstance of ClusterServiceClass (K8S: "cscguid" ExternalName: "test-clusterserviceclass") at ClusterServiceBroker "test-clusterservicebroker": Status: 300; ErrorMessage: <nil>; Description: <nil>; ResponseError: <nil>
I0824 18:07:32.323306       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" v94bw487msf: Provision request for ServiceInstance in-flight to Broker
I0824 18:07:32.335070       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" v94bw487msf: Error provisioning ServiceInstance of ClusterServiceClass (K8S: "cscguid" ExternalName: "test-clusterserviceclass") at ClusterServiceBroker "test-clusterservicebroker": Status: 400; ErrorMessage: <nil>; Description: <nil>; ResponseError: <nil>
I0824 18:07:32.335227       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" v94bw487msf: Error provisioning ServiceInstance of ClusterServiceClass (K8S: "cscguid" ExternalName: "test-clusterserviceclass") at ClusterServiceBroker "test-clusterservicebroker": Status: 400; ErrorMessage: <nil>; Description: <nil>; ResponseError: <nil>
I0824 18:07:32.459164       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vmnjpz6tgn9: Provision request for ServiceInstance in-flight to Broker
I0824 18:07:32.461104       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vmnjpz6tgn9: Error provisioning ServiceInstance of ClusterServiceClass (K8S: "cscguid" ExternalName: "test-clusterserviceclass") at ClusterServiceBroker "test-clusterservicebroker": Status: 408; ErrorMessage: <nil>; Description: <nil>; ResponseError: <nil>
I0824 18:07:32.574411       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vxzzm9zl7bj: Provision request for ServiceInstance in-flight to Broker
I0824 18:07:32.591916       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vxzzm9zl7bj: Error provisioning ServiceInstance of ClusterServiceClass (K8S: "cscguid" ExternalName: "test-clusterserviceclass") at ClusterServiceBroker "test-clusterservicebroker": Status: 400; ErrorMessage: <nil>; Description: <nil>; ResponseError: <nil>
I0824 18:07:32.592269       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vxzzm9zl7bj: Error provisioning ServiceInstance of ClusterServiceClass (K8S: "cscguid" ExternalName: "test-clusterserviceclass") at ClusterServiceBroker "test-clusterservicebroker": Status: 400; ErrorMessage: <nil>; Description: <nil>; ResponseError: <nil>
I0824 18:07:32.723882       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vt5hqsjwqq2: Provision request for ServiceInstance in-flight to Broker
I0824 18:07:32.732915       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vt5hqsjwqq2: Error provisioning ServiceInstance of ClusterServiceClass (K8S: "cscguid" ExternalName: "test-clusterserviceclass") at ClusterServiceBroker "test-clusterservicebroker": Status: 500; ErrorMessage: <nil>; Description: <nil>; ResponseError: <nil>
I0824 18:07:32.743918       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vt5hqsjwqq2: Error provisioning ServiceInstance of ClusterServiceClass (K8S: "cscguid" ExternalName: "test-clusterserviceclass") at ClusterServiceBroker "test-clusterservicebroker": Status: 500; ErrorMessage: <nil>; Description: <nil>; ResponseError: <nil>
I0824 18:07:32.744474       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vt5hqsjwqq2: The instance provision call failed with an ambiguous error; attempting to deprovision the instance in order to mitigate an orphaned resource
I0824 18:07:32.911582       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" v4fwkq2c6fd: Provision request for ServiceInstance in-flight to Broker
I0824 18:07:32.914183       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" v4fwkq2c6fd: Communication with the ClusterServiceBroker timed out; operation will be retried:  : timed out
I0824 18:07:32.915027       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" v4fwkq2c6fd: Communication with the ClusterServiceBroker timed out; operation will be retried:  : timed out
I0824 18:07:32.916097       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" v4fwkq2c6fd: The instance provision call failed with an ambiguous error; attempting to deprovision the instance in order to mitigate an orphaned resource
I0824 18:07:33.067286       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance provision call failed with an ambiguous error; attempting to deprovision the instance in order to mitigate an orphaned resource
I0824 18:07:33.068690       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Orphan mitigation was completed successfully
I0824 18:07:33.210499       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance provision call failed with an ambiguous error; attempting to deprovision the instance in order to mitigate an orphaned resource
I0824 18:07:33.213704       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance is being deprovisioned asynchronously
I0824 18:07:33.310318       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance provision call failed with an ambiguous error; attempting to deprovision the instance in order to mitigate an orphaned resource
I0824 18:07:33.319271       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Deprovision call failed; received error response from broker: Status: 422; ErrorMessage: AsyncRequired; Description: This service plan requires client support for asynchronous service operations.; ResponseError: <nil>
I0824 18:07:33.416950       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance provision call failed with an ambiguous error; attempting to deprovision the instance in order to mitigate an orphaned resource
I0824 18:07:33.419591       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Orphan mitigation failed: Stopping reconciliation retries because too much time has elapsed
I0824 18:07:33.526048       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance provision call failed with an ambiguous error; attempting to deprovision the instance in order to mitigate an orphaned resource
I0824 18:07:33.528087       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Error deprovisioning, ClusterServiceClass (K8S: "cscguid" ExternalName: "test-clusterserviceclass") at ClusterServiceBroker "test-clusterservicebroker": other error
I0824 18:07:33.678727       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance provision call failed with an ambiguous error; attempting to deprovision the instance in order to mitigate an orphaned resource
I0824 18:07:33.679844       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Orphan mitigation failed: Stopping reconciliation retries because too much time has elapsed
I0824 18:07:33.832413       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance provision call failed with an ambiguous error; attempting to deprovision the instance in order to mitigate an orphaned resource
I0824 18:07:33.834722       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Orphan mitigation was completed successfully
I0824 18:07:33.968033       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance provision call failed with an ambiguous error; attempting to deprovision the instance in order to mitigate an orphaned resource
I0824 18:07:33.969098       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Orphan mitigation was completed successfully
I0824 18:07:34.132919       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance provision call failed with an ambiguous error; attempting to deprovision the instance in order to mitigate an orphaned resource
I0824 18:07:34.141850       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance is being deprovisioned asynchronously (description)
I0824 18:07:34.335322       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance provision call failed with an ambiguous error; attempting to deprovision the instance in order to mitigate an orphaned resource
I0824 18:07:34.338581       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Orphan mitigation failed: Stopping reconciliation retries because too much time has elapsed
I0824 18:07:34.488474       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance provision call failed with an ambiguous error; attempting to deprovision the instance in order to mitigate an orphaned resource
I0824 18:07:34.505829       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Orphan mitigation failed: Stopping reconciliation retries because too much time has elapsed
I0824 18:07:34.661792       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance provision call failed with an ambiguous error; attempting to deprovision the instance in order to mitigate an orphaned resource
I0824 18:07:34.679268       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Orphan mitigation failed: Stopping reconciliation retries because too much time has elapsed
I0824 18:07:34.761972       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance provision call failed with an ambiguous error; attempting to deprovision the instance in order to mitigate an orphaned resource
I0824 18:07:34.767003       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Orphan mitigation failed: Stopping reconciliation retries because too much time has elapsed
I0824 18:07:34.874795       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance provision call failed with an ambiguous error; attempting to deprovision the instance in order to mitigate an orphaned resource
W0824 18:07:34.876431       1 controller_instance.go:1173] ServiceInstance "test-ns/test-instance": Got invalid state in LastOperationResponse: "invalid state"
I0824 18:07:34.877318       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Orphan mitigation failed: Stopping reconciliation retries because too much time has elapsed
I0824 18:07:35.005482       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vf6m5rjsg6z: Provision request for ServiceInstance in-flight to Broker
I0824 18:07:35.031328       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance" vf6m5rjsg6z: The instance was provisioned successfully
I0824 18:07:35.316436       1 controller_instance.go:1417] ServiceInstance "test-ns/test-instance": Found 0 ClusterServiceClasses
W0824 18:07:35.324788       1 controller_instance.go:1281] ServiceInstance "test-ns/test-instance": References a non-existent ClusterServiceClass {ClusterServiceClassExternalName:"test-clusterserviceclass"} or there is more than one (found: 0)
I0824 18:07:35.325018       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance references a ClusterServiceClass that does not exist. References a non-existent ClusterServiceClass {ClusterServiceClassExternalName:"test-clusterserviceclass"} or there is more than one (found: 0)
I0824 18:07:35.478678       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Update request for ServiceInstance in-flight to Broker
... skipping 10 lines ...
I0824 18:07:36.004261       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance was updated successfully
I0824 18:07:36.109571       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Update request for ServiceInstance in-flight to Broker
I0824 18:07:36.112998       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance was updated successfully
I0824 18:07:36.278913       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Update request for ServiceInstance in-flight to Broker
I0824 18:07:36.288805       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance was updated successfully
I0824 18:07:36.404171       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Update request for ServiceInstance in-flight to Broker
I0824 18:07:36.406285       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The update call failed and will be retried: Error communicating with broker for updating: fake update failure
I0824 18:07:36.450130       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Update request for ServiceInstance in-flight to Broker
I0824 18:07:36.457408       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": ServiceBroker returned a failure for update call; update will be retried: Status: 409; ErrorMessage: OutOfQuota; Description: You're out of quota!; ResponseError: <nil>
I0824 18:07:36.486508       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Update request for ServiceInstance in-flight to Broker
I0824 18:07:36.488179       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": ServiceBroker returned a failure for update call; update will not be retried: Status: 400; ErrorMessage: BadRequest; Description: Something's wrong with the request; ResponseError: <nil>
I0824 18:07:36.495285       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": ServiceBroker returned a failure for update call; update will not be retried: Status: 400; ErrorMessage: BadRequest; Description: Something's wrong with the request; ResponseError: <nil>
I0824 18:07:36.611183       1 controller_instance.go:1417] ServiceInstance "test-ns/test-instance": Found 1 ClusterServiceClasses
I0824 18:07:36.621453       1 controller_instance.go:1552] ServiceInstance "test-ns/test-instance": Found 1 ClusterServicePlans
I0824 18:07:36.727641       1 controller_instance.go:1552] ServiceInstance "test-ns/test-instance": Found 1 ClusterServicePlans
I0824 18:07:36.939198       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Update request for ServiceInstance in-flight to Broker
I0824 18:07:36.940616       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance is being updated asynchronously
I0824 18:07:37.077201       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance is being updated asynchronously (testdescr)
I0824 18:07:37.156131       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance was updated successfully
I0824 18:07:37.343979       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Update call failed: (no description provided)
I0824 18:07:37.344591       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Update call failed: (no description provided)
I0824 18:07:38.221392       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Deprovision request for ServiceInstance in-flight to Broker
I0824 18:07:38.223609       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance was deprovisioned successfully
I0824 18:07:38.223989       1 controller_instance.go:2656] ServiceInstance "test-ns/test-instance": Cleared finalizer
I0824 18:07:38.419647       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance provision call failed with an ambiguous error; attempting to deprovision the instance in order to mitigate an orphaned resource
I0824 18:07:38.426389       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Deprovision request for ServiceInstance in-flight to Broker
I0824 18:07:38.427821       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance was deprovisioned successfully
I0824 18:07:38.428290       1 controller_instance.go:2656] ServiceInstance "test-ns/test-instance": Cleared finalizer
I0824 18:07:38.541334       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": Deprovision request for ServiceInstance in-flight to Broker
I0824 18:07:38.554550       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance was deprovisioned successfully
I0824 18:07:38.555819       1 controller_instance.go:2656] ServiceInstance "test-ns/test-instance": Cleared finalizer
I0824 18:07:38.813967       1 controller_instance.go:1829] ServiceInstance "test-ns/test-instance": The instance provision call failed with an ambiguous error; attempting to deprovision the instance in order to mitigate an orphaned resource
W0824 18:07:38.956372       1 controller_servicebroker.go:175] ServiceBroker "test-ns/test-servicebrokernot-predefined": Error getting broker catalog: Unexpected action
I0824 18:07:38.956939       1 controller_servicebroker.go:626] ServiceBroker "test-ns/test-servicebrokernot-predefined": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:38.956796317 +0000 UTC m=+25.704521039
I0824 18:07:39.108335       1 controller_servicebroker.go:728] ServiceBroker "test-ns/test-servicebroker": Found 1 ServiceClasses
I0824 18:07:39.116557       1 controller_servicebroker.go:745] ServiceBroker "test-ns/test-servicebroker": Found 1 ServicePlans
I0824 18:07:39.117132       1 controller_servicebroker.go:626] ServiceBroker "test-ns/test-servicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:39.117074303 +0000 UTC m=+25.864798834
I0824 18:07:39.260092       1 controller_servicebroker.go:728] ServiceBroker "test-ns/test-servicebroker": Found 1 ServiceClasses
I0824 18:07:39.269393       1 controller_servicebroker.go:745] ServiceBroker "test-ns/test-servicebroker": Found 1 ServicePlans
I0824 18:07:39.269770       1 controller_servicebroker.go:626] ServiceBroker "test-ns/test-servicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:39.269695885 +0000 UTC m=+26.017420418
I0824 18:07:39.412254       1 controller_servicebroker.go:728] ServiceBroker "test-ns/test-servicebroker": Found 1 ServiceClasses
I0824 18:07:39.413499       1 controller_servicebroker.go:745] ServiceBroker "test-ns/test-servicebroker": Found 1 ServicePlans
I0824 18:07:39.414169       1 controller_servicebroker.go:626] ServiceBroker "test-ns/test-servicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:39.41398614 +0000 UTC m=+26.161710678
E0824 18:07:40.380866       1 controller_servicebroker.go:590] ServiceBroker "test-ns/test-servicebroker": Error updating ServicePlan (K8S: "test-ns/spguid" ExternalName: "new-value"): oops
I0824 18:07:40.583631       1 controller_servicebroker.go:728] ServiceBroker "test-ns/test-servicebroker": Found 1 ServiceClasses
I0824 18:07:40.589961       1 controller_servicebroker.go:745] ServiceBroker "test-ns/test-servicebroker": Found 0 ServicePlans
I0824 18:07:40.595013       1 controller_servicebroker.go:626] ServiceBroker "test-ns/test-servicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:40.59493577 +0000 UTC m=+27.342660320
I0824 18:07:40.758315       1 controller_serviceclass.go:80] ServiceClass "test-ns/scguid": Processing
I0824 18:07:40.892801       1 controller_serviceclass.go:80] ServiceClass "test-ns/scguid": Processing
I0824 18:07:40.893551       1 controller_serviceclass.go:86] ServiceClass "test-ns/scguid": Removed from broker catalog; determining whether there are instances remaining
... skipping 115 lines ...
I0824 18:07:47.400948       1 controller_clusterserviceplan.go:76] ClusterServicePlan "76543" (ExternalName: "test-otherclusterserviceplan"): processing
I0824 18:07:47.495283       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": Provision request for ServiceInstance in-flight to Broker
I0824 18:07:47.501694       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The instance was provisioned successfully
I0824 18:07:47.596776       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Binding request for ServiceBinding in-flight to Broker
I0824 18:07:47.597436       1 controller_binding.go:712] ServiceBinding "test-ns/test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:47.596727364 +0000 UTC m=+34.344451883
I0824 18:07:47.609051       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": The binding is being created asynchronously
I0824 18:07:48.630061       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Bind call failed: (no description provided)
I0824 18:07:48.631551       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Bind call failed: (no description provided)
I0824 18:07:48.635718       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Unbind request for ServiceBinding in-flight to Broker
I0824 18:07:48.639776       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": The binding was deleted successfully
I0824 18:07:48.648986       1 controller_binding.go:1534] ServiceBinding "test-ns/test-binding": Status updated
I0824 18:07:48.660011       1 controller_binding.go:1545] ServiceBinding "test-ns/test-binding": Cleared finalizer
I0824 18:07:48.662618       1 controller_binding.go:1534] ServiceBinding "test-ns/test-binding": Status updated
I0824 18:07:48.663575       1 controller_binding.go:1545] ServiceBinding "test-ns/test-binding": Cleared finalizer
... skipping 10 lines ...
I0824 18:07:49.108627       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": Provision request for ServiceInstance in-flight to Broker
I0824 18:07:49.114783       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The instance was provisioned successfully
I0824 18:07:49.191861       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Binding request for ServiceBinding in-flight to Broker
I0824 18:07:49.193314       1 controller_binding.go:712] ServiceBinding "test-ns/test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:49.191836824 +0000 UTC m=+35.939561336
I0824 18:07:49.227830       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Injected bind result
I0824 18:07:49.258007       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Unbind request for ServiceBinding in-flight to Broker
I0824 18:07:49.267480       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Error unbinding from ServiceInstance "test-ns/service-instance" of ClusterServiceClass (K8S: "clusterserviceclass-12345" ExternalName: "test-clusterserviceclass") at ClusterServiceBroker "test-clusterservicebroker": Status: 500; ErrorMessage: <nil>; Description: <nil>; ResponseError: <nil>
I0824 18:07:49.281784       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": The binding was deleted successfully
I0824 18:07:49.283561       1 controller_binding.go:1534] ServiceBinding "test-ns/test-binding": Status updated
I0824 18:07:49.284628       1 controller_binding.go:1545] ServiceBinding "test-ns/test-binding": Cleared finalizer
I0824 18:07:49.351790       1 controller.go:279] Shutting down service-catalog controller
I0824 18:07:49.428123       1 controller.go:296] Shutdown service-catalog controller
I0824 18:07:49.647117       1 controller.go:245] Starting service-catalog controller
... skipping 9 lines ...
I0824 18:07:49.873860       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Binding request for ServiceBinding in-flight to Broker
I0824 18:07:49.875384       1 controller_binding.go:712] ServiceBinding "test-ns/test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:49.873815311 +0000 UTC m=+36.621539809
I0824 18:07:49.881467       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": The binding is being created asynchronously
I0824 18:07:50.889357       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Injected bind result
I0824 18:07:50.919423       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Unbind request for ServiceBinding in-flight to Broker
I0824 18:07:50.937414       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": The binding is being deleted asynchronously
I0824 18:07:51.945478       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Unbind call failed: (no description provided)
I0824 18:07:51.972677       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": The binding is being deleted asynchronously
I0824 18:07:51.983966       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": The binding was deleted successfully
I0824 18:07:51.985120       1 controller_binding.go:1534] ServiceBinding "test-ns/test-binding": Status updated
I0824 18:07:51.985830       1 controller_binding.go:1545] ServiceBinding "test-ns/test-binding": Cleared finalizer
I0824 18:07:52.009753       1 controller.go:279] Shutting down service-catalog controller
I0824 18:07:52.064550       1 controller.go:296] Shutdown service-catalog controller
... skipping 6 lines ...
I0824 18:07:52.366411       1 controller_clusterserviceplan.go:76] ClusterServicePlan "76543" (ExternalName: "test-otherclusterserviceplan"): processing
I0824 18:07:52.367606       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Binding cannot begin because referenced ServiceInstance "test-ns/service-instance" is not ready
I0824 18:07:52.368683       1 controller_binding.go:712] ServiceBinding "test-ns/test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:52.367515572 +0000 UTC m=+39.115240098
I0824 18:07:52.367121       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": Provision request for ServiceInstance in-flight to Broker
I0824 18:07:52.388438       1 controller_clusterserviceclass.go:75] ClusterServiceClass "clusterserviceclass-12345" (ExternalName: "test-clusterserviceclass"): processing
I0824 18:07:52.389000       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Binding cannot begin because referenced ServiceInstance "test-ns/service-instance" is not ready
I0824 18:07:52.389712       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": Error provisioning ServiceInstance of ClusterServiceClass (K8S: "clusterserviceclass-12345" ExternalName: "test-clusterserviceclass") at ClusterServiceBroker "test-clusterservicebroker": Status: 502; ErrorMessage: <nil>; Description: <nil>; ResponseError: <nil>
I0824 18:07:52.396328       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": Error provisioning ServiceInstance of ClusterServiceClass (K8S: "clusterserviceclass-12345" ExternalName: "test-clusterserviceclass") at ClusterServiceBroker "test-clusterservicebroker": Status: 502; ErrorMessage: <nil>; Description: <nil>; ResponseError: <nil>
I0824 18:07:52.397009       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The instance provision call failed with an ambiguous error; attempting to deprovision the instance in order to mitigate an orphaned resource
I0824 18:07:52.402534       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Binding cannot begin because referenced ServiceInstance "test-ns/service-instance" is not ready
I0824 18:07:52.405437       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Binding cannot begin because referenced ServiceInstance "test-ns/service-instance" is not ready
I0824 18:07:52.413695       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": All associated ServiceBindings must be removed before this ServiceInstance can be deleted
I0824 18:07:52.417291       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Binding cannot begin because referenced ServiceInstance "test-ns/service-instance" is not ready
I0824 18:07:52.431062       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": All associated ServiceBindings must be removed before this ServiceInstance can be deleted
I0824 18:07:52.434464       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": All associated ServiceBindings must be removed before this ServiceInstance can be deleted
... skipping 9 lines ...
I0824 18:07:52.803553       1 controller_clusterserviceplan.go:76] ClusterServicePlan "34567" (ExternalName: "test-clusterserviceplan"): processing
I0824 18:07:52.806189       1 controller_clusterserviceplan.go:76] ClusterServicePlan "nb34567" (ExternalName: "test-nonbindable-plan"): processing
I0824 18:07:52.806671       1 controller_clusterserviceplan.go:76] ClusterServicePlan "76543" (ExternalName: "test-otherclusterserviceplan"): processing
I0824 18:07:52.838719       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": Provision request for ServiceInstance in-flight to Broker
I0824 18:07:52.851257       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Binding cannot begin because referenced ServiceInstance "test-ns/service-instance" is not ready
I0824 18:07:52.852781       1 controller_binding.go:712] ServiceBinding "test-ns/test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:52.85116704 +0000 UTC m=+39.598891593
I0824 18:07:52.859943       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": Error provisioning ServiceInstance of ClusterServiceClass (K8S: "clusterserviceclass-12345" ExternalName: "test-clusterserviceclass") at ClusterServiceBroker "test-clusterservicebroker": Status: 502; ErrorMessage: <nil>; Description: <nil>; ResponseError: <nil>
I0824 18:07:52.861120       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": Error provisioning ServiceInstance of ClusterServiceClass (K8S: "clusterserviceclass-12345" ExternalName: "test-clusterserviceclass") at ClusterServiceBroker "test-clusterservicebroker": Status: 502; ErrorMessage: <nil>; Description: <nil>; ResponseError: <nil>
I0824 18:07:52.861590       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The instance provision call failed with an ambiguous error; attempting to deprovision the instance in order to mitigate an orphaned resource
I0824 18:07:52.865796       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Binding cannot begin because referenced ServiceInstance "test-ns/service-instance" is not ready
I0824 18:07:52.877172       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": All associated ServiceBindings must be removed before this ServiceInstance can be deleted
I0824 18:07:52.880910       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": Binding cannot begin because referenced ServiceInstance "test-ns/service-instance" is not ready
I0824 18:07:52.895123       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": All associated ServiceBindings must be removed before this ServiceInstance can be deleted
I0824 18:07:52.920305       1 controller.go:279] Shutting down service-catalog controller
I0824 18:07:52.923665       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": All associated ServiceBindings must be removed before this ServiceInstance can be deleted
... skipping 84 lines ...
I0824 18:07:56.426821       1 controller_clusterserviceplan.go:76] ClusterServicePlan "34567" (ExternalName: "test-clusterserviceplan"): processing
I0824 18:07:56.438449       1 controller_clusterservicebroker.go:654] ClusterServiceBroker "test-clusterservicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:56.438279823 +0000 UTC m=+43.186004360
I0824 18:07:56.459624       1 controller_clusterserviceplan.go:76] ClusterServicePlan "nb34567" (ExternalName: "test-nonbindable-plan"): processing
I0824 18:07:56.461179       1 controller_clusterserviceplan.go:76] ClusterServicePlan "76543" (ExternalName: "test-otherclusterserviceplan"): processing
I0824 18:07:56.502700       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": Provision request for ServiceInstance in-flight to Broker
I0824 18:07:56.505576       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The instance was provisioned successfully
I0824 18:07:56.568367       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": failed to prepare parameters nil: secrets "secret-name" not found
I0824 18:07:56.569399       1 controller_binding.go:712] ServiceBinding "test-ns/test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:56.568230484 +0000 UTC m=+43.315955012
I0824 18:07:56.588649       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": failed to prepare parameters nil: secrets "secret-name" not found
I0824 18:07:56.598622       1 controller_binding.go:712] ServiceBinding "test-ns/test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:56.588514298 +0000 UTC m=+43.336238833
I0824 18:07:56.612548       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": failed to prepare parameters nil: secrets "secret-name" not found
I0824 18:07:56.618010       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": failed to prepare parameters nil: secrets "secret-name" not found
I0824 18:07:56.618999       1 controller.go:279] Shutting down service-catalog controller
I0824 18:07:56.694810       1 controller.go:296] Shutdown service-catalog controller
I0824 18:07:56.923947       1 controller.go:245] Starting service-catalog controller
I0824 18:07:57.012624       1 controller_clusterservicebroker.go:749] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServiceClasses
I0824 18:07:57.035351       1 controller_clusterservicebroker.go:766] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServicePlans
I0824 18:07:57.058782       1 controller_clusterservicebroker.go:654] ClusterServiceBroker "test-clusterservicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:57.058637382 +0000 UTC m=+43.806361921
I0824 18:07:57.061990       1 controller_clusterserviceplan.go:76] ClusterServicePlan "34567" (ExternalName: "test-clusterserviceplan"): processing
I0824 18:07:57.088369       1 controller_clusterserviceclass.go:75] ClusterServiceClass "clusterserviceclass-12345" (ExternalName: "test-clusterserviceclass"): processing
I0824 18:07:57.088438       1 controller_clusterserviceplan.go:76] ClusterServicePlan "nb34567" (ExternalName: "test-nonbindable-plan"): processing
I0824 18:07:57.100404       1 controller_clusterserviceplan.go:76] ClusterServicePlan "76543" (ExternalName: "test-otherclusterserviceplan"): processing
I0824 18:07:57.103185       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": Provision request for ServiceInstance in-flight to Broker
I0824 18:07:57.123264       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The instance was provisioned successfully
I0824 18:07:57.127384       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The instance was provisioned successfully
I0824 18:07:57.197537       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": failed to prepare parameters nil: failed to unmarshal parameters as JSON object: unexpected end of JSON input
I0824 18:07:57.198188       1 controller_binding.go:712] ServiceBinding "test-ns/test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:57.197442221 +0000 UTC m=+43.945166759
I0824 18:07:57.206081       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": failed to prepare parameters nil: failed to unmarshal parameters as JSON object: unexpected end of JSON input
I0824 18:07:57.212071       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": failed to prepare parameters nil: failed to unmarshal parameters as JSON object: unexpected end of JSON input
I0824 18:07:57.244957       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": failed to prepare parameters nil: failed to unmarshal parameters as JSON object: unexpected end of JSON input
I0824 18:07:57.254419       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": failed to prepare parameters nil: failed to unmarshal parameters as JSON object: unexpected end of JSON input
I0824 18:07:57.266059       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": failed to prepare parameters nil: failed to unmarshal parameters as JSON object: unexpected end of JSON input
I0824 18:07:57.276277       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": failed to prepare parameters nil: failed to unmarshal parameters as JSON object: unexpected end of JSON input
I0824 18:07:57.299487       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": failed to prepare parameters nil: failed to unmarshal parameters as JSON object: unexpected end of JSON input
I0824 18:07:57.311557       1 controller.go:279] Shutting down service-catalog controller
I0824 18:07:57.380206       1 controller.go:296] Shutdown service-catalog controller
I0824 18:07:57.582496       1 controller.go:245] Starting service-catalog controller
I0824 18:07:57.638210       1 controller_clusterservicebroker.go:749] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServiceClasses
I0824 18:07:57.689967       1 controller_clusterservicebroker.go:766] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServicePlans
I0824 18:07:57.719975       1 controller_clusterserviceplan.go:76] ClusterServicePlan "34567" (ExternalName: "test-clusterserviceplan"): processing
I0824 18:07:57.720998       1 controller_clusterserviceclass.go:75] ClusterServiceClass "clusterserviceclass-12345" (ExternalName: "test-clusterserviceclass"): processing
I0824 18:07:57.723635       1 controller_clusterservicebroker.go:654] ClusterServiceBroker "test-clusterservicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:57.723555799 +0000 UTC m=+44.471280344
I0824 18:07:57.729081       1 controller_clusterserviceplan.go:76] ClusterServicePlan "nb34567" (ExternalName: "test-nonbindable-plan"): processing
I0824 18:07:57.730080       1 controller_clusterserviceplan.go:76] ClusterServicePlan "76543" (ExternalName: "test-otherclusterserviceplan"): processing
I0824 18:07:57.775320       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": Provision request for ServiceInstance in-flight to Broker
I0824 18:07:57.778678       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The instance was provisioned successfully
I0824 18:07:57.866628       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": failed to prepare parameters nil: failed to unmarshal parameters as JSON object: unexpected end of JSON input
I0824 18:07:57.867276       1 controller_binding.go:712] ServiceBinding "test-ns/test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:57.866554073 +0000 UTC m=+44.614278635
I0824 18:07:57.877815       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": failed to prepare parameters nil: failed to unmarshal parameters as JSON object: unexpected end of JSON input
I0824 18:07:57.883376       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": failed to prepare parameters nil: failed to unmarshal parameters as JSON object: unexpected end of JSON input
I0824 18:07:57.889156       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": failed to prepare parameters nil: failed to unmarshal parameters as JSON object: unexpected end of JSON input
I0824 18:07:57.896381       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": failed to prepare parameters nil: failed to unmarshal parameters as JSON object: unexpected end of JSON input
I0824 18:07:57.910348       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": failed to prepare parameters nil: failed to unmarshal parameters as JSON object: unexpected end of JSON input
I0824 18:07:57.913454       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": failed to prepare parameters nil: failed to unmarshal parameters as JSON object: unexpected end of JSON input
I0824 18:07:57.924427       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": failed to prepare parameters nil: failed to unmarshal parameters as JSON object: unexpected end of JSON input
I0824 18:07:57.929496       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": failed to prepare parameters nil: failed to unmarshal parameters as JSON object: unexpected end of JSON input
I0824 18:07:57.949532       1 controller.go:279] Shutting down service-catalog controller
I0824 18:07:58.002799       1 controller.go:296] Shutdown service-catalog controller
I0824 18:07:58.211786       1 controller.go:245] Starting service-catalog controller
I0824 18:07:58.252342       1 controller_clusterservicebroker.go:749] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServiceClasses
I0824 18:07:58.254630       1 controller_clusterservicebroker.go:766] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServicePlans
I0824 18:07:58.278521       1 controller_clusterservicebroker.go:654] ClusterServiceBroker "test-clusterservicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:58.278431138 +0000 UTC m=+45.026155708
I0824 18:07:58.301937       1 controller_clusterserviceplan.go:76] ClusterServicePlan "34567" (ExternalName: "test-clusterserviceplan"): processing
I0824 18:07:58.303264       1 controller_clusterserviceplan.go:76] ClusterServicePlan "nb34567" (ExternalName: "test-nonbindable-plan"): processing
I0824 18:07:58.311301       1 controller_clusterserviceclass.go:75] ClusterServiceClass "clusterserviceclass-12345" (ExternalName: "test-clusterserviceclass"): processing
I0824 18:07:58.313907       1 controller_clusterserviceplan.go:76] ClusterServicePlan "76543" (ExternalName: "test-otherclusterserviceplan"): processing
I0824 18:07:58.379862       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": Provision request for ServiceInstance in-flight to Broker
I0824 18:07:58.388951       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The instance was provisioned successfully
I0824 18:07:58.460355       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": failed to prepare parameters nil: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:07:58.461000       1 controller_binding.go:712] ServiceBinding "test-ns/test-binding": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:58.460267256 +0000 UTC m=+45.207991806
I0824 18:07:58.491148       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": failed to prepare parameters nil: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:07:58.511683       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": failed to prepare parameters nil: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:07:58.515750       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": failed to prepare parameters nil: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:07:58.521461       1 controller.go:279] Shutting down service-catalog controller
I0824 18:07:58.543758       1 controller_binding.go:698] ServiceBinding "test-ns/test-binding": failed to prepare parameters nil: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:07:58.616761       1 controller.go:296] Shutdown service-catalog controller
I0824 18:07:58.821932       1 controller.go:245] Starting service-catalog controller
I0824 18:07:58.873186       1 controller_clusterservicebroker.go:749] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServiceClasses
I0824 18:07:58.895238       1 controller_clusterservicebroker.go:766] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServicePlans
I0824 18:07:58.903041       1 controller_clusterservicebroker.go:654] ClusterServiceBroker "test-clusterservicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:07:58.902949142 +0000 UTC m=+45.650673671
I0824 18:07:58.926230       1 controller_clusterserviceclass.go:75] ClusterServiceClass "clusterserviceclass-12345" (ExternalName: "test-clusterserviceclass"): processing
... skipping 60 lines ...
I0824 18:08:00.495485       1 controller_clusterservicebroker.go:654] ClusterServiceBroker "test-clusterservicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:08:00.495423531 +0000 UTC m=+47.243148088
I0824 18:08:00.500703       1 controller_clusterserviceclass.go:75] ClusterServiceClass "clusterserviceclass-12345" (ExternalName: "test-clusterserviceclass"): processing
I0824 18:08:00.504578       1 controller_clusterserviceplan.go:76] ClusterServicePlan "34567" (ExternalName: "test-clusterserviceplan"): processing
I0824 18:08:00.505786       1 controller_clusterserviceplan.go:76] ClusterServicePlan "nb34567" (ExternalName: "test-nonbindable-plan"): processing
I0824 18:08:00.508167       1 controller_clusterserviceplan.go:76] ClusterServicePlan "76543" (ExternalName: "test-otherclusterserviceplan"): processing
I0824 18:08:00.548364       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": Provision request for ServiceInstance in-flight to Broker
I0824 18:08:00.551948       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": Error provisioning ServiceInstance of ClusterServiceClass (K8S: "clusterserviceclass-12345" ExternalName: "test-clusterserviceclass") at ClusterServiceBroker "test-clusterservicebroker": Status: 401; ErrorMessage: <nil>; Description: <nil>; ResponseError: <nil>
I0824 18:08:00.553641       1 controller.go:245] Starting service-catalog controller
I0824 18:08:00.566419       1 controller_clusterservicebroker.go:749] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServiceClasses
I0824 18:08:00.568399       1 controller_clusterservicebroker.go:766] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServicePlans
I0824 18:08:00.572573       1 controller_clusterservicebroker.go:654] ClusterServiceBroker "test-clusterservicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:08:00.572466156 +0000 UTC m=+47.320190690
I0824 18:08:00.573917       1 controller_clusterserviceclass.go:75] ClusterServiceClass "clusterserviceclass-12345" (ExternalName: "test-clusterserviceclass"): processing
I0824 18:08:00.576438       1 controller_clusterserviceplan.go:76] ClusterServicePlan "34567" (ExternalName: "test-clusterserviceplan"): processing
I0824 18:08:00.577604       1 controller_clusterserviceplan.go:76] ClusterServicePlan "nb34567" (ExternalName: "test-nonbindable-plan"): processing
I0824 18:08:00.578011       1 controller_clusterserviceplan.go:76] ClusterServicePlan "76543" (ExternalName: "test-otherclusterserviceplan"): processing
I0824 18:08:00.620447       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": Provision request for ServiceInstance in-flight to Broker
I0824 18:08:00.624549       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": Error provisioning ServiceInstance of ClusterServiceClass (K8S: "clusterserviceclass-12345" ExternalName: "test-clusterserviceclass") at ClusterServiceBroker "test-clusterservicebroker": Status: 401; ErrorMessage: <nil>; Description: <nil>; ResponseError: <nil>
I0824 18:08:01.559716       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The instance was provisioned successfully
I0824 18:08:01.569974       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The instance was provisioned successfully
I0824 18:08:01.592747       1 controller.go:279] Shutting down service-catalog controller
I0824 18:08:01.631587       1 controller.go:296] Shutdown service-catalog controller
I0824 18:08:01.642859       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The instance was provisioned successfully
I0824 18:08:01.675261       1 controller.go:279] Shutting down service-catalog controller
... skipping 77 lines ...
I0824 18:08:11.711709       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": Provision request for ServiceInstance in-flight to Broker
I0824 18:08:11.714253       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The instance was provisioned successfully
I0824 18:08:11.730380       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": Update request for ServiceInstance in-flight to Broker
I0824 18:08:11.733361       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The instance is being updated asynchronously
I0824 18:08:11.762968       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": Update request for ServiceInstance in-flight to Broker
I0824 18:08:11.765171       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The instance is being updated asynchronously
I0824 18:08:12.740179       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": Update call failed: (no description provided)
I0824 18:08:12.741144       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": Update call failed: (no description provided)
I0824 18:08:12.744428       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": Update call failed: (no description provided)
I0824 18:08:12.745063       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": Update call failed: (no description provided)
I0824 18:08:12.747568       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": Deprovision request for ServiceInstance in-flight to Broker
I0824 18:08:12.749147       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The instance was deprovisioned successfully
I0824 18:08:12.749987       1 controller_instance.go:2656] ServiceInstance "test-ns/service-instance": Cleared finalizer
I0824 18:08:12.752772       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The instance was deprovisioned successfully
I0824 18:08:12.754852       1 controller_instance.go:2656] ServiceInstance "test-ns/service-instance": Cleared finalizer
I0824 18:08:12.772396       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": Update call failed: (no description provided)
I0824 18:08:12.773300       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": Update call failed: (no description provided)
I0824 18:08:12.780723       1 controller.go:279] Shutting down service-catalog controller
I0824 18:08:12.784208       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": Deprovision request for ServiceInstance in-flight to Broker
I0824 18:08:12.787417       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The instance was deprovisioned successfully
I0824 18:08:12.788233       1 controller_instance.go:2656] ServiceInstance "test-ns/service-instance": Cleared finalizer
I0824 18:08:12.789963       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": Deprovision request for ServiceInstance in-flight to Broker
I0824 18:08:12.791051       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The instance was deprovisioned successfully
... skipping 43 lines ...
I0824 18:08:13.864906       1 controller_clusterservicebroker.go:749] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServiceClasses
I0824 18:08:13.867898       1 controller_clusterservicebroker.go:749] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServiceClasses
I0824 18:08:13.883982       1 controller_clusterservicebroker.go:766] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServicePlans
I0824 18:08:13.905762       1 controller_clusterservicebroker.go:766] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServicePlans
I0824 18:08:13.928499       1 controller_clusterservicebroker.go:766] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServicePlans
I0824 18:08:13.898262       1 controller_clusterservicebroker.go:654] ClusterServiceBroker "test-clusterservicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:08:13.898087975 +0000 UTC m=+60.645812510
I0824 18:08:13.983737       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:13.965005       1 controller_clusterserviceplan.go:76] ClusterServicePlan "34567" (ExternalName: "test-clusterserviceplan"): processing
I0824 18:08:13.993917       1 controller_clusterservicebroker.go:654] ClusterServiceBroker "test-clusterservicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:08:13.993780846 +0000 UTC m=+60.741505390
I0824 18:08:14.004880       1 controller_clusterserviceclass.go:75] ClusterServiceClass "clusterserviceclass-12345" (ExternalName: "test-clusterserviceclass"): processing
I0824 18:08:13.965479       1 controller_clusterservicebroker.go:749] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServiceClasses
I0824 18:08:14.057034       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:14.046001       1 controller_clusterserviceclass.go:75] ClusterServiceClass "clusterserviceclass-12345" (ExternalName: "test-clusterserviceclass"): processing
I0824 18:08:14.056122       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:14.098558       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:14.016507       1 controller_clusterserviceclass.go:75] ClusterServiceClass "clusterserviceclass-12345" (ExternalName: "test-clusterserviceclass"): processing
I0824 18:08:14.102401       1 controller_clusterserviceplan.go:76] ClusterServicePlan "34567" (ExternalName: "test-clusterserviceplan"): processing
I0824 18:08:14.103624       1 controller_clusterserviceplan.go:76] ClusterServicePlan "nb34567" (ExternalName: "test-nonbindable-plan"): processing
I0824 18:08:14.058315       1 controller_clusterservicebroker.go:766] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServicePlans
I0824 18:08:14.077468       1 controller_clusterservicebroker.go:654] ClusterServiceBroker "test-clusterservicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:08:14.077379541 +0000 UTC m=+60.825104086
I0824 18:08:14.078087       1 controller_clusterserviceplan.go:76] ClusterServicePlan "34567" (ExternalName: "test-clusterserviceplan"): processing
I0824 18:08:14.064871       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:14.088437       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:14.048158       1 controller_clusterserviceplan.go:76] ClusterServicePlan "nb34567" (ExternalName: "test-nonbindable-plan"): processing
I0824 18:08:14.104690       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:14.114460       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:14.120766       1 controller_clusterservicebroker.go:654] ClusterServiceBroker "test-clusterservicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:08:14.120694913 +0000 UTC m=+60.868419462
I0824 18:08:14.122347       1 controller_clusterserviceplan.go:76] ClusterServicePlan "76543" (ExternalName: "test-otherclusterserviceplan"): processing
I0824 18:08:14.146241       1 controller_clusterserviceplan.go:76] ClusterServicePlan "nb34567" (ExternalName: "test-nonbindable-plan"): processing
I0824 18:08:14.175238       1 controller_clusterserviceplan.go:76] ClusterServicePlan "34567" (ExternalName: "test-clusterserviceplan"): processing
I0824 18:08:14.184255       1 controller_clusterserviceclass.go:75] ClusterServiceClass "clusterserviceclass-12345" (ExternalName: "test-clusterserviceclass"): processing
I0824 18:08:14.195066       1 controller_clusterserviceplan.go:76] ClusterServicePlan "76543" (ExternalName: "test-otherclusterserviceplan"): processing
I0824 18:08:14.216815       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:14.236707       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:14.247322       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:14.253478       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:14.255392       1 controller_clusterserviceplan.go:76] ClusterServicePlan "76543" (ExternalName: "test-otherclusterserviceplan"): processing
I0824 18:08:14.277724       1 controller_clusterserviceplan.go:76] ClusterServicePlan "nb34567" (ExternalName: "test-nonbindable-plan"): processing
I0824 18:08:14.293207       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:14.315007       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:14.439746       1 controller.go:279] Shutting down service-catalog controller
I0824 18:08:14.480097       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:14.483831       1 controller_clusterserviceplan.go:76] ClusterServicePlan "76543" (ExternalName: "test-otherclusterserviceplan"): processing
I0824 18:08:14.704891       1 controller.go:279] Shutting down service-catalog controller
I0824 18:08:14.657211       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:14.587756       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:14.588686       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:14.599047       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:14.610913       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:14.836751       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:14.767964       1 controller.go:296] Shutdown service-catalog controller
I0824 18:08:14.801720       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:14.861315       1 controller.go:296] Shutdown service-catalog controller
I0824 18:08:14.790021       1 controller.go:279] Shutting down service-catalog controller
I0824 18:08:14.853178       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:14.952757       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:14.959066       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:14.801084       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:14.994428       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:14.996012       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:14.997142       1 controller.go:279] Shutting down service-catalog controller
I0824 18:08:14.866716       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.054187       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.055897       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:14.871079       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.077985       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:14.880152       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.096568       1 controller.go:296] Shutdown service-catalog controller
I0824 18:08:15.109693       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.135890       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.137342       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.079524       1 controller.go:296] Shutdown service-catalog controller
I0824 18:08:15.151013       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.156340       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.172013       1 controller.go:279] Shutting down service-catalog controller
I0824 18:08:15.186814       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.213799       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.214557       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.262971       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.172583       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.269076       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.269084       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.281731       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.287472       1 controller.go:296] Shutdown service-catalog controller
I0824 18:08:15.307731       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.320977       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.322281       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.326240       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.327333       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.331114       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.333726       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.338448       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.338538       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.354030       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.356625       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.363983       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.366262       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.364018       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.372393       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.456850       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.458365       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.462240       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.463119       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.458627       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.468200       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.468686       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.469659       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.483894       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.484023       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.508831       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.513074       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.514591       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.518751       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.521301       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.533086       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.549266       1 controller.go:245] Starting service-catalog controller
I0824 18:08:15.561528       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.567666       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.569740       1 controller.go:279] Shutting down service-catalog controller
I0824 18:08:15.580164       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.625078       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.639465       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.644610       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.663497       1 controller.go:279] Shutting down service-catalog controller
I0824 18:08:15.681371       1 controller.go:296] Shutdown service-catalog controller
I0824 18:08:15.664531       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.748786       1 controller_clusterservicebroker.go:749] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServiceClasses
I0824 18:08:15.758842       1 controller_clusterservicebroker.go:766] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServicePlans
I0824 18:08:15.774553       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:15.775979       1 controller.go:279] Shutting down service-catalog controller
I0824 18:08:15.793747       1 controller.go:296] Shutdown service-catalog controller
I0824 18:08:15.801765       1 controller_clusterservicebroker.go:654] ClusterServiceBroker "test-clusterservicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:08:15.80166801 +0000 UTC m=+62.549392570
I0824 18:08:15.844337       1 controller_clusterserviceplan.go:76] ClusterServicePlan "34567" (ExternalName: "test-clusterserviceplan"): processing
I0824 18:08:15.845136       1 controller_clusterserviceclass.go:75] ClusterServiceClass "clusterserviceclass-12345" (ExternalName: "test-clusterserviceclass"): processing
I0824 18:08:15.845784       1 controller_clusterserviceplan.go:76] ClusterServicePlan "nb34567" (ExternalName: "test-nonbindable-plan"): processing
I0824 18:08:15.847642       1 controller_clusterserviceplan.go:76] ClusterServicePlan "76543" (ExternalName: "test-otherclusterserviceplan"): processing
I0824 18:08:15.890955       1 controller.go:296] Shutdown service-catalog controller
I0824 18:08:16.172747       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:16.178400       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:16.182370       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:16.238791       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:16.245049       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:16.250255       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:16.257760       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:16.271236       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:16.276417       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:16.330208       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:16.343486       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:16.347952       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:16.409833       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:16.425609       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:16.430954       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:16.437106       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:16.441619       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:16.446891       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:16.452070       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:16.458929       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:16.465723       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:16.470830       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:16.476184       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:16.488953       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:16.513820       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:16.541056       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:16.546209       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:16.551124       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:16.556146       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:16.580665       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:16.588325       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:16.593661       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:16.625104       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:16.630209       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:16.665800       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:16.670473       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[110 117 108 108],}: failed to unmarshal parameters as JSON object: invalid character 'b' looking for beginning of value
I0824 18:08:16.694010       1 controller.go:279] Shutting down service-catalog controller
I0824 18:08:16.770285       1 controller.go:296] Shutdown service-catalog controller
I0824 18:08:17.836127       1 controller.go:245] Starting service-catalog controller
I0824 18:08:17.913448       1 controller_clusterservicebroker.go:749] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServiceClasses
I0824 18:08:17.919462       1 controller_clusterservicebroker.go:766] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServicePlans
I0824 18:08:17.960434       1 controller_clusterservicebroker.go:654] ClusterServiceBroker "test-clusterservicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:08:17.960280911 +0000 UTC m=+64.708005455
... skipping 13 lines ...
I0824 18:08:18.691287       1 controller_clusterservicebroker.go:749] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServiceClasses
I0824 18:08:18.685931       1 controller.go:245] Starting service-catalog controller
I0824 18:08:18.698526       1 controller_clusterservicebroker.go:749] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServiceClasses
I0824 18:08:18.688778       1 controller_clusterservicebroker.go:749] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServiceClasses
I0824 18:08:18.821030       1 controller_clusterservicebroker.go:766] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServicePlans
I0824 18:08:18.830082       1 controller_clusterserviceplan.go:76] ClusterServicePlan "34567" (ExternalName: "test-clusterserviceplan"): processing
I0824 18:08:18.830143       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The provision call failed and will be retried: Error communicating with broker for provisioning: non-url error
I0824 18:08:18.868030       1 controller_clusterservicebroker.go:766] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServicePlans
I0824 18:08:18.862936       1 controller_clusterserviceclass.go:75] ClusterServiceClass "clusterserviceclass-12345" (ExternalName: "test-clusterserviceclass"): processing
I0824 18:08:18.863468       1 controller_clusterservicebroker.go:766] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServicePlans
I0824 18:08:18.833447       1 controller_clusterservicebroker.go:654] ClusterServiceBroker "test-clusterservicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:08:18.833327998 +0000 UTC m=+65.581052529
I0824 18:08:18.881281       1 controller_clusterservicebroker.go:766] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServicePlans
I0824 18:08:18.896291       1 controller_clusterservicebroker.go:749] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServiceClasses
... skipping 32 lines ...
I0824 18:08:19.460843       1 controller_clusterservicebroker.go:654] ClusterServiceBroker "test-clusterservicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:08:19.460755559 +0000 UTC m=+66.208480102
I0824 18:08:19.512643       1 controller_clusterserviceplan.go:76] ClusterServicePlan "34567" (ExternalName: "test-clusterserviceplan"): processing
I0824 18:08:19.523413       1 controller_clusterserviceplan.go:76] ClusterServicePlan "nb34567" (ExternalName: "test-nonbindable-plan"): processing
I0824 18:08:19.524220       1 controller_clusterserviceplan.go:76] ClusterServicePlan "76543" (ExternalName: "test-otherclusterserviceplan"): processing
I0824 18:08:19.576217       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": Provision request for ServiceInstance in-flight to Broker
I0824 18:08:19.582916       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": Provision request for ServiceInstance in-flight to Broker
I0824 18:08:19.583398       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The provision call failed and will be retried: Error communicating with broker for provisioning: non-url error
I0824 18:08:19.622646       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The provision call failed and will be retried: Error communicating with broker for provisioning: non-url error
I0824 18:08:19.699371       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": Provision request for ServiceInstance in-flight to Broker
I0824 18:08:19.702342       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The provision call failed and will be retried: Error communicating with broker for provisioning: non-url error
I0824 18:08:19.775794       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": Provision request for ServiceInstance in-flight to Broker
I0824 18:08:19.778667       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The provision call failed and will be retried: Error communicating with broker for provisioning: non-url error
I0824 18:08:19.876149       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": Provision request for ServiceInstance in-flight to Broker
I0824 18:08:19.879179       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The provision call failed and will be retried: Error communicating with broker for provisioning: non-url error
I0824 18:08:19.927584       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": Provision request for ServiceInstance in-flight to Broker
I0824 18:08:19.985317       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The provision call failed and will be retried: Error communicating with broker for provisioning: non-url error
I0824 18:08:20.164066       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": Provision request for ServiceInstance in-flight to Broker
I0824 18:08:20.167379       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The provision call failed and will be retried: Error communicating with broker for provisioning: non-url error
I0824 18:08:20.294869       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The instance was provisioned successfully
I0824 18:08:20.551864       1 controller.go:279] Shutting down service-catalog controller
I0824 18:08:20.633526       1 controller.go:296] Shutdown service-catalog controller
I0824 18:08:20.715694       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The instance was provisioned successfully
I0824 18:08:20.752193       1 controller.go:279] Shutting down service-catalog controller
I0824 18:08:20.780822       1 controller.go:245] Starting service-catalog controller
... skipping 23 lines ...
I0824 18:08:21.477274       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The instance was provisioned successfully
I0824 18:08:21.498226       1 controller.go:296] Shutdown service-catalog controller
I0824 18:08:21.525653       1 controller.go:279] Shutting down service-catalog controller
I0824 18:08:21.603429       1 controller.go:296] Shutdown service-catalog controller
I0824 18:08:21.627942       1 controller.go:245] Starting service-catalog controller
I0824 18:08:21.684011       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": Provision request for ServiceInstance in-flight to Broker
I0824 18:08:21.700367       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The provision call failed and will be retried: Error communicating with broker for provisioning: non-url error
I0824 18:08:21.718922       1 controller_clusterservicebroker.go:749] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServiceClasses
I0824 18:08:21.730714       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": Provision request for ServiceInstance in-flight to Broker
I0824 18:08:21.739945       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The provision call failed and will be retried: Error communicating with broker for provisioning: non-url error
I0824 18:08:21.741012       1 controller_clusterservicebroker.go:766] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServicePlans
I0824 18:08:21.770257       1 controller_clusterserviceclass.go:75] ClusterServiceClass "clusterserviceclass-12345" (ExternalName: "test-clusterserviceclass"): processing
I0824 18:08:21.790385       1 controller_clusterservicebroker.go:654] ClusterServiceBroker "test-clusterservicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:08:21.790288467 +0000 UTC m=+68.538013008
I0824 18:08:21.809381       1 controller_clusterserviceplan.go:76] ClusterServicePlan "34567" (ExternalName: "test-clusterserviceplan"): processing
I0824 18:08:21.810406       1 controller_clusterserviceplan.go:76] ClusterServicePlan "nb34567" (ExternalName: "test-nonbindable-plan"): processing
I0824 18:08:21.810526       1 controller_clusterserviceplan.go:76] ClusterServicePlan "76543" (ExternalName: "test-otherclusterserviceplan"): processing
... skipping 2 lines ...
I0824 18:08:21.925158       1 controller.go:296] Shutdown service-catalog controller
I0824 18:08:21.994665       1 controller.go:279] Shutting down service-catalog controller
I0824 18:08:22.014074       1 controller.go:279] Shutting down service-catalog controller
I0824 18:08:22.075590       1 controller.go:296] Shutdown service-catalog controller
I0824 18:08:22.123588       1 controller.go:296] Shutdown service-catalog controller
I0824 18:08:22.359482       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": Provision request for ServiceInstance in-flight to Broker
I0824 18:08:22.362458       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The provision call failed and will be retried: Error communicating with broker for provisioning: non-url error
I0824 18:08:22.884742       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The instance was provisioned successfully
I0824 18:08:22.908420       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The instance was provisioned successfully
I0824 18:08:22.931828       1 controller.go:279] Shutting down service-catalog controller
I0824 18:08:22.979578       1 controller.go:296] Shutdown service-catalog controller
I0824 18:08:22.989193       1 controller.go:279] Shutting down service-catalog controller
I0824 18:08:23.059388       1 controller.go:296] Shutdown service-catalog controller
... skipping 93 lines ...
I0824 18:08:27.028684       1 controller_clusterservicebroker.go:654] ClusterServiceBroker "test-clusterservicebroker": Setting lastTransitionTime for condition "Ready" to 2020-08-24 18:08:27.028569683 +0000 UTC m=+73.776294220
I0824 18:08:27.036147       1 controller_clusterserviceplan.go:76] ClusterServicePlan "34567" (ExternalName: "test-clusterserviceplan"): processing
I0824 18:08:27.055350       1 controller_clusterserviceclass.go:75] ClusterServiceClass "clusterserviceclass-12345" (ExternalName: "test-clusterserviceclass"): processing
I0824 18:08:27.057368       1 controller_clusterserviceplan.go:76] ClusterServicePlan "nb34567" (ExternalName: "test-nonbindable-plan"): processing
I0824 18:08:27.058446       1 controller_clusterserviceplan.go:76] ClusterServicePlan "76543" (ExternalName: "test-otherclusterserviceplan"): processing
I0824 18:08:34.907538       1 controller.go:279] Shutting down service-catalog controller
--- FAIL: TestUpdateServiceInstanceNewDashboardResponse (8.65s)
    --- FAIL: TestUpdateServiceInstanceNewDashboardResponse/Alpha_feature_disabled (8.27s)
        controller_flow_instance_test.go:805: 
            	Error Trace:	controller_flow_instance_test.go:805
            	Error:      	Received unexpected error:
            	            	the instance is in expected state (expected condition {Type:Ready Status:True LastTransitionTime:0001-01-01 00:00:00 +0000 UTC Reason: Message:}), current status: {Conditions:[] AsyncOpInProgress:false OrphanMitigationInProgress:false LastOperation:<nil> DashboardURL:<nil> CurrentOperation: ReconciledGeneration:0 ObservedGeneration:0 OperationStartTime:<nil> InProgressProperties:<nil> ExternalProperties:<nil> ProvisionStatus: DeprovisionStatus: DefaultProvisionParameters:nil LastConditionState: UserSpecifiedPlanName: UserSpecifiedClassName:}
            	Test:       	TestUpdateServiceInstanceNewDashboardResponse/Alpha_feature_disabled
I0824 18:08:34.959901       1 controller.go:296] Shutdown service-catalog controller
I0824 18:08:36.093149       1 controller.go:245] Starting service-catalog controller
I0824 18:08:36.162916       1 controller_clusterservicebroker.go:749] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServiceClasses
I0824 18:08:36.182062       1 controller_clusterservicebroker.go:766] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServicePlans
... skipping 476 lines ...
I0824 18:08:48.309947       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The instance references a non-existent ClusterServicePlan "34567" - {ClusterServiceClassExternalName:"clusterserviceclass-12345", ClusterServicePlanExternalName:"34567"}
I0824 18:08:48.331082       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The instance references a non-existent ClusterServicePlan "34567" - {ClusterServiceClassExternalName:"clusterserviceclass-12345", ClusterServicePlanExternalName:"34567"}
I0824 18:08:48.336121       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The instance references a non-existent ClusterServicePlan "34567" - {ClusterServiceClassExternalName:"clusterserviceclass-12345", ClusterServicePlanExternalName:"34567"}
I0824 18:08:48.341703       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The instance references a non-existent broker "test-clusterservicebroker"
I0824 18:08:48.343331       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": Deprovision request for ServiceInstance in-flight to Broker
I0824 18:08:48.345758       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The instance is being deprovisioned asynchronously
I0824 18:08:48.351039       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[33 34 65 114 103 115 34 58 123 34 102 105 114 115 116 34 58 34 102 105 114 115 116 45 97 114 103 34 44 34 115 101 99 111 110 100 34 58 34 115 101 99 111 110 100 45 97 114 103 34 125 44 34 78 97 109 101 34 58 34 116 101 115 116 45 112 97 114 97 109 34 125],}: error converting YAML to JSON: yaml: did not find expected whitespace or line break
I0824 18:08:48.352385       1 controller.go:279] Shutting down service-catalog controller
I0824 18:08:48.352900       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The instance references a non-existent ClusterServicePlan "34567" - {ClusterServiceClassExternalName:"clusterserviceclass-12345", ClusterServicePlanExternalName:"34567"}
I0824 18:08:48.357662       1 controller.go:279] Shutting down service-catalog controller
I0824 18:08:48.361611       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[33 34 65 114 103 115 34 58 123 34 102 105 114 115 116 34 58 34 102 105 114 115 116 45 97 114 103 34 44 34 115 101 99 111 110 100 34 58 34 115 101 99 111 110 100 45 97 114 103 34 125 44 34 78 97 109 101 34 58 34 116 101 115 116 45 112 97 114 97 109 34 125],}: error converting YAML to JSON: yaml: did not find expected whitespace or line break
I0824 18:08:48.366350       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[33 34 65 114 103 115 34 58 123 34 102 105 114 115 116 34 58 34 102 105 114 115 116 45 97 114 103 34 44 34 115 101 99 111 110 100 34 58 34 115 101 99 111 110 100 45 97 114 103 34 125 44 34 78 97 109 101 34 58 34 116 101 115 116 45 112 97 114 97 109 34 125],}: error converting YAML to JSON: yaml: did not find expected whitespace or line break
I0824 18:08:48.369943       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": Deprovision call failed: (no description provided)
I0824 18:08:48.375493       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The instance references a non-existent ClusterServicePlan "non-existing-plan-id" - {ClusterServiceClassExternalName:"clusterserviceclass-12345", ClusterServicePlanExternalName:"non-existing-plan-id"}
I0824 18:08:48.386980       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The instance is being deprovisioned asynchronously
I0824 18:08:48.389118       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The instance references a non-existent ClusterServicePlan "non-existing-plan-id" - {ClusterServiceClassExternalName:"clusterserviceclass-12345", ClusterServicePlanExternalName:"non-existing-plan-id"}
I0824 18:08:48.394709       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[33 34 65 114 103 115 34 58 123 34 102 105 114 115 116 34 58 34 102 105 114 115 116 45 97 114 103 34 44 34 115 101 99 111 110 100 34 58 34 115 101 99 111 110 100 45 97 114 103 34 125 44 34 78 97 109 101 34 58 34 116 101 115 116 45 112 97 114 97 109 34 125],}: error converting YAML to JSON: yaml: did not find expected whitespace or line break
I0824 18:08:48.398208       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The instance references a non-existent ClusterServicePlan "34567" - {ClusterServiceClassExternalName:"clusterserviceclass-12345", ClusterServicePlanExternalName:"34567"}
I0824 18:08:48.406033       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The instance references a non-existent ClusterServicePlan "non-existing-plan-id" - {ClusterServiceClassExternalName:"clusterserviceclass-12345", ClusterServicePlanExternalName:"non-existing-plan-id"}
I0824 18:08:48.408771       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[33 34 65 114 103 115 34 58 123 34 102 105 114 115 116 34 58 34 102 105 114 115 116 45 97 114 103 34 44 34 115 101 99 111 110 100 34 58 34 115 101 99 111 110 100 45 97 114 103 34 125 44 34 78 97 109 101 34 58 34 116 101 115 116 45 112 97 114 97 109 34 125],}: error converting YAML to JSON: yaml: did not find expected whitespace or line break
I0824 18:08:48.358124       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The instance references a non-existent broker "test-clusterservicebroker"
I0824 18:08:48.412977       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": The instance was deprovisioned successfully
I0824 18:08:48.415117       1 controller_instance.go:2656] ServiceInstance "test-ns/service-instance": Cleared finalizer
I0824 18:08:48.415941       1 controller.go:279] Shutting down service-catalog controller
I0824 18:08:48.419831       1 controller_clusterservicebroker.go:749] ClusterServiceBroker "test-clusterservicebroker": Found 1 ClusterServiceClasses
I0824 18:08:48.420525       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[33 34 65 114 103 115 34 58 123 34 102 105 114 115 116 34 58 34 102 105 114 115 116 45 97 114 103 34 44 34 115 101 99 111 110 100 34 58 34 115 101 99 111 110 100 45 97 114 103 34 125 44 34 78 97 109 101 34 58 34 116 101 115 116 45 112 97 114 97 109 34 125],}: error converting YAML to JSON: yaml: did not find expected whitespace or line break
I0824 18:08:48.422263       1 controller_clusterservicebroker.go:766] ClusterServiceBroker "test-clusterservicebroker": Found 0 ClusterServicePlans
I0824 18:08:48.424788       1 controller.go:296] Shutdown service-catalog controller
I0824 18:08:48.427912       1 controller_clusterserviceclass.go:75] ClusterServiceClass "clusterserviceclass-12345" (ExternalName: "test-clusterserviceclass"): processing
I0824 18:08:48.429240       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[33 34 65 114 103 115 34 58 123 34 102 105 114 115 116 34 58 34 102 105 114 115 116 45 97 114 103 34 44 34 115 101 99 111 110 100 34 58 34 115 101 99 111 110 100 45 97 114 103 34 125 44 34 78 97 109 101 34 58 34 116 101 115 116 45 112 97 114 97 109 34 125],}: error converting YAML to JSON: yaml: did not find expected whitespace or line break
I0824 18:08:48.430368       1 controller.go:296] Shutdown service-catalog controller
I0824 18:08:48.436056       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[33 34 65 114 103 115 34 58 123 34 102 105 114 115 116 34 58 34 102 105 114 115 116 45 97 114 103 34 44 34 115 101 99 111 110 100 34 58 34 115 101 99 111 110 100 45 97 114 103 34 125 44 34 78 97 109 101 34 58 34 116 101 115 116 45 112 97 114 97 109 34 125],}: error converting YAML to JSON: yaml: did not find expected whitespace or line break
I0824 18:08:48.442843       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[33 34 65 114 103 115 34 58 123 34 102 105 114 115 116 34 58 34 102 105 114 115 116 45 97 114 103 34 44 34 115 101 99 111 110 100 34 58 34 115 101 99 111 110 100 45 97 114 103 34 125 44 34 78 97 109 101 34 58 34 116 101 115 116 45 112 97 114 97 109 34 125],}: error converting YAML to JSON: yaml: did not find expected whitespace or line break
I0824 18:08:48.448605       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[33 34 65 114 103 115 34 58 123 34 102 105 114 115 116 34 58 34 102 105 114 115 116 45 97 114 103 34 44 34 115 101 99 111 110 100 34 58 34 115 101 99 111 110 100 45 97 114 103 34 125 44 34 78 97 109 101 34 58 34 116 101 115 116 45 112 97 114 97 109 34 125],}: error converting YAML to JSON: yaml: did not find expected whitespace or line break
I0824 18:08:48.459194       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[33 34 65 114 103 115 34 58 123 34 102 105 114 115 116 34 58 34 102 105 114 115 116 45 97 114 103 34 44 34 115 101 99 111 110 100 34 58 34 115 101 99 111 110 100 45 97 114 103 34 125 44 34 78 97 109 101 34 58 34 116 101 115 116 45 112 97 114 97 109 34 125],}: error converting YAML to JSON: yaml: did not find expected whitespace or line break
I0824 18:08:48.460763       1 controller_clusterserviceclass.go:75] ClusterServiceClass "clusterserviceclass-12345" (ExternalName: "test-clusterserviceclass"): processing
I0824 18:08:48.461772       1 controller_clusterserviceclass.go:81] ClusterServiceClass "clusterserviceclass-12345" (ExternalName: "test-clusterserviceclass"): has been removed from broker catalog; determining whether there are instances remaining
I0824 18:08:48.465206       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[33 34 65 114 103 115 34 58 123 34 102 105 114 115 116 34 58 34 102 105 114 115 116 45 97 114 103 34 44 34 115 101 99 111 110 100 34 58 34 115 101 99 111 110 100 45 97 114 103 34 125 44 34 78 97 109 101 34 58 34 116 101 115 116 45 112 97 114 97 109 34 125],}: error converting YAML to JSON: yaml: did not find expected whitespace or line break
I0824 18:08:48.465655       1 controller.go:279] Shutting down service-catalog controller
I0824 18:08:48.465481       1 controller_clusterserviceclass.go:87] Found 0 ServiceInstances
I0824 18:08:48.469045       1 controller_clusterserviceclass.go:93] ClusterServiceClass "clusterserviceclass-12345" (ExternalName: "test-clusterserviceclass"): has been removed from broker catalog and has zero instances remaining; deleting
I0824 18:08:48.472987       1 controller_instance.go:1829] ServiceInstance "test-ns/service-instance": failed to prepare parameters &RawExtension{Raw:*[33 34 65 114 103 115 34 58 123 34 102 105 114 115 116 34 58 34 102 105 114 115 116 45 97 114 103 34 44 34 115 101 99 111 110 100 34 58 34 115 101 99 111 110 100 45 97 114 103 34 125 44 34 78 97 109 101 34 58 34 116 101 115 116 45 112 97 114 97 109 34 125],}: error converting YAML to JSON: yaml: did not find expected whitespace or line break
I0824 18:08:48.489325       1 controller.go:296] Shutdown service-catalog controller
I0824 18:08:48.501298       1 controller.go:279] Shutting down service-catalog controller
I0824 18:08:48.509280       1 controller.go:296] Shutdown service-catalog controller
FAIL
make: *** [Makefile:295: test-integration] Error 1
+ EXIT_VALUE=2
+ set +o xtrace
Cleaning up after docker in docker.
================================================================================
Cleaning up after docker
Stopping Docker: dockerProgram process in pidfile '/var/run/docker-ssd.pid', 1 process(es), refused to die.
... skipping 3 lines ...