When i created a pvc in a zone(zone-a) which has two datastores, the pv created faild. But i used another zone(zone-b) which has only single datastore, pv can be created successfully.
The log of vsphere-csi-controller is in the following:
I0108 17:26:11.574537 1 config.go:265] GetCnsconfig called with cfgPath: /etc/cloud/csi-vsphere.conf
I0108 17:26:11.574769 1 config.go:209] Initializing vc server 100.2.51.14
I0108 17:26:11.574777 1 controller.go:66] Initializing CNS controller
I0108 17:26:11.574799 1 virtualcentermanager.go:61] Initializing defaultVirtualCenterManager...
I0108 17:26:11.574804 1 virtualcentermanager.go:63] Successfully initialized defaultVirtualCenterManager
I0108 17:26:11.574812 1 virtualcentermanager.go:105] Successfully registered VC "100.2.51.14"
I0108 17:26:11.574822 1 manager.go:55] Initializing volume.defaultManager...
I0108 17:26:11.574826 1 manager.go:59] volume.defaultManager initialized
I0108 17:26:11.788643 1 virtualcenter.go:130] New session ID for 'VSPHERE.LOCAL\Administrator' = 52040b65-a46d-c864-42db-6093c39b8ab2
I0108 17:26:11.788926 1 manager.go:71] Initializing node.defaultManager...
I0108 17:26:11.788987 1 manager.go:75] node.defaultManager initialized
I0108 17:26:11.789014 1 kubernetes.go:34] k8s client using in-cluster config
time="2020-01-08T17:26:11Z" level=info msg="configured: csi.vsphere.vmware.com" controllerType=VANILLA mode=controller
time="2020-01-08T17:26:11Z" level=info msg="identity service registered"
time="2020-01-08T17:26:11Z" level=info msg="controller service registered"
time="2020-01-08T17:26:11Z" level=info msg=serving endpoint="unix:///var/lib/csi/sockets/pluginproxy/csi.sock"
I0108 17:26:11.793208 1 reflector.go:123] Starting reflector *v1.Node (0s) from pkg/mod/k8s.io/[email protected]+incompatible/tools/cache/reflector.go:94
I0108 17:26:11.793353 1 reflector.go:161] Listing and watching *v1.Node from pkg/mod/k8s.io/[email protected]+incompatible/tools/cache/reflector.go:94
I0108 17:26:11.804130 1 manager.go:98] Successfully registered node: "k8s-master-zhj" with nodeUUID "421C972B-903B-101C-84AE-D291AB325231"
I0108 17:26:11.804149 1 virtualmachine.go:124] Initiating asynchronous datacenter listing with uuid 421C972B-903B-101C-84AE-D291AB325231
I0108 17:26:11.893251 1 datacenter.go:146] Publishing datacenter Datacenter [Datacenter: Datacenter:datacenter-2 @ /Datacenter, VirtualCenterHost: 100.2.51.14]
I0108 17:26:11.893310 1 virtualmachine.go:140] AsyncGetAllDatacenters finished with uuid 421C972B-903B-101C-84AE-D291AB325231
I0108 17:26:11.893375 1 virtualmachine.go:161] AsyncGetAllDatacenters with uuid 421C972B-903B-101C-84AE-D291AB325231 sent a dc Datacenter [Datacenter: Datacenter:datacenter-2 @ /Datacenter, VirtualCenterHost: 100.2.51.14]
I0108 17:26:11.893757 1 virtualmachine.go:140] AsyncGetAllDatacenters finished with uuid 421C972B-903B-101C-84AE-D291AB325231
I0108 17:26:11.893791 1 virtualmachine.go:140] AsyncGetAllDatacenters finished with uuid 421C972B-903B-101C-84AE-D291AB325231
I0108 17:26:11.893851 1 virtualmachine.go:156] AsyncGetAllDatacenters finished with uuid 421C972B-903B-101C-84AE-D291AB325231
I0108 17:26:11.893862 1 virtualmachine.go:156] AsyncGetAllDatacenters finished with uuid 421C972B-903B-101C-84AE-D291AB325231
I0108 17:26:11.893867 1 virtualmachine.go:156] AsyncGetAllDatacenters finished with uuid 421C972B-903B-101C-84AE-D291AB325231
I0108 17:26:11.893872 1 virtualmachine.go:156] AsyncGetAllDatacenters finished with uuid 421C972B-903B-101C-84AE-D291AB325231
I0108 17:26:11.925708 1 virtualmachine.go:176] Found VM VirtualMachine:vm-79 [VirtualCenterHost: 100.2.51.14, UUID: 421c972b-903b-101c-84ae-d291ab325231, Datacenter: Datacenter [Datacenter: Datacenter:datacenter-2 @ /Datacenter, VirtualCenterHost: 100.2.51.14]] given uuid 421C972B-903B-101C-84AE-D291AB325231 on DC Datacenter [Datacenter: Datacenter:datacenter-2 @ /Datacenter, VirtualCenterHost: 100.2.51.14], canceling context
I0108 17:26:11.925764 1 virtualmachine.go:188] Returning VM VirtualMachine:vm-79 [VirtualCenterHost: 100.2.51.14, UUID: 421c972b-903b-101c-84ae-d291ab325231, Datacenter: Datacenter [Datacenter: Datacenter:datacenter-2 @ /Datacenter, VirtualCenterHost: 100.2.51.14]] for UUID 421C972B-903B-101C-84AE-D291AB325231
I0108 17:26:11.925824 1 manager.go:117] Successfully discovered node with nodeUUID 421C972B-903B-101C-84AE-D291AB325231 in vm VirtualMachine:vm-79 [VirtualCenterHost: 100.2.51.14, UUID: 421c972b-903b-101c-84ae-d291ab325231, Datacenter: Datacenter [Datacenter: Datacenter:datacenter-2 @ /Datacenter, VirtualCenterHost: 100.2.51.14]]
I0108 17:26:11.925839 1 manager.go:104] Successfully discovered node: "k8s-master-zhj" with nodeUUID "421C972B-903B-101C-84AE-D291AB325231"
I0108 17:26:11.925850 1 manager.go:98] Successfully registered node: "k8s-node1-zhj" with nodeUUID "421C056B-782D-E3FD-758B-9109ABDB9162"
I0108 17:26:11.925860 1 virtualmachine.go:124] Initiating asynchronous datacenter listing with uuid 421C056B-782D-E3FD-758B-9109ABDB9162
I0108 17:26:12.023746 1 datacenter.go:146] Publishing datacenter Datacenter [Datacenter: Datacenter:datacenter-2 @ /Datacenter, VirtualCenterHost: 100.2.51.14]
I0108 17:26:12.027570 1 virtualmachine.go:140] AsyncGetAllDatacenters finished with uuid 421C056B-782D-E3FD-758B-9109ABDB9162
I0108 17:26:12.027628 1 virtualmachine.go:161] AsyncGetAllDatacenters with uuid 421C056B-782D-E3FD-758B-9109ABDB9162 sent a dc Datacenter [Datacenter: Datacenter:datacenter-2 @ /Datacenter, VirtualCenterHost: 100.2.51.14]
I0108 17:26:12.027859 1 virtualmachine.go:156] AsyncGetAllDatacenters finished with uuid 421C056B-782D-E3FD-758B-9109ABDB9162
I0108 17:26:12.027873 1 virtualmachine.go:140] AsyncGetAllDatacenters finished with uuid 421C056B-782D-E3FD-758B-9109ABDB9162
I0108 17:26:12.027882 1 virtualmachine.go:156] AsyncGetAllDatacenters finished with uuid 421C056B-782D-E3FD-758B-9109ABDB9162
I0108 17:26:12.027892 1 virtualmachine.go:156] AsyncGetAllDatacenters finished with uuid 421C056B-782D-E3FD-758B-9109ABDB9162
I0108 17:26:12.027902 1 virtualmachine.go:140] AsyncGetAllDatacenters finished with uuid 421C056B-782D-E3FD-758B-9109ABDB9162
I0108 17:26:12.027911 1 virtualmachine.go:156] AsyncGetAllDatacenters finished with uuid 421C056B-782D-E3FD-758B-9109ABDB9162
I0108 17:26:12.059761 1 virtualmachine.go:176] Found VM VirtualMachine:vm-83 [VirtualCenterHost: 100.2.51.14, UUID: 421c056b-782d-e3fd-758b-9109abdb9162, Datacenter: Datacenter [Datacenter: Datacenter:datacenter-2 @ /Datacenter, VirtualCenterHost: 100.2.51.14]] given uuid 421C056B-782D-E3FD-758B-9109ABDB9162 on DC Datacenter [Datacenter: Datacenter:datacenter-2 @ /Datacenter, VirtualCenterHost: 100.2.51.14], canceling context
I0108 17:26:12.059796 1 virtualmachine.go:188] Returning VM VirtualMachine:vm-83 [VirtualCenterHost: 100.2.51.14, UUID: 421c056b-782d-e3fd-758b-9109abdb9162, Datacenter: Datacenter [Datacenter: Datacenter:datacenter-2 @ /Datacenter, VirtualCenterHost: 100.2.51.14]] for UUID 421C056B-782D-E3FD-758B-9109ABDB9162
I0108 17:26:12.059810 1 manager.go:117] Successfully discovered node with nodeUUID 421C056B-782D-E3FD-758B-9109ABDB9162 in vm VirtualMachine:vm-83 [VirtualCenterHost: 100.2.51.14, UUID: 421c056b-782d-e3fd-758b-9109abdb9162, Datacenter: Datacenter [Datacenter: Datacenter:datacenter-2 @ /Datacenter, VirtualCenterHost: 100.2.51.14]]
I0108 17:26:12.059829 1 manager.go:104] Successfully discovered node: "k8s-node1-zhj" with nodeUUID "421C056B-782D-E3FD-758B-9109ABDB9162"
I0108 17:26:12.060261 1 manager.go:98] Successfully registered node: "k8s-node2-zhj" with nodeUUID "421CC765-4F58-5A4B-39DB-2C63908366B0"
I0108 17:26:12.060275 1 virtualmachine.go:124] Initiating asynchronous datacenter listing with uuid 421CC765-4F58-5A4B-39DB-2C63908366B0
I0108 17:26:12.098502 1 controller.go:350] ControllerGetCapabilities: called with args {XXX_NoUnkeyedLiteral:{} XXX_unrecognized:[] XXX_sizecache:0}
I0108 17:26:12.154967 1 datacenter.go:146] Publishing datacenter Datacenter [Datacenter: Datacenter:datacenter-2 @ /Datacenter, VirtualCenterHost: 100.2.51.14]
I0108 17:26:12.155057 1 virtualmachine.go:156] AsyncGetAllDatacenters finished with uuid 421CC765-4F58-5A4B-39DB-2C63908366B0
I0108 17:26:12.155073 1 virtualmachine.go:161] AsyncGetAllDatacenters with uuid 421CC765-4F58-5A4B-39DB-2C63908366B0 sent a dc Datacenter [Datacenter: Datacenter:datacenter-2 @ /Datacenter, VirtualCenterHost: 100.2.51.14]
I0108 17:26:12.155094 1 virtualmachine.go:156] AsyncGetAllDatacenters finished with uuid 421CC765-4F58-5A4B-39DB-2C63908366B0
I0108 17:26:12.155119 1 virtualmachine.go:156] AsyncGetAllDatacenters finished with uuid 421CC765-4F58-5A4B-39DB-2C63908366B0
I0108 17:26:12.155164 1 virtualmachine.go:140] AsyncGetAllDatacenters finished with uuid 421CC765-4F58-5A4B-39DB-2C63908366B0
I0108 17:26:12.155178 1 virtualmachine.go:156] AsyncGetAllDatacenters finished with uuid 421CC765-4F58-5A4B-39DB-2C63908366B0
I0108 17:26:12.155188 1 virtualmachine.go:156] AsyncGetAllDatacenters finished with uuid 421CC765-4F58-5A4B-39DB-2C63908366B0
I0108 17:26:12.155197 1 virtualmachine.go:156] AsyncGetAllDatacenters finished with uuid 421CC765-4F58-5A4B-39DB-2C63908366B0
I0108 17:26:12.186242 1 virtualmachine.go:176] Found VM VirtualMachine:vm-82 [VirtualCenterHost: 100.2.51.14, UUID: 421cc765-4f58-5a4b-39db-2c63908366b0, Datacenter: Datacenter [Datacenter: Datacenter:datacenter-2 @ /Datacenter, VirtualCenterHost: 100.2.51.14]] given uuid 421CC765-4F58-5A4B-39DB-2C63908366B0 on DC Datacenter [Datacenter: Datacenter:datacenter-2 @ /Datacenter, VirtualCenterHost: 100.2.51.14], canceling context
I0108 17:26:12.186275 1 virtualmachine.go:188] Returning VM VirtualMachine:vm-82 [VirtualCenterHost: 100.2.51.14, UUID: 421cc765-4f58-5a4b-39db-2c63908366b0, Datacenter: Datacenter [Datacenter: Datacenter:datacenter-2 @ /Datacenter, VirtualCenterHost: 100.2.51.14]] for UUID 421CC765-4F58-5A4B-39DB-2C63908366B0
I0108 17:26:12.186287 1 manager.go:117] Successfully discovered node with nodeUUID 421CC765-4F58-5A4B-39DB-2C63908366B0 in vm VirtualMachine:vm-82 [VirtualCenterHost: 100.2.51.14, UUID: 421cc765-4f58-5a4b-39db-2c63908366b0, Datacenter: Datacenter [Datacenter: Datacenter:datacenter-2 @ /Datacenter, VirtualCenterHost: 100.2.51.14]]
I0108 17:26:12.186298 1 manager.go:104] Successfully discovered node: "k8s-node2-zhj" with nodeUUID "421CC765-4F58-5A4B-39DB-2C63908366B0"
I0108 17:26:12.270352 1 controller.go:350] ControllerGetCapabilities: called with args {XXX_NoUnkeyedLiteral:{} XXX_unrecognized:[] XXX_sizecache:0}
I0108 17:34:12.804690 1 reflector.go:370] pkg/mod/k8s.io/[email protected]+incompatible/tools/cache/reflector.go:94: Watch close - *v1.Node total 26 items received
I0108 17:40:03.944951 1 controller.go:113] CreateVolume: called with args {Name:pvc-53813478-1248-4e0a-a134-250e240b6dbf CapacityRange:required_bytes:10737418240 VolumeCapabilities:[mount:<fs_type:"ext4" > access_mode:<mode:SINGLE_NODE_WRITER > ] Parameters:map[] Secrets:map[] VolumeContentSource: AccessibilityRequirements:requisite:<segments:<key:"failure-domain.beta.kubernetes.io/region" value:"region-1" > segments:<key:"failure-domain.beta.kubernetes.io/zone" value:"zone-a" > > preferred:<segments:<key:"failure-domain.beta.kubernetes.io/region" value:"region-1" > segments:<key:"failure-domain.beta.kubernetes.io/zone" value:"zone-a" > > XXX_NoUnkeyedLiteral:{} XXX_unrecognized:[] XXX_sizecache:0}
I0108 17:40:03.946435 1 nodes.go:105] GetSharedDatastoresInTopology: called with topologyRequirement: requisite:<segments:<key:"failure-domain.beta.kubernetes.io/region" value:"region-1" > segments:<key:"failure-domain.beta.kubernetes.io/zone" value:"zone-a" > > preferred:<segments:<key:"failure-domain.beta.kubernetes.io/region" value:"region-1" > segments:<key:"failure-domain.beta.kubernetes.io/zone" value:"zone-a" > > , zoneCategoryName: k8s-zone, regionCategoryName: k8s-region
I0108 17:40:03.946473 1 manager.go:217] Renewing VM VirtualMachine:vm-82 [VirtualCenterHost: 100.2.51.14, UUID: 421cc765-4f58-5a4b-39db-2c63908366b0, Datacenter: Datacenter [Datacenter: Datacenter:datacenter-2 @ /Datacenter, VirtualCenterHost: 100.2.51.14]] with new connection: nodeUUID 421CC765-4F58-5A4B-39DB-2C63908366B0
I0108 17:40:04.188345 1 manager.go:227] Updated VM VirtualMachine:vm-82 [VirtualCenterHost: 100.2.51.14, UUID: 421cc765-4f58-5a4b-39db-2c63908366b0, Datacenter: Datacenter [Datacenter: Datacenter:datacenter-2, VirtualCenterHost: 100.2.51.14]] for node with nodeUUID 421CC765-4F58-5A4B-39DB-2C63908366B0
I0108 17:40:04.188421 1 manager.go:214] Renewing VM VirtualMachine:vm-79 [VirtualCenterHost: 100.2.51.14, UUID: 421c972b-903b-101c-84ae-d291ab325231, Datacenter: Datacenter [Datacenter: Datacenter:datacenter-2 @ /Datacenter, VirtualCenterHost: 100.2.51.14]], no new connection needed: nodeUUID 421C972B-903B-101C-84AE-D291AB325231
I0108 17:40:04.188495 1 manager.go:227] Updated VM VirtualMachine:vm-79 [VirtualCenterHost: 100.2.51.14, UUID: 421c972b-903b-101c-84ae-d291ab325231, Datacenter: Datacenter [Datacenter: Datacenter:datacenter-2, VirtualCenterHost: 100.2.51.14]] for node with nodeUUID 421C972B-903B-101C-84AE-D291AB325231
I0108 17:40:04.188531 1 manager.go:214] Renewing VM VirtualMachine:vm-83 [VirtualCenterHost: 100.2.51.14, UUID: 421c056b-782d-e3fd-758b-9109abdb9162, Datacenter: Datacenter [Datacenter: Datacenter:datacenter-2 @ /Datacenter, VirtualCenterHost: 100.2.51.14]], no new connection needed: nodeUUID 421C056B-782D-E3FD-758B-9109ABDB9162
I0108 17:40:04.188567 1 manager.go:227] Updated VM VirtualMachine:vm-83 [VirtualCenterHost: 100.2.51.14, UUID: 421c056b-782d-e3fd-758b-9109abdb9162, Datacenter: Datacenter [Datacenter: Datacenter:datacenter-2, VirtualCenterHost: 100.2.51.14]] for node with nodeUUID 421C056B-782D-E3FD-758B-9109ABDB9162
I0108 17:40:04.188612 1 nodes.go:175] Using preferred topology
I0108 17:40:04.188653 1 nodes.go:137] getSharedDatastoresInTopology: called with topologyArr: [segments:<key:"failure-domain.beta.kubernetes.io/region" value:"region-1" > segments:<key:"failure-domain.beta.kubernetes.io/zone" value:"zone-a" > ]
I0108 17:40:04.188723 1 nodes.go:144] Getting list of nodeVMs for zone [zone-a] and region [region-1]
I0108 17:40:04.188741 1 nodes.go:119] getNodesInZoneRegion: called with zoneValue: zone-a, regionValue: region-1
I0108 17:40:04.188792 1 virtualmachine.go:324] IsInZoneRegion: called with zoneCategoryName: k8s-zone, regionCategoryName: k8s-region, zoneValue: zone-a, regionValue: region-1
I0108 17:40:04.188868 1 virtualmachine.go:230] Using plain text username and password
I0108 17:40:04.590415 1 virtualmachine.go:269] GetZoneRegion: called with zoneCategoryName: k8s-zone, regionCategoryName: k8s-region
I0108 17:40:04.590548 1 virtualmachine.go:230] Using plain text username and password
I0108 17:40:05.134616 1 virtualmachine.go:212] Host owning node vm: VirtualMachine:vm-82 [VirtualCenterHost: 100.2.51.14, UUID: 421cc765-4f58-5a4b-39db-2c63908366b0, Datacenter: Datacenter [Datacenter: Datacenter:datacenter-2, VirtualCenterHost: 100.2.51.14]] is 100.2.51.13
I0108 17:40:05.179237 1 virtualmachine.go:263] Ancestors of node vm: VirtualMachine:vm-82 [VirtualCenterHost: 100.2.51.14, UUID: 421cc765-4f58-5a4b-39db-2c63908366b0, Datacenter: Datacenter [Datacenter: Datacenter:datacenter-2, VirtualCenterHost: 100.2.51.14]] are : [[{ExtensibleManagedObject:{Self:Folder:group-d1 Value:[] AvailableField:[]} Parent: CustomValue:[] OverallStatus: ConfigStatus: ConfigIssue:[] EffectiveRole:[] Permission:[] Name:Datacenters DisabledMethod:[] RecentTask:[] DeclaredAlarmState:[] TriggeredAlarmState:[] AlarmActionsEnabled: Tag:[]} {ExtensibleManagedObject:{Self:Datacenter:datacenter-2 Value:[] AvailableField:[]} Parent:Folder:group-d1 CustomValue:[] OverallStatus: ConfigStatus: ConfigIssue:[] EffectiveRole:[] Permission:[] Name:Datacenter DisabledMethod:[] RecentTask:[] DeclaredAlarmState:[] TriggeredAlarmState:[] AlarmActionsEnabled: Tag:[]} {ExtensibleManagedObject:{Self:Folder:group-h4 Value:[] AvailableField:[]} Parent:Datacenter:datacenter-2 CustomValue:[] OverallStatus: ConfigStatus: ConfigIssue:[] EffectiveRole:[] Permission:[] Name:host DisabledMethod:[] RecentTask:[] DeclaredAlarmState:[] TriggeredAlarmState:[] AlarmActionsEnabled: Tag:[]} {ExtensibleManagedObject:{Self:ClusterComputeResource:domain-c86 Value:[] AvailableField:[]} Parent:Folder:group-h4 CustomValue:[] OverallStatus: ConfigStatus: ConfigIssue:[] EffectiveRole:[] Permission:[] Name:cluster2 DisabledMethod:[] RecentTask:[] DeclaredAlarmState:[] TriggeredAlarmState:[] AlarmActionsEnabled: Tag:[]} {ExtensibleManagedObject:{Self:HostSystem:host-14 Value:[] AvailableField:[]} Parent:ClusterComputeResource:domain-c86 CustomValue:[] OverallStatus: ConfigStatus: ConfigIssue:[] EffectiveRole:[] Permission:[] Name:100.2.51.13 DisabledMethod:[] RecentTask:[] DeclaredAlarmState:[] TriggeredAlarmState:[] AlarmActionsEnabled: Tag:[]}]]
I0108 17:40:05.179317 1 virtualmachine.go:285] Name: host-14, Type: HostSystem
I0108 17:40:05.473059 1 virtualmachine.go:285] Name: domain-c86, Type: ClusterComputeResource
I0108 17:40:05.729980 1 virtualmachine.go:292] Object [{{ClusterComputeResource:domain-c86 [] []} Folder:group-h4 [] [] [] [] cluster2 [] [] [] [] []}] has attached Tags [[urn:vmomi:InventoryServiceTag:c73d04ac-d8d7-4676-a476-c79288c8dfc4:GLOBAL]]
I0108 17:40:05.897122 1 virtualmachine.go:300] Found tag: zone-b for object {{ClusterComputeResource:domain-c86 [] []} Folder:group-h4 [] [] [] [] cluster2 [] [] [] [] []}
I0108 17:40:05.942668 1 virtualmachine.go:306] Found category: k8s-zone for object {{ClusterComputeResource:domain-c86 [] []} Folder:group-h4 [] [] [] [] cluster2 [] [] [] [] []} with tag: zone-b
I0108 17:40:05.942689 1 virtualmachine.go:285] Name: group-h4, Type: Folder
I0108 17:40:06.143389 1 virtualmachine.go:285] Name: datacenter-2, Type: Datacenter
I0108 17:40:06.219155 1 virtualmachine.go:292] Object [{{Datacenter:datacenter-2 [] []} Folder:group-d1 [] [] [] [] Datacenter [] [] [] [] []}] has attached Tags [[urn:vmomi:InventoryServiceTag:cbe20733-aed0-4561-b6e5-1fc22e4c1dd3:GLOBAL]]
I0108 17:40:06.393739 1 virtualmachine.go:300] Found tag: region-1 for object {{Datacenter:datacenter-2 [] []} Folder:group-d1 [] [] [] [] Datacenter [] [] [] [] []}
I0108 17:40:06.438611 1 virtualmachine.go:306] Found category: k8s-region for object {{Datacenter:datacenter-2 [] []} Folder:group-d1 [] [] [] [] Datacenter [] [] [] [] []} with tag: region-1
I0108 17:40:06.667479 1 virtualmachine.go:324] IsInZoneRegion: called with zoneCategoryName: k8s-zone, regionCategoryName: k8s-region, zoneValue: zone-a, regionValue: region-1
I0108 17:40:06.667613 1 virtualmachine.go:230] Using plain text username and password
I0108 17:40:07.049321 1 virtualmachine.go:269] GetZoneRegion: called with zoneCategoryName: k8s-zone, regionCategoryName: k8s-region
I0108 17:40:07.049420 1 virtualmachine.go:230] Using plain text username and password
I0108 17:40:07.638535 1 virtualmachine.go:212] Host owning node vm: VirtualMachine:vm-79 [VirtualCenterHost: 100.2.51.14, UUID: 421c972b-903b-101c-84ae-d291ab325231, Datacenter: Datacenter [Datacenter: Datacenter:datacenter-2, VirtualCenterHost: 100.2.51.14]] is 100.2.126.24
I0108 17:40:07.686361 1 virtualmachine.go:263] Ancestors of node vm: VirtualMachine:vm-79 [VirtualCenterHost: 100.2.51.14, UUID: 421c972b-903b-101c-84ae-d291ab325231, Datacenter: Datacenter [Datacenter: Datacenter:datacenter-2, VirtualCenterHost: 100.2.51.14]] are : [[{ExtensibleManagedObject:{Self:Folder:group-d1 Value:[] AvailableField:[]} Parent: CustomValue:[] OverallStatus: ConfigStatus: ConfigIssue:[] EffectiveRole:[] Permission:[] Name:Datacenters DisabledMethod:[] RecentTask:[] DeclaredAlarmState:[] TriggeredAlarmState:[] AlarmActionsEnabled: Tag:[]} {ExtensibleManagedObject:{Self:Datacenter:datacenter-2 Value:[] AvailableField:[]} Parent:Folder:group-d1 CustomValue:[] OverallStatus: ConfigStatus: ConfigIssue:[] EffectiveRole:[] Permission:[] Name:Datacenter DisabledMethod:[] RecentTask:[] DeclaredAlarmState:[] TriggeredAlarmState:[] AlarmActionsEnabled: Tag:[]} {ExtensibleManagedObject:{Self:Folder:group-h4 Value:[] AvailableField:[]} Parent:Datacenter:datacenter-2 CustomValue:[] OverallStatus: ConfigStatus: ConfigIssue:[] EffectiveRole:[] Permission:[] Name:host DisabledMethod:[] RecentTask:[] DeclaredAlarmState:[] TriggeredAlarmState:[] AlarmActionsEnabled: Tag:[]} {ExtensibleManagedObject:{Self:ClusterComputeResource:domain-c69 Value:[] AvailableField:[]} Parent:Folder:group-h4 CustomValue:[] OverallStatus: ConfigStatus: ConfigIssue:[] EffectiveRole:[] Permission:[] Name:cluster1 DisabledMethod:[] RecentTask:[] DeclaredAlarmState:[] TriggeredAlarmState:[] AlarmActionsEnabled: Tag:[]} {ExtensibleManagedObject:{Self:HostSystem:host-39 Value:[] AvailableField:[]} Parent:ClusterComputeResource:domain-c69 CustomValue:[] OverallStatus: ConfigStatus: ConfigIssue:[] EffectiveRole:[] Permission:[] Name:100.2.126.24 DisabledMethod:[] RecentTask:[] DeclaredAlarmState:[] TriggeredAlarmState:[] AlarmActionsEnabled: Tag:[]}]]
I0108 17:40:07.686545 1 virtualmachine.go:285] Name: host-39, Type: HostSystem
I0108 17:40:07.936444 1 virtualmachine.go:285] Name: domain-c69, Type: ClusterComputeResource
I0108 17:40:08.171643 1 virtualmachine.go:292] Object [{{ClusterComputeResource:domain-c69 [] []} Folder:group-h4 [] [] [] [] cluster1 [] [] [] [] []}] has attached Tags [[urn:vmomi:InventoryServiceTag:34d348cf-82a5-4b62-8faa-c0bb5128f9e1:GLOBAL]]
I0108 17:40:08.378222 1 virtualmachine.go:300] Found tag: zone-a for object {{ClusterComputeResource:domain-c69 [] []} Folder:group-h4 [] [] [] [] cluster1 [] [] [] [] []}
I0108 17:40:08.587307 1 virtualmachine.go:306] Found category: k8s-zone for object {{ClusterComputeResource:domain-c69 [] []} Folder:group-h4 [] [] [] [] cluster1 [] [] [] [] []} with tag: zone-a
I0108 17:40:08.587331 1 virtualmachine.go:285] Name: group-h4, Type: Folder
I0108 17:40:08.802722 1 virtualmachine.go:285] Name: datacenter-2, Type: Datacenter
I0108 17:40:09.033697 1 virtualmachine.go:292] Object [{{Datacenter:datacenter-2 [] []} Folder:group-d1 [] [] [] [] Datacenter [] [] [] [] []}] has attached Tags [[urn:vmomi:InventoryServiceTag:cbe20733-aed0-4561-b6e5-1fc22e4c1dd3:GLOBAL]]
I0108 17:40:09.237978 1 virtualmachine.go:300] Found tag: region-1 for object {{Datacenter:datacenter-2 [] []} Folder:group-d1 [] [] [] [] Datacenter [] [] [] [] []}
I0108 17:40:09.290767 1 virtualmachine.go:306] Found category: k8s-region for object {{Datacenter:datacenter-2 [] []} Folder:group-d1 [] [] [] [] Datacenter [] [] [] [] []} with tag: region-1
I0108 17:40:09.346782 1 virtualmachine.go:347] MoRef [VirtualMachine:vm-79] belongs to zone [zone-a] and region [region-1]
I0108 17:40:09.567819 1 virtualmachine.go:324] IsInZoneRegion: called with zoneCategoryName: k8s-zone, regionCategoryName: k8s-region, zoneValue: zone-a, regionValue: region-1
I0108 17:40:09.568110 1 virtualmachine.go:230] Using plain text username and password
I0108 17:40:09.967352 1 virtualmachine.go:269] GetZoneRegion: called with zoneCategoryName: k8s-zone, regionCategoryName: k8s-region
I0108 17:40:09.967629 1 virtualmachine.go:230] Using plain text username and password
I0108 17:40:10.670152 1 virtualmachine.go:212] Host owning node vm: VirtualMachine:vm-83 [VirtualCenterHost: 100.2.51.14, UUID: 421c056b-782d-e3fd-758b-9109abdb9162, Datacenter: Datacenter [Datacenter: Datacenter:datacenter-2, VirtualCenterHost: 100.2.51.14]] is 100.2.126.24
I0108 17:40:10.718798 1 virtualmachine.go:263] Ancestors of node vm: VirtualMachine:vm-83 [VirtualCenterHost: 100.2.51.14, UUID: 421c056b-782d-e3fd-758b-9109abdb9162, Datacenter: Datacenter [Datacenter: Datacenter:datacenter-2, VirtualCenterHost: 100.2.51.14]] are : [[{ExtensibleManagedObject:{Self:Folder:group-d1 Value:[] AvailableField:[]} Parent: CustomValue:[] OverallStatus: ConfigStatus: ConfigIssue:[] EffectiveRole:[] Permission:[] Name:Datacenters DisabledMethod:[] RecentTask:[] DeclaredAlarmState:[] TriggeredAlarmState:[] AlarmActionsEnabled: Tag:[]} {ExtensibleManagedObject:{Self:Datacenter:datacenter-2 Value:[] AvailableField:[]} Parent:Folder:group-d1 CustomValue:[] OverallStatus: ConfigStatus: ConfigIssue:[] EffectiveRole:[] Permission:[] Name:Datacenter DisabledMethod:[] RecentTask:[] DeclaredAlarmState:[] TriggeredAlarmState:[] AlarmActionsEnabled: Tag:[]} {ExtensibleManagedObject:{Self:Folder:group-h4 Value:[] AvailableField:[]} Parent:Datacenter:datacenter-2 CustomValue:[] OverallStatus: ConfigStatus: ConfigIssue:[] EffectiveRole:[] Permission:[] Name:host DisabledMethod:[] RecentTask:[] DeclaredAlarmState:[] TriggeredAlarmState:[] AlarmActionsEnabled: Tag:[]} {ExtensibleManagedObject:{Self:ClusterComputeResource:domain-c69 Value:[] AvailableField:[]} Parent:Folder:group-h4 CustomValue:[] OverallStatus: ConfigStatus: ConfigIssue:[] EffectiveRole:[] Permission:[] Name:cluster1 DisabledMethod:[] RecentTask:[] DeclaredAlarmState:[] TriggeredAlarmState:[] AlarmActionsEnabled: Tag:[]} {ExtensibleManagedObject:{Self:HostSystem:host-39 Value:[] AvailableField:[]} Parent:ClusterComputeResource:domain-c69 CustomValue:[] OverallStatus: ConfigStatus: ConfigIssue:[] EffectiveRole:[] Permission:[] Name:100.2.126.24 DisabledMethod:[] RecentTask:[] DeclaredAlarmState:[] TriggeredAlarmState:[] AlarmActionsEnabled: Tag:[]}]]
I0108 17:40:10.720287 1 virtualmachine.go:285] Name: host-39, Type: HostSystem
I0108 17:40:10.962121 1 virtualmachine.go:285] Name: domain-c69, Type: ClusterComputeResource
I0108 17:40:11.049047 1 virtualmachine.go:292] Object [{{ClusterComputeResource:domain-c69 [] []} Folder:group-h4 [] [] [] [] cluster1 [] [] [] [] []}] has attached Tags [[urn:vmomi:InventoryServiceTag:34d348cf-82a5-4b62-8faa-c0bb5128f9e1:GLOBAL]]
I0108 17:40:11.108277 1 virtualmachine.go:300] Found tag: zone-a for object {{ClusterComputeResource:domain-c69 [] []} Folder:group-h4 [] [] [] [] cluster1 [] [] [] [] []}
I0108 17:40:11.160528 1 virtualmachine.go:306] Found category: k8s-zone for object {{ClusterComputeResource:domain-c69 [] []} Folder:group-h4 [] [] [] [] cluster1 [] [] [] [] []} with tag: zone-a
I0108 17:40:11.160578 1 virtualmachine.go:285] Name: group-h4, Type: Folder
I0108 17:40:11.246856 1 virtualmachine.go:285] Name: datacenter-2, Type: Datacenter
I0108 17:40:11.488449 1 virtualmachine.go:292] Object [{{Datacenter:datacenter-2 [] []} Folder:group-d1 [] [] [] [] Datacenter [] [] [] [] []}] has attached Tags [[urn:vmomi:InventoryServiceTag:cbe20733-aed0-4561-b6e5-1fc22e4c1dd3:GLOBAL]]
I0108 17:40:11.542314 1 virtualmachine.go:300] Found tag: region-1 for object {{Datacenter:datacenter-2 [] []} Folder:group-d1 [] [] [] [] Datacenter [] [] [] [] []}
I0108 17:40:11.595377 1 virtualmachine.go:306] Found category: k8s-region for object {{Datacenter:datacenter-2 [] []} Folder:group-d1 [] [] [] [] Datacenter [] [] [] [] []} with tag: region-1
I0108 17:40:11.645451 1 virtualmachine.go:347] MoRef [VirtualMachine:vm-83] belongs to zone [zone-a] and region [region-1]
I0108 17:40:11.788163 1 nodes.go:150] Obtained list of nodeVMs [[VirtualMachine:vm-79 [VirtualCenterHost: 100.2.51.14, UUID: 421c972b-903b-101c-84ae-d291ab325231, Datacenter: Datacenter [Datacenter: Datacenter:datacenter-2, VirtualCenterHost: 100.2.51.14]] VirtualMachine:vm-83 [VirtualCenterHost: 100.2.51.14, UUID: 421c056b-782d-e3fd-758b-9109abdb9162, Datacenter: Datacenter [Datacenter: Datacenter:datacenter-2, VirtualCenterHost: 100.2.51.14]]]] for zone [zone-a] and region [region-1]
I0108 17:40:11.788263 1 nodes.go:219] Getting accessible datastores for node VirtualMachine:vm-79
I0108 17:40:11.888995 1 nodes.go:219] Getting accessible datastores for node VirtualMachine:vm-83
I0108 17:40:11.985369 1 nodes.go:156] Obtained shared datastores : [] for topology: segments:<key:"failure-domain.beta.kubernetes.io/region" value:"region-1" > segments:<key:"failure-domain.beta.kubernetes.io/zone" value:"zone-a" >
I0108 17:40:11.985412 1 controller.go:165] Shared datastores [[Datastore: Datastore:datastore-68, datastore URL: ds:///vmfs/volumes/5df10bce-59da0dfa-df69-6c92bfebd126/ Datastore: Datastore:datastore-71, datastore URL: ds:///vmfs/volumes/vsan:52b98b583dea3365-d797441ba454996d/]] retrieved for topologyRequirement [requisite:<segments:<key:"failure-domain.beta.kubernetes.io/region" value:"region-1" > segments:<key:"failure-domain.beta.kubernetes.io/zone" value:"zone-a" > > preferred:<segments:<key:"failure-domain.beta.kubernetes.io/region" value:"region-1" > segments:<key:"failure-domain.beta.kubernetes.io/zone" value:"zone-a" > > ] with datastoreTopologyMap [+map[ds:///vmfs/volumes/5df10bce-59da0dfa-df69-6c92bfebd126/:[map[failure-domain.beta.kubernetes.io/region:region-1 failure-domain.beta.kubernetes.io/zone:zone-a]] ds:///vmfs/volumes/vsan:52b98b583dea3365-d797441ba454996d/:[map[failure-domain.beta.kubernetes.io/region:region-1 failure-domain.beta.kubernetes.io/zone:zone-a]]]]
I0108 17:40:12.015722 1 vsphereutil.go:115] vSphere CNS driver creating volume pvc-53813478-1248-4e0a-a134-250e240b6dbf with create spec (*types.CnsVolumeCreateSpec)(0xc0007bb810)({
DynamicData: (types.DynamicData) {
},
Name: (string) (len=40) "pvc-53813478-1248-4e0a-a134-250e240b6dbf",
VolumeType: (string) (len=5) "BLOCK",
Datastores: ([]types.ManagedObjectReference) (len=2 cap=2) {
(types.ManagedObjectReference) Datastore:datastore-68,
(types.ManagedObjectReference) Datastore:datastore-71
},
Metadata: (types.CnsVolumeMetadata) {
DynamicData: (types.DynamicData) {
},
ContainerCluster: (types.CnsContainerCluster) {
DynamicData: (types.DynamicData) {
},
ClusterType: (string) (len=10) "KUBERNETES",
ClusterId: (string) (len=8) "cluster1",
VSphereUser: (string) (len=27) "[email protected]"
},
EntityMetadata: ([]types.BaseCnsEntityMetadata)
},
BackingObjectDetails: (*types.CnsBackingObjectDetails)(0xc000859df0)({
DynamicData: (types.DynamicData) {
},
CapacityInMb: (int64) 10240
}),
Profile: ([]types.BaseVirtualMachineProfileSpec)
})
I0108 17:40:12.077553 1 manager.go:91] Update VSphereUser from [email protected] to VSPHERE.LOCAL\Administrator
I0108 17:40:13.525391 1 manager.go:110] CreateVolume: VolumeName: "pvc-53813478-1248-4e0a-a134-250e240b6dbf", opId: "5d599dc2"
E0108 17:40:13.525608 1 manager.go:126] failed to create cns volume. createSpec: "(*types.CnsVolumeCreateSpec)(0xc0007bb810)({\n DynamicData: (types.DynamicData) {\n },\n Name: (string) (len=40) "pvc-53813478-1248-4e0a-a134-250e240b6dbf",\n VolumeType: (string) (len=5) "BLOCK",\n Datastores: ([]types.ManagedObjectReference) (len=2 cap=2) {\n (types.ManagedObjectReference) Datastore:datastore-68,\n (types.ManagedObjectReference) Datastore:datastore-71\n },\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=8) "cluster1",\n VSphereUser: (string) (len=27) "VSPHERE.LOCAL\\Administrator"\n },\n EntityMetadata: ([]types.BaseCnsEntityMetadata) \n },\n BackingObjectDetails: (*types.CnsBackingObjectDetails)(0xc000859df0)({\n DynamicData: (types.DynamicData) {\n },\n CapacityInMb: (int64) 10240\n }),\n Profile: ([]types.BaseVirtualMachineProfileSpec) \n})\n", fault: "(*types.CnsFault)(0xc000971700)({\n Fault: (*types.BaseMethodFault)(0xc000623fa0)(),\n LocalizedMessage: (string) (len=81) "CnsFault error: CNS: Failed to create disk.:Fault cause: vmodl.fault.SystemError\n"\n})\n", opId: "5d599dc2"
E0108 17:40:13.525714 1 vsphereutil.go:118] Failed to create disk pvc-53813478-1248-4e0a-a134-250e240b6dbf with error CnsFault error: CNS: Failed to create disk.:Fault cause: vmodl.fault.SystemError
E0108 17:40:13.525747 1 controller.go:195] Failed to create volume. Error: CnsFault error: CNS: Failed to create disk.:Fault cause: vmodl.fault.SystemError