Uploaded image for project: 'OpenShift Bugs'
  1. OpenShift Bugs
  2. OCPBUGS-20417

syncer: fix nil pointer dereference in log message

    XMLWordPrintable

Details

    • Bug
    • Resolution: Done-Errata
    • Critical
    • 4.12.z
    • 4.12.z
    • Storage
    • Critical
    • Yes
    • Rejected
    • False
    • Hide

      None

      Show
      None

    Description

      Description of problem:

      - After upgrading cluster from 4.10 to 4.12.35, the cluster has successfully completed installation of 4.12.35, but storage operator stuck in CrashLoopBackOff state:
      
      omc get co
      NAME                                       VERSION   AVAILABLE   PROGRESSING   DEGRADED   SINCE
      storage                                    4.12.35   False       True          False      1y
      
      omc get po -A |grep -iv 'running\|completed'
      NAMESPACE                                          NAME                                                              READY   STATUS             RESTARTS   AGE
      openshift-cluster-csi-drivers                      vmware-vsphere-csi-driver-controller-645948b495-hmcjx             12/13   CrashLoopBackOff   21         1h
      openshift-cluster-csi-drivers                      vmware-vsphere-csi-driver-controller-645948b495-wcz7s             12/13   CrashLoopBackOff   21         1h

      Version-Release number of selected component (if applicable):

      4.12.35

      Current Status:

      • We had recommended to the customer that they verify the cloud-provider-config and credentials in secret/vsphere-creds. The customer has since verified that all configurations are accurate.
      • This appears to be due to errors similar to the following:
        $ omc logs vmware-vsphere-csi-driver-controller-645948b495-hmcjx -n openshift-cluster-csi-drivers -c vsphere-syncer 
        ...
        2023-10-07T22:33:48.132384307Z {"level":"info","time":"2023-10-07T22:33:48.132319042Z","caller":"migration/migration.go:519","msg":"Registering volume: \"[D2_Tools_Artifactory_03] volumes/artifactory-member-1\" using backingDiskURLPath :\"https://d2-ap-custvc.ad.sec.gov/folder/volumes/artifactory-member-1?dcPath=D2-OpenShift-DC&dsName=D2_Tools_Artifactory_03\""}
        2023-10-07T22:33:48.171361862Z {"level":"info","time":"2023-10-07T22:33:48.171277078Z","caller":"syncer/metadatasyncer.go:956","msg":"Registering in-tree Static vSphere PV: \"postgresql-artifactory\", Volume Path: \"[D2_Tools_Artifactory_03] volumes/postgres\"","TraceId":"36f40bb3-49a8-4386-a901-1a451bcdd689"}
        2023-10-07T22:33:48.171446326Z {"level":"info","time":"2023-10-07T22:33:48.171398554Z","caller":"migration/migration.go:519","msg":"Registering volume: \"[D2_Tools_Artifactory_03] volumes/postgres\" using backingDiskURLPath :\"https://d2-ap-custvc.ad.sec.gov/folder/volumes/postgres?dcPath=D2-OpenShift-DC&dsName=D2_Tools_Artifactory_03\"","TraceId":"36f40bb3-49a8-4386-a901-1a451bcdd689"}
        2023-10-07T22:33:48.340168658Z {"level":"info","time":"2023-10-07T22:33:48.34009221Z","caller":"volume/manager.go:508","msg":"CreateVolume: VolumeName: \"9502c18b-6561-11ee-b9b6-005056a34ce4\", opId: \"05961a9d\""}
        2023-10-07T22:33:48.340378102Z {"level":"info","time":"2023-10-07T22:33:48.340333857Z","caller":"volume/util.go:371","msg":"Extract vimfault type: +types.CnsFault  vimFault: +{<nil> Fault cause: vmodl.fault.InvalidArgument\n} Fault: &{DynamicData:{} Fault:{BaseMethodFault:<nil> Reason:Fault cause: vmodl.fault.InvalidArgument\n} LocalizedMessage:CnsFault error: Fault cause: vmodl.fault.InvalidArgument\n} from resp: +&{{} {{} } 0xc004091da0}"}
        2023-10-07T22:33:48.340553060Z {"level":"error","time":"2023-10-07T22:33:48.340478353Z","caller":"volume/util.go:298","msg":"failed to create volume with fault: \"(*types.LocalizedMethodFault)(0xc004091da0)({\\n DynamicData: (types.DynamicData) {\\n },\\n Fault: (types.CnsFault) {\\n  BaseMethodFault: (types.BaseMethodFault) <nil>,\\n  Reason: (string) (len=41) \\\"Fault cause: vmodl.fault.InvalidArgument\\\\n\\\"\\n },\\n LocalizedMessage: (string) (len=57) \\\"CnsFault error: Fault cause: vmodl.fault.InvalidArgument\\\\n\\\"\\n})\\n\"","stacktrace":"sigs.k8s.io/vsphere-csi-driver/v2/pkg/common/cns-lib/volume.validateCreateVolumeResponseFault\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/common/cns-lib/volume/util.go:298\nsigs.k8s.io/vsphere-csi-driver/v2/pkg/common/cns-lib/volume.(*defaultManager).createVolume\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/common/cns-lib/volume/manager.go:525\nsigs.k8s.io/vsphere-csi-driver/v2/pkg/common/cns-lib/volume.(*defaultManager).CreateVolume.func1\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/common/cns-lib/volume/manager.go:573\nsigs.k8s.io/vsphere-csi-driver/v2/pkg/common/cns-lib/volume.(*defaultManager).CreateVolume\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/common/cns-lib/volume/manager.go:576\nsigs.k8s.io/vsphere-csi-driver/v2/pkg/apis/migration.(*volumeMigration).registerVolume\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/apis/migration/migration.go:523\nsigs.k8s.io/vsphere-csi-driver/v2/pkg/apis/migration.(*volumeMigration).GetVolumeID\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/apis/migration/migration.go:218\nsigs.k8s.io/vsphere-csi-driver/v2/pkg/syncer.CsiFullSync\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/syncer/fullsync.go:89\nsigs.k8s.io/vsphere-csi-driver/v2/pkg/syncer.InitMetadataSyncer.func11\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/syncer/metadatasyncer.go:430"}
        2023-10-07T22:33:48.340732540Z {"level":"error","time":"2023-10-07T22:33:48.340627799Z","caller":"volume/manager.go:540","msg":"failed to create cns volume 9502c18b-6561-11ee-b9b6-005056a34ce4. createSpec: \"(*types.CnsVolumeCreateSpec)(0xc00377d900)({\\n DynamicData: (types.DynamicData) {\\n },\\n Name: (string) (len=36) \\\"9502c18b-6561-11ee-b9b6-005056a34ce4\\\",\\n VolumeType: (string) (len=5) \\\"BLOCK\\\",\\n Datastores: ([]types.ManagedObjectReference) <nil>,\\n Metadata: (types.CnsVolumeMetadata) {\\n  DynamicData: (types.DynamicData) {\\n  },\\n  ContainerCluster: (types.CnsContainerCluster) {\\n   DynamicData: (types.DynamicData) {\\n   },\\n   ClusterType: (string) (len=10) \\\"KUBERNETES\\\",\\n   ClusterId: (string) (len=10) \\\"mgmt-7dg4z\\\",\\n   VSphereUser: (string) (len=20) \\\"AD\\\\\\\\ocp4prodadmin.svc\\\",\\n   ClusterFlavor: (string) (len=7) \\\"VANILLA\\\",\\n   ClusterDistribution: (string) \\\"\\\"\\n  },\\n  EntityMetadata: ([]types.BaseCnsEntityMetadata) <nil>,\\n  ContainerClusterArray: ([]types.CnsContainerCluster) (len=1 cap=1) {\\n   (types.CnsContainerCluster) {\\n    DynamicData: (types.DynamicData) {\\n    },\\n    ClusterType: (string) (len=10) \\\"KUBERNETES\\\",\\n    ClusterId: (string) (len=10) \\\"mgmt-7dg4z\\\",\\n    VSphereUser: (string) (len=17) \\\"ocp4prodadmin.svc\\\",\\n    ClusterFlavor: (string) (len=7) \\\"VANILLA\\\",\\n    ClusterDistribution: (string) \\\"\\\"\\n   }\\n  }\\n },\\n BackingObjectDetails: (*types.CnsBlockBackingDetails)(0xc003755780)({\\n  CnsBackingObjectDetails: (types.CnsBackingObjectDetails) {\\n   DynamicData: (types.DynamicData) {\\n   },\\n   CapacityInMb: (int64) 0\\n  },\\n  BackingDiskId: (string) \\\"\\\",\\n  BackingDiskUrlPath: (string) (len=121) \\\"https://d2-ap-custvc.ad.sec.gov/folder/volumes/artifactory-member-1?dcPath=D2-OpenShift-DC&dsName=D2_Tools_Artifactory_03\\\",\\n  BackingDiskObjectId: (string) \\\"\\\"\\n }),\\n Profile: ([]types.BaseVirtualMachineProfileSpec) <nil>,\\n CreateSpec: (types.BaseCnsBaseCreateSpec) <nil>,\\n VolumeSource: (types.BaseCnsVolumeSource) <nil>\\n})\\n\", fault: \"(*types.LocalizedMethodFault)(0xc004091da0)({\\n DynamicData: (types.DynamicData) {\\n },\\n Fault: (types.CnsFault) {\\n  BaseMethodFault: (types.BaseMethodFault) <nil>,\\n  Reason: (string) (len=41) \\\"Fault cause: vmodl.fault.InvalidArgument\\\\n\\\"\\n },\\n LocalizedMessage: (string) (len=57) \\\"CnsFault error: Fault cause: vmodl.fault.InvalidArgument\\\\n\\\"\\n})\\n\"","stacktrace":"sigs.k8s.io/vsphere-csi-driver/v2/pkg/common/cns-lib/volume.(*defaultManager).createVolume\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/common/cns-lib/volume/manager.go:540\nsigs.k8s.io/vsphere-csi-driver/v2/pkg/common/cns-lib/volume.(*defaultManager).CreateVolume.func1\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/common/cns-lib/volume/manager.go:573\nsigs.k8s.io/vsphere-csi-driver/v2/pkg/common/cns-lib/volume.(*defaultManager).CreateVolume\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/common/cns-lib/volume/manager.go:576\nsigs.k8s.io/vsphere-csi-driver/v2/pkg/apis/migration.(*volumeMigration).registerVolume\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/apis/migration/migration.go:523\nsigs.k8s.io/vsphere-csi-driver/v2/pkg/apis/migration.(*volumeMigration).GetVolumeID\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/apis/migration/migration.go:218\nsigs.k8s.io/vsphere-csi-driver/v2/pkg/syncer.CsiFullSync\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/syncer/fullsync.go:89\nsigs.k8s.io/vsphere-csi-driver/v2/pkg/syncer.InitMetadataSyncer.func11\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/syncer/metadatasyncer.go:430"}
        2023-10-07T22:33:48.340866375Z {"level":"warn","time":"2023-10-07T22:33:48.340808941Z","caller":"migration/migration.go:525","msg":"failed to register volume \"[D2_Tools_Artifactory_03] volumes/artifactory-member-1\" with createSpec: &{{} 9502c18b-6561-11ee-b9b6-005056a34ce4 BLOCK [] {{} {{} KUBERNETES mgmt-7dg4z AD\\ocp4prodadmin.svc VANILLA } [] [{{} KUBERNETES mgmt-7dg4z ocp4prodadmin.svc VANILLA }]} 0xc003755780 [] <nil> <nil>}. error: failed to create volume with fault: \"(*types.LocalizedMethodFault)(0xc004091da0)({\\n DynamicData: (types.DynamicData) {\\n },\\n Fault: (types.CnsFault) {\\n  BaseMethodFault: (types.BaseMethodFault) <nil>,\\n  Reason: (string) (len=41) \\\"Fault cause: vmodl.fault.InvalidArgument\\\\n\\\"\\n },\\n LocalizedMessage: (string) (len=57) \\\"CnsFault error: Fault cause: vmodl.fault.InvalidArgument\\\\n\\\"\\n})\\n\""}
        2023-10-07T22:33:48.340901381Z {"level":"error","time":"2023-10-07T22:33:48.340838585Z","caller":"migration/migration.go:535","msg":"registration failed for volumeSpec: &{[D2_Tools_Artifactory_03] volumes/artifactory-member-1 }","stacktrace":"sigs.k8s.io/vsphere-csi-driver/v2/pkg/apis/migration.(*volumeMigration).registerVolume\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/apis/migration/migration.go:535\nsigs.k8s.io/vsphere-csi-driver/v2/pkg/apis/migration.(*volumeMigration).GetVolumeID\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/apis/migration/migration.go:218\nsigs.k8s.io/vsphere-csi-driver/v2/pkg/syncer.CsiFullSync\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/syncer/fullsync.go:89\nsigs.k8s.io/vsphere-csi-driver/v2/pkg/syncer.InitMetadataSyncer.func11\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/syncer/metadatasyncer.go:430"}
        2023-10-07T22:33:48.340901381Z {"level":"error","time":"2023-10-07T22:33:48.340881754Z","caller":"migration/migration.go:220","msg":"failed to register volume for volumeSpec: &{[D2_Tools_Artifactory_03] volumes/artifactory-member-1 }, with err: registration failed for volumeSpec: &{[D2_Tools_Artifactory_03] volumes/artifactory-member-1 }","stacktrace":"sigs.k8s.io/vsphere-csi-driver/v2/pkg/apis/migration.(*volumeMigration).GetVolumeID\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/apis/migration/migration.go:220\nsigs.k8s.io/vsphere-csi-driver/v2/pkg/syncer.CsiFullSync\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/syncer/fullsync.go:89\nsigs.k8s.io/vsphere-csi-driver/v2/pkg/syncer.InitMetadataSyncer.func11\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/syncer/metadatasyncer.go:430"}
        2023-10-07T22:33:48.340942649Z {"level":"error","time":"2023-10-07T22:33:48.340898008Z","caller":"syncer/fullsync.go:91","msg":"FullSync: Failed to get VolumeID from volumeMigrationService for spec: &{[D2_Tools_Artifactory_03] volumes/artifactory-member-1 }. Err: registration failed for volumeSpec: &{[D2_Tools_Artifactory_03] volumes/artifactory-member-1 }","stacktrace":"sigs.k8s.io/vsphere-csi-driver/v2/pkg/syncer.CsiFullSync\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/syncer/fullsync.go:91\nsigs.k8s.io/vsphere-csi-driver/v2/pkg/syncer.InitMetadataSyncer.func11\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/syncer/metadatasyncer.go:430"}
        2023-10-07T22:33:48.340965859Z {"level":"info","time":"2023-10-07T22:33:48.34094354Z","caller":"syncer/metadatasyncer.go:432","msg":"CSI full sync failed with error: registration failed for volumeSpec: &{[D2_Tools_Artifactory_03] volumes/artifactory-member-1 }"}
        2023-10-07T22:33:48.342614644Z {"level":"info","time":"2023-10-07T22:33:48.342579871Z","caller":"volume/manager.go:508","msg":"CreateVolume: VolumeName: \"950952c4-6561-11ee-b9b6-005056a34ce4\", opId: \"05961a9e\"","TraceId":"36f40bb3-49a8-4386-a901-1a451bcdd689"}
        2023-10-07T22:33:48.342647687Z {"level":"info","time":"2023-10-07T22:33:48.342611262Z","caller":"volume/util.go:371","msg":"Extract vimfault type: +types.CnsFault  vimFault: +{<nil> Fault cause: vmodl.fault.InvalidArgument\n} Fault: &{DynamicData:{} Fault:{BaseMethodFault:<nil> Reason:Fault cause: vmodl.fault.InvalidArgument\n} LocalizedMessage:CnsFault error: Fault cause: vmodl.fault.InvalidArgument\n} from resp: +&{{} {{} } 0xc002037380}","TraceId":"36f40bb3-49a8-4386-a901-1a451bcdd689"}
        2023-10-07T22:33:48.342707751Z {"level":"error","time":"2023-10-07T22:33:48.342640672Z","caller":"volume/util.go:298","msg":"failed to create volume with fault: \"(*types.LocalizedMethodFault)(0xc002037380)({\\n DynamicData: (types.DynamicData) {\\n },\\n Fault: (types.CnsFault) {\\n  BaseMethodFault: (types.BaseMethodFault) <nil>,\\n  Reason: (string) (len=41) \\\"Fault cause: vmodl.fault.InvalidArgument\\\\n\\\"\\n },\\n LocalizedMessage: (string) (len=57) \\\"CnsFault error: Fault cause: vmodl.fault.InvalidArgument\\\\n\\\"\\n})\\n\"","TraceId":"36f40bb3-49a8-4386-a901-1a451bcdd689","stacktrace":"sigs.k8s.io/vsphere-csi-driver/v2/pkg/common/cns-lib/volume.validateCreateVolumeResponseFault\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/common/cns-lib/volume/util.go:298\nsigs.k8s.io/vsphere-csi-driver/v2/pkg/common/cns-lib/volume.(*defaultManager).createVolume\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/common/cns-lib/volume/manager.go:525\nsigs.k8s.io/vsphere-csi-driver/v2/pkg/common/cns-lib/volume.(*defaultManager).CreateVolume.func1\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/common/cns-lib/volume/manager.go:573\nsigs.k8s.io/vsphere-csi-driver/v2/pkg/common/cns-lib/volume.(*defaultManager).CreateVolume\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/common/cns-lib/volume/manager.go:576\nsigs.k8s.io/vsphere-csi-driver/v2/pkg/apis/migration.(*volumeMigration).registerVolume\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/apis/migration/migration.go:523\nsigs.k8s.io/vsphere-csi-driver/v2/pkg/apis/migration.(*volumeMigration).GetVolumeID\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/apis/migration/migration.go:218\nsigs.k8s.io/vsphere-csi-driver/v2/pkg/syncer.podAdded\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/syncer/metadatasyncer.go:958\nsigs.k8s.io/vsphere-csi-driver/v2/pkg/syncer.InitMetadataSyncer.func7\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/syncer/metadatasyncer.go:354\nk8s.io/client-go/tools/cache.ResourceEventHandlerFuncs.OnAdd\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/vendor/k8s.io/client-go/tools/cache/controller.go:232\nk8s.io/client-go/tools/cache.(*processorListener).run.func1\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/vendor/k8s.io/client-go/tools/cache/shared_informer.go:818\nk8s.io/apimachinery/pkg/util/wait.BackoffUntil.func1\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/vendor/k8s.io/apimachinery/pkg/util/wait/wait.go:157\nk8s.io/apimachinery/pkg/util/wait.BackoffUntil\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/vendor/k8s.io/apimachinery/pkg/util/wait/wait.go:158\nk8s.io/apimachinery/pkg/util/wait.JitterUntil\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/vendor/k8s.io/apimachinery/pkg/util/wait/wait.go:135\nk8s.io/apimachinery/pkg/util/wait.Until\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/vendor/k8s.io/apimachinery/pkg/util/wait/wait.go:92\nk8s.io/client-go/tools/cache.(*processorListener).run\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/vendor/k8s.io/client-go/tools/cache/shared_informer.go:812\nk8s.io/apimachinery/pkg/util/wait.(*Group).Start.func1\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/vendor/k8s.io/apimachinery/pkg/util/wait/wait.go:75"}
        2023-10-07T22:33:48.342882661Z {"level":"error","time":"2023-10-07T22:33:48.34277867Z","caller":"volume/manager.go:540","msg":"failed to create cns volume 950952c4-6561-11ee-b9b6-005056a34ce4. createSpec: \"(*types.CnsVolumeCreateSpec)(0xc004082000)({\\n DynamicData: (types.DynamicData) {\\n },\\n Name: (string) (len=36) \\\"950952c4-6561-11ee-b9b6-005056a34ce4\\\",\\n VolumeType: (string) (len=5) \\\"BLOCK\\\",\\n Datastores: ([]types.ManagedObjectReference) <nil>,\\n Metadata: (types.CnsVolumeMetadata) {\\n  DynamicData: (types.DynamicData) {\\n  },\\n  ContainerCluster: (types.CnsContainerCluster) {\\n   DynamicData: (types.DynamicData) {\\n   },\\n   ClusterType: (string) (len=10) \\\"KUBERNETES\\\",\\n   ClusterId: (string) (len=10) \\\"mgmt-7dg4z\\\",\\n   VSphereUser: (string) (len=20) \\\"AD\\\\\\\\ocp4prodadmin.svc\\\",\\n   ClusterFlavor: (string) (len=7) \\\"VANILLA\\\",\\n   ClusterDistribution: (string) \\\"\\\"\\n  },\\n  EntityMetadata: ([]types.BaseCnsEntityMetadata) <nil>,\\n  ContainerClusterArray: ([]types.CnsContainerCluster) (len=1 cap=1) {\\n   (types.CnsContainerCluster) {\\n    DynamicData: (types.DynamicData) {\\n    },\\n    ClusterType: (string) (len=10) \\\"KUBERNETES\\\",\\n    ClusterId: (string) (len=10) \\\"mgmt-7dg4z\\\",\\n    VSphereUser: (string) (len=17) \\\"ocp4prodadmin.svc\\\",\\n    ClusterFlavor: (string) (len=7) \\\"VANILLA\\\",\\n    ClusterDistribution: (string) \\\"\\\"\\n   }\\n  }\\n },\\n BackingObjectDetails: (*types.CnsBlockBackingDetails)(0xc00202d000)({\\n  CnsBackingObjectDetails: (types.CnsBackingObjectDetails) {\\n   DynamicData: (types.DynamicData) {\\n   },\\n   CapacityInMb: (int64) 0\\n  },\\n  BackingDiskId: (string) \\\"\\\",\\n  BackingDiskUrlPath: (string) (len=109) \\\"https://d2-ap-custvc.ad.sec.gov/folder/volumes/postgres?dcPath=D2-OpenShift-DC&dsName=D2_Tools_Artifactory_03\\\",\\n  BackingDiskObjectId: (string) \\\"\\\"\\n }),\\n Profile: ([]types.BaseVirtualMachineProfileSpec) <nil>,\\n CreateSpec: (types.BaseCnsBaseCreateSpec) <nil>,\\n VolumeSource: (types.BaseCnsVolumeSource) <nil>\\n})\\n\", fault: \"(*types.LocalizedMethodFault)(0xc002037380)({\\n DynamicData: (types.DynamicData) {\\n },\\n Fault: (types.CnsFault) {\\n  BaseMethodFault: (types.BaseMethodFault) <nil>,\\n  Reason: (string) (len=41) \\\"Fault cause: vmodl.fault.InvalidArgument\\\\n\\\"\\n },\\n LocalizedMessage: (string) (len=57) \\\"CnsFault error: Fault cause: vmodl.fault.InvalidArgument\\\\n\\\"\\n})\\n\"","TraceId":"36f40bb3-49a8-4386-a901-1a451bcdd689","stacktrace":"sigs.k8s.io/vsphere-csi-driver/v2/pkg/common/cns-lib/volume.(*defaultManager).createVolume\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/common/cns-lib/volume/manager.go:540\nsigs.k8s.io/vsphere-csi-driver/v2/pkg/common/cns-lib/volume.(*defaultManager).CreateVolume.func1\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/common/cns-lib/volume/manager.go:573\nsigs.k8s.io/vsphere-csi-driver/v2/pkg/common/cns-lib/volume.(*defaultManager).CreateVolume\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/common/cns-lib/volume/manager.go:576\nsigs.k8s.io/vsphere-csi-driver/v2/pkg/apis/migration.(*volumeMigration).registerVolume\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/apis/migration/migration.go:523\nsigs.k8s.io/vsphere-csi-driver/v2/pkg/apis/migration.(*volumeMigration).GetVolumeID\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/apis/migration/migration.go:218\nsigs.k8s.io/vsphere-csi-driver/v2/pkg/syncer.podAdded\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/syncer/metadatasyncer.go:958\nsigs.k8s.io/vsphere-csi-driver/v2/pkg/syncer.InitMetadataSyncer.func7\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/syncer/metadatasyncer.go:354\nk8s.io/client-go/tools/cache.ResourceEventHandlerFuncs.OnAdd\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/vendor/k8s.io/client-go/tools/cache/controller.go:232\nk8s.io/client-go/tools/cache.(*processorListener).run.func1\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/vendor/k8s.io/client-go/tools/cache/shared_informer.go:818\nk8s.io/apimachinery/pkg/util/wait.BackoffUntil.func1\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/vendor/k8s.io/apimachinery/pkg/util/wait/wait.go:157\nk8s.io/apimachinery/pkg/util/wait.BackoffUntil\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/vendor/k8s.io/apimachinery/pkg/util/wait/wait.go:158\nk8s.io/apimachinery/pkg/util/wait.JitterUntil\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/vendor/k8s.io/apimachinery/pkg/util/wait/wait.go:135\nk8s.io/apimachinery/pkg/util/wait.Until\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/vendor/k8s.io/apimachinery/pkg/util/wait/wait.go:92\nk8s.io/client-go/tools/cache.(*processorListener).run\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/vendor/k8s.io/client-go/tools/cache/shared_informer.go:812\nk8s.io/apimachinery/pkg/util/wait.(*Group).Start.func1\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/vendor/k8s.io/apimachinery/pkg/util/wait/wait.go:75"}
        2023-10-07T22:33:48.342925768Z {"level":"warn","time":"2023-10-07T22:33:48.34287662Z","caller":"migration/migration.go:525","msg":"failed to register volume \"[D2_Tools_Artifactory_03] volumes/postgres\" with createSpec: &{{} 950952c4-6561-11ee-b9b6-005056a34ce4 BLOCK [] {{} {{} KUBERNETES mgmt-7dg4z AD\\ocp4prodadmin.svc VANILLA } [] [{{} KUBERNETES mgmt-7dg4z ocp4prodadmin.svc VANILLA }]} 0xc00202d000 [] <nil> <nil>}. error: failed to create volume with fault: \"(*types.LocalizedMethodFault)(0xc002037380)({\\n DynamicData: (types.DynamicData) {\\n },\\n Fault: (types.CnsFault) {\\n  BaseMethodFault: (types.BaseMethodFault) <nil>,\\n  Reason: (string) (len=41) \\\"Fault cause: vmodl.fault.InvalidArgument\\\\n\\\"\\n },\\n LocalizedMessage: (string) (len=57) \\\"CnsFault error: Fault cause: vmodl.fault.InvalidArgument\\\\n\\\"\\n})\\n\"","TraceId":"36f40bb3-49a8-4386-a901-1a451bcdd689"}
        2023-10-07T22:33:48.342925768Z {"level":"error","time":"2023-10-07T22:33:48.342897208Z","caller":"migration/migration.go:535","msg":"registration failed for volumeSpec: &{[D2_Tools_Artifactory_03] volumes/postgres }","TraceId":"36f40bb3-49a8-4386-a901-1a451bcdd689","stacktrace":"sigs.k8s.io/vsphere-csi-driver/v2/pkg/apis/migration.(*volumeMigration).registerVolume\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/apis/migration/migration.go:535\nsigs.k8s.io/vsphere-csi-driver/v2/pkg/apis/migration.(*volumeMigration).GetVolumeID\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/apis/migration/migration.go:218\nsigs.k8s.io/vsphere-csi-driver/v2/pkg/syncer.podAdded\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/syncer/metadatasyncer.go:958\nsigs.k8s.io/vsphere-csi-driver/v2/pkg/syncer.InitMetadataSyncer.func7\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/syncer/metadatasyncer.go:354\nk8s.io/client-go/tools/cache.ResourceEventHandlerFuncs.OnAdd\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/vendor/k8s.io/client-go/tools/cache/controller.go:232\nk8s.io/client-go/tools/cache.(*processorListener).run.func1\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/vendor/k8s.io/client-go/tools/cache/shared_informer.go:818\nk8s.io/apimachinery/pkg/util/wait.BackoffUntil.func1\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/vendor/k8s.io/apimachinery/pkg/util/wait/wait.go:157\nk8s.io/apimachinery/pkg/util/wait.BackoffUntil\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/vendor/k8s.io/apimachinery/pkg/util/wait/wait.go:158\nk8s.io/apimachinery/pkg/util/wait.JitterUntil\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/vendor/k8s.io/apimachinery/pkg/util/wait/wait.go:135\nk8s.io/apimachinery/pkg/util/wait.Until\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/vendor/k8s.io/apimachinery/pkg/util/wait/wait.go:92\nk8s.io/client-go/tools/cache.(*processorListener).run\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/vendor/k8s.io/client-go/tools/cache/shared_informer.go:812\nk8s.io/apimachinery/pkg/util/wait.(*Group).Start.func1\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/vendor/k8s.io/apimachinery/pkg/util/wait/wait.go:75"}
        2023-10-07T22:33:48.342954779Z {"level":"error","time":"2023-10-07T22:33:48.342926972Z","caller":"migration/migration.go:220","msg":"failed to register volume for volumeSpec: &{[D2_Tools_Artifactory_03] volumes/postgres }, with err: registration failed for volumeSpec: &{[D2_Tools_Artifactory_03] volumes/postgres }","TraceId":"36f40bb3-49a8-4386-a901-1a451bcdd689","stacktrace":"sigs.k8s.io/vsphere-csi-driver/v2/pkg/apis/migration.(*volumeMigration).GetVolumeID\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/apis/migration/migration.go:220\nsigs.k8s.io/vsphere-csi-driver/v2/pkg/syncer.podAdded\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/syncer/metadatasyncer.go:958\nsigs.k8s.io/vsphere-csi-driver/v2/pkg/syncer.InitMetadataSyncer.func7\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/syncer/metadatasyncer.go:354\nk8s.io/client-go/tools/cache.ResourceEventHandlerFuncs.OnAdd\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/vendor/k8s.io/client-go/tools/cache/controller.go:232\nk8s.io/client-go/tools/cache.(*processorListener).run.func1\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/vendor/k8s.io/client-go/tools/cache/shared_informer.go:818\nk8s.io/apimachinery/pkg/util/wait.BackoffUntil.func1\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/vendor/k8s.io/apimachinery/pkg/util/wait/wait.go:157\nk8s.io/apimachinery/pkg/util/wait.BackoffUntil\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/vendor/k8s.io/apimachinery/pkg/util/wait/wait.go:158\nk8s.io/apimachinery/pkg/util/wait.JitterUntil\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/vendor/k8s.io/apimachinery/pkg/util/wait/wait.go:135\nk8s.io/apimachinery/pkg/util/wait.Until\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/vendor/k8s.io/apimachinery/pkg/util/wait/wait.go:92\nk8s.io/client-go/tools/cache.(*processorListener).run\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/vendor/k8s.io/client-go/tools/cache/shared_informer.go:812\nk8s.io/apimachinery/pkg/util/wait.(*Group).Start.func1\n\t/go/src/github.com/kubernetes-sigs/vsphere-csi-driver/vendor/k8s.io/apimachinery/pkg/util/wait/wait.go:75"}
        2023-10-07T22:33:48.343055959Z E1007 22:33:48.343021       1 runtime.go:79] Observed a panic: "invalid memory address or nil pointer dereference" (runtime error: invalid memory address or nil pointer dereference)
        2023-10-07T22:33:48.343055959Z goroutine 166 [running]:
        2023-10-07T22:33:48.343055959Z k8s.io/apimachinery/pkg/util/runtime.logPanic({0x1ecf920?, 0x3a77a20})
        2023-10-07T22:33:48.343055959Z     /go/src/github.com/kubernetes-sigs/vsphere-csi-driver/vendor/k8s.io/apimachinery/pkg/util/runtime/runtime.go:75 +0x99
        2023-10-07T22:33:48.343055959Z k8s.io/apimachinery/pkg/util/runtime.HandleCrash({0x0, 0x0, 0x2c81738?})
        2023-10-07T22:33:48.343055959Z     /go/src/github.com/kubernetes-sigs/vsphere-csi-driver/vendor/k8s.io/apimachinery/pkg/util/runtime/runtime.go:49 +0x75
        2023-10-07T22:33:48.343055959Z panic({0x1ecf920, 0x3a77a20})
        2023-10-07T22:33:48.343055959Z     /usr/lib/golang/src/runtime/panic.go:884 +0x212
        2023-10-07T22:33:48.343055959Z sigs.k8s.io/vsphere-csi-driver/v2/pkg/syncer.podAdded({0x23000e0?, 0xc0021b5f48}, 0xc0002ea1e0)
        2023-10-07T22:33:48.343055959Z     /go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/syncer/metadatasyncer.go:963 +0x885
        2023-10-07T22:33:48.343055959Z sigs.k8s.io/vsphere-csi-driver/v2/pkg/syncer.InitMetadataSyncer.func7({0x23000e0?, 0xc0021b5f48?})
        2023-10-07T22:33:48.343055959Z     /go/src/github.com/kubernetes-sigs/vsphere-csi-driver/pkg/syncer/metadatasyncer.go:354 +0x27
        2023-10-07T22:33:48.343055959Z k8s.io/client-go/tools/cache.ResourceEventHandlerFuncs.OnAdd(...)
        2023-10-07T22:33:48.343055959Z     /go/src/github.com/kubernetes-sigs/vsphere-csi-driver/vendor/k8s.io/client-go/tools/cache/controller.go:232
        2023-10-07T22:33:48.343055959Z k8s.io/client-go/tools/cache.(*processorListener).run.func1()
        2023-10-07T22:33:48.343055959Z     /go/src/github.com/kubernetes-sigs/vsphere-csi-driver/vendor/k8s.io/client-go/tools/cache/shared_informer.go:818 +0x134
        ...
        2023-10-07T22:33:48.343055959Z created by k8s.io/apimachinery/pkg/util/wait.(*Group).Start
        2023-10-07T22:33:48.343055959Z     /go/src/github.com/kubernetes-sigs/vsphere-csi-driver/vendor/k8s.io/apimachinery/pkg/util/wait/wait.go:73 +0x85
        2023-10-07T22:33:48.345196271Z panic: runtime error: invalid memory address or nil pointer dereference [recovered]
        2023-10-07T22:33:48.345196271Z     panic: runtime error: invalid memory address or nil pointer dereference
        2023-10-07T22:33:48.345196271Z [signal SIGSEGV: segmentation violation code=0x1 addr=0x8 pc=0x1b3c7c5]
        2023-10-07T22:33:48.345229208Z 
        2023-10-07T22:33:48.345229208Z goroutine 166 [running]:
        2023-10-07T22:33:48.345229208Z k8s.io/apimachinery/pkg/util/runtime.HandleCrash({0x0, 0x0, 0x2c81738?})
        2023-10-07T22:33:48.345229208Z     /go/src/github.com/kubernetes-sigs/vsphere-csi-driver/vendor/k8s.io/apimachinery/pkg/util/runtime/runtime.go:56 +0xd7
        2023-10-07T22:33:48.345229208Z panic({0x1ecf920, 0x3a77a20})
        2023-10-07T22:33:48.345248171Z     /usr/lib/golang/src/runtime/panic.go:884 +0x212
      • Could I kindly ask for additional troubleshooting steps to investigate the potential bug? Please inform me if you require any more information.

      Attachments

        Issue Links

          Activity

            People

              jdobson@redhat.com Jonathan Dobson
              rhn-support-jaykim Jihoon Kim
              Wei Duan Wei Duan
              Votes:
              0 Vote for this issue
              Watchers:
              11 Start watching this issue

              Dates

                Created:
                Updated:
                Resolved: