Skip to content

Instantly share code, notes, and snippets.

@divyenpatel

divyenpatel/migration-support-driver.log

Created June 8, 2020 23:24
Show Gist options
  • Save divyenpatel/78da801ddaa818f9480f126fc72b0786 to your computer and use it in GitHub Desktop.
Save divyenpatel/78da801ddaa818f9480f126fc72b0786 to your computer and use it in GitHub Desktop.
Download ZIP
Raw
migration-support-driver.log
CreateVolume
-------------
2020-06-08T23:02:07.101807034Z {"level":"info","time":"2020-06-08T23:02:07.101475128Z","caller":"vanilla/controller.go:475","msg":"CreateVolume: called with args {Name:pvc-ccf3130a-5fdf-44bc-88af-152e12bd20b4 CapacityRange:required_bytes:2147483648 VolumeCapabilities:[mount:<fs_type:\"ext4\" > access_mode:<mode:SINGLE_NODE_WRITER > ] Parameters:map[csimigration:true datastore-migrationparam:vsanDatastore storagepolicyname:vSAN Default Storage Policy] Secrets:map[] VolumeContentSource:<nil> AccessibilityRequirements:<nil> XXX_NoUnkeyedLiteral:{} XXX_unrecognized:[] XXX_sizecache:0}","TraceId":"8a907298-0ea9-4a73-99ac-9594663b9e8a"}
2020-06-08T23:02:07.101832911Z {"level":"info","time":"2020-06-08T23:02:07.10162329Z","caller":"common/util.go:228","msg":"vSphere CSI Driver supports StoragePolicyName, Datastore and fsType parameters supplied from legacy in-tree provisioner. All other parameters supplied in csimigrationparams will be dropped.","TraceId":"8a907298-0ea9-4a73-99ac-9594663b9e8a"}
2020-06-08T23:02:07.101838462Z {"level":"info","time":"2020-06-08T23:02:07.101649791Z","caller":"vanilla/controller.go:273","msg":"Converting datastore name: \"vsanDatastore\" to Datastore URL","TraceId":"8a907298-0ea9-4a73-99ac-9594663b9e8a"}
2020-06-08T23:02:07.149020363Z {"level":"info","time":"2020-06-08T23:02:07.14862007Z","caller":"vanilla/controller.go:292","msg":"Found datastoreURL: \"ds:///vmfs/volumes/vsan:52b7b0d022ddee29-e62dca3400ef5bb7/\" for datastore name: \"vsanDatastore\"","TraceId":"8a907298-0ea9-4a73-99ac-9594663b9e8a"}
2020-06-08T23:02:17.477640693Z {"level":"info","time":"2020-06-08T23:02:17.477205354Z","caller":"volume/manager.go:197","msg":"CreateVolume: VolumeName: \"pvc-ccf3130a-5fdf-44bc-88af-152e12bd20b4\", opId: \"4c7e60e3\"","TraceId":"8a907298-0ea9-4a73-99ac-9594663b9e8a"}
2020-06-08T23:02:17.477736843Z {"level":"info","time":"2020-06-08T23:02:17.477284513Z","caller":"volume/manager.go:228","msg":"CreateVolume: Volume created successfully. VolumeName: \"pvc-ccf3130a-5fdf-44bc-88af-152e12bd20b4\", opId: \"4c7e60e3\", volumeID: \"0d289d4f-6b8c-450e-b936-79eefb4306f0\"","TraceId":"8a907298-0ea9-4a73-99ac-9594663b9e8a"}
2020-06-08T23:02:17.480845998Z {"level":"info","time":"2020-06-08T23:02:17.480429609Z","caller":"migration/migration.go:209","msg":"Could not retrieve mapping of volume path and volume ID in the cache for VolumeID: \"0d289d4f-6b8c-450e-b936-79eefb4306f0\". volume may not be registered","TraceId":"8a907298-0ea9-4a73-99ac-9594663b9e8a"}
2020-06-08T23:02:17.480861116Z {"level":"info","time":"2020-06-08T23:02:17.480541711Z","caller":"migration/migration.go:211","msg":"Calling QueryVolumeInfo using: [{{} 0d289d4f-6b8c-450e-b936-79eefb4306f0}]","TraceId":"8a907298-0ea9-4a73-99ac-9594663b9e8a"}
2020-06-08T23:02:19.274675931Z {"level":"info","time":"2020-06-08T23:02:19.274145688Z","caller":"volume/manager.go:648","msg":"QueryVolumeInfo: volumeIDList: [{{} 0d289d4f-6b8c-450e-b936-79eefb4306f0}], opId: \"4c7e60e7\"","TraceId":"8a907298-0ea9-4a73-99ac-9594663b9e8a"}
2020-06-08T23:02:19.274788742Z {"level":"info","time":"2020-06-08T23:02:19.27422037Z","caller":"volume/manager.go:667","msg":"QueryVolumeInfo successfully returned volumeInfo volumeIDList [{{} 0d289d4f-6b8c-450e-b936-79eefb4306f0}]:, opId: \"4c7e60e7\"","TraceId":"8a907298-0ea9-4a73-99ac-9594663b9e8a"}
2020-06-08T23:02:19.274794406Z {"level":"info","time":"2020-06-08T23:02:19.274382441Z","caller":"migration/migration.go:220","msg":"successfully retrieved volume path: \"[vsanDatastore] 879cd65e-6165-91a3-d047-02000359156d/7cdf786b2f5b4303aa94853c7783b44c.vmdk\" for volume id: \"0d289d4f-6b8c-450e-b936-79eefb4306f0\"","TraceId":"8a907298-0ea9-4a73-99ac-9594663b9e8a"}
2020-06-08T23:02:19.274799104Z {"level":"info","time":"2020-06-08T23:02:19.274505951Z","caller":"migration/migration.go:228","msg":"Saving cnsvSphereVolumeMigration CR: {{ } {0d289d4f-6b8c-450e-b936-79eefb4306f0 0 0001-01-01 00:00:00 +0000 UTC <nil> <nil> map[] map[] [] nil [] []} {[vsanDatastore] 879cd65e-6165-91a3-d047-02000359156d/7cdf786b2f5b4303aa94853c7783b44c.vmdk 0d289d4f-6b8c-450e-b936-79eefb4306f0}}","TraceId":"8a907298-0ea9-4a73-99ac-9594663b9e8a"}
2020-06-08T23:02:19.274815291Z {"level":"info","time":"2020-06-08T23:02:19.274585349Z","caller":"migration/migration.go:242","msg":"creating CR for cnsVSphereVolumeMigration: &{TypeMeta:{Kind: APIVersion:} ObjectMeta:{Name:0d289d4f-6b8c-450e-b936-79eefb4306f0 GenerateName: Namespace: SelfLink: UID: ResourceVersion: Generation:0 CreationTimestamp:0001-01-01 00:00:00 +0000 UTC DeletionTimestamp:<nil> DeletionGracePeriodSeconds:<nil> Labels:map[] Annotations:map[] OwnerReferences:[] Initializers:nil Finalizers:[] ClusterName: ManagedFields:[]} Spec:{VolumePath:[vsanDatastore] 879cd65e-6165-91a3-d047-02000359156d/7cdf786b2f5b4303aa94853c7783b44c.vmdk VolumeID:0d289d4f-6b8c-450e-b936-79eefb4306f0}}","TraceId":"8a907298-0ea9-4a73-99ac-9594663b9e8a"}
2020-06-08T23:02:19.282741661Z {"level":"info","time":"2020-06-08T23:02:19.282315708Z","caller":"migration/migration.go:252","msg":"successfully created CR for cnsVSphereVolumeMigration: &{TypeMeta:{Kind: APIVersion:} ObjectMeta:{Name:0d289d4f-6b8c-450e-b936-79eefb4306f0 GenerateName: Namespace: SelfLink:/apis/cns.vmware.com/v1alpha1/cnsvspherevolumemigrations/0d289d4f-6b8c-450e-b936-79eefb4306f0 UID:6b882c71-52cf-4ed3-baf3-24a8de8d0083 ResourceVersion:2001688 Generation:1 CreationTimestamp:2020-06-08 23:02:19 +0000 UTC DeletionTimestamp:<nil> DeletionGracePeriodSeconds:<nil> Labels:map[] Annotations:map[] OwnerReferences:[] Initializers:nil Finalizers:[] ClusterName: ManagedFields:[{Manager:vsphere-csi Operation:Update APIVersion:cns.vmware.com/v1alpha1 Time:2020-06-08 23:02:19 +0000 UTC Fields:nil}]} Spec:{VolumePath:[vsanDatastore] 879cd65e-6165-91a3-d047-02000359156d/7cdf786b2f5b4303aa94853c7783b44c.vmdk VolumeID:0d289d4f-6b8c-450e-b936-79eefb4306f0}}","TraceId":"8a907298-0ea9-4a73-99ac-9594663b9e8a"}
2020-06-08T23:02:19.282998663Z {"level":"info","time":"2020-06-08T23:02:19.282825611Z","caller":"migration/migration.go:234","msg":"successfully saved cnsvSphereVolumeMigration CR: {{ } {0d289d4f-6b8c-450e-b936-79eefb4306f0 /apis/cns.vmware.com/v1alpha1/cnsvspherevolumemigrations/0d289d4f-6b8c-450e-b936-79eefb4306f0 6b882c71-52cf-4ed3-baf3-24a8de8d0083 2001688 1 2020-06-08 23:02:19 +0000 UTC <nil> <nil> map[] map[] [] nil [] [{vsphere-csi Update cns.vmware.com/v1alpha1 2020-06-08 23:02:19 +0000 UTC nil}]} {[vsanDatastore] 879cd65e-6165-91a3-d047-02000359156d/7cdf786b2f5b4303aa94853c7783b44c.vmdk 0d289d4f-6b8c-450e-b936-79eefb4306f0}}","TraceId":"8a907298-0ea9-4a73-99ac-9594663b9e8a"}
2020-06-08T23:02:19.283938872Z {"level":"info","time":"2020-06-08T23:02:19.283837246Z","caller":"migration/migration.go:122","msg":"successfully added volumePath: \"[vsanDatastore] 879cd65e-6165-91a3-d047-02000359156d/7cdf786b2f5b4303aa94853c7783b44c.vmdk\", volumeID: \"0d289d4f-6b8c-450e-b936-79eefb4306f0\" mapping in the cache","TraceId":"3627cc04-173d-40dc-9a15-ae89eb8bfab7"}
Attach Volume
--------------
2020-06-08T23:03:00.822224310Z {"level":"info","time":"2020-06-08T23:03:00.821474572Z","caller":"vanilla/controller.go:557","msg":"ControllerPublishVolume: called with args {VolumeId:[vsanDatastore] 879cd65e-6165-91a3-d047-02000359156d/7cdf786b2f5b4303aa94853c7783b44c.vmdk NodeId:k8s-node2 VolumeCapability:mount:<fs_type:\"ext4\" > access_mode:<mode:SINGLE_NODE_WRITER > Readonly:false Secrets:map[] VolumeContext:map[] XXX_NoUnkeyedLiteral:{} XXX_unrecognized:[] XXX_sizecache:0}","TraceId":"a4ec54f6-9b62-40fd-89f3-c04f02207dc1"}
2020-06-08T23:03:00.829834391Z {"level":"info","time":"2020-06-08T23:03:00.829488254Z","caller":"migration/migration.go:155","msg":"VolumeID: \"0d289d4f-6b8c-450e-b936-79eefb4306f0\" found from the cache for for VolumePath: \"[vsanDatastore] 879cd65e-6165-91a3-d047-02000359156d/7cdf786b2f5b4303aa94853c7783b44c.vmdk\"","TraceId":"a4ec54f6-9b62-40fd-89f3-c04f02207dc1"}
2020-06-08T23:03:06.693273007Z {"level":"info","time":"2020-06-08T23:03:06.692769542Z","caller":"volume/manager.go:268","msg":"AttachVolume: volumeID: \"0d289d4f-6b8c-450e-b936-79eefb4306f0\", vm: \"VirtualMachine:vm-87 [VirtualCenterHost: 10.160.41.232, UUID: 4224256b-0e41-f05c-898f-04c7b5b43c57, Datacenter: Datacenter [Datacenter: Datacenter:datacenter-3, VirtualCenterHost: 10.160.41.232]]\", opId: \"4c7e60ed\"","TraceId":"a4ec54f6-9b62-40fd-89f3-c04f02207dc1"}
2020-06-08T23:03:06.693311776Z {"level":"info","time":"2020-06-08T23:03:06.692962127Z","caller":"volume/manager.go:301","msg":"AttachVolume: Volume attached successfully. volumeID: \"0d289d4f-6b8c-450e-b936-79eefb4306f0\", opId: \"4c7e60ed\", vm: \"VirtualMachine:vm-87 [VirtualCenterHost: 10.160.41.232, UUID: 4224256b-0e41-f05c-898f-04c7b5b43c57, Datacenter: Datacenter [Datacenter: Datacenter:datacenter-3, VirtualCenterHost: 10.160.41.232]]\", diskUUID: \"6000C29f-b6ba-fc60-3ea5-af6d6df0836b\"","TraceId":"a4ec54f6-9b62-40fd-89f3-c04f02207dc1"}
Detach Volume
--------------
2020-06-08T23:05:37.690747464Z {"level":"info","time":"2020-06-08T23:05:37.690444704Z","caller":"vanilla/controller.go:656","msg":"ControllerUnpublishVolume: called with args {VolumeId:[vsanDatastore] 879cd65e-6165-91a3-d047-02000359156d/7cdf786b2f5b4303aa94853c7783b44c.vmdk NodeId:k8s-node2 Secrets:map[] XXX_NoUnkeyedLiteral:{} XXX_unrecognized:[] XXX_sizecache:0}","TraceId":"ad03f0f0-549a-43f1-bfb7-15ce20dc9706"}
2020-06-08T23:05:37.691850535Z {"level":"info","time":"2020-06-08T23:05:37.691551445Z","caller":"migration/migration.go:155","msg":"VolumeID: \"0d289d4f-6b8c-450e-b936-79eefb4306f0\" found from the cache for for VolumePath: \"[vsanDatastore] 879cd65e-6165-91a3-d047-02000359156d/7cdf786b2f5b4303aa94853c7783b44c.vmdk\"","TraceId":"ad03f0f0-549a-43f1-bfb7-15ce20dc9706"}
2020-06-08T23:05:40.646469417Z {"level":"info","time":"2020-06-08T23:05:40.646009452Z","caller":"volume/manager.go:359","msg":"DetachVolume: volumeID: \"0d289d4f-6b8c-450e-b936-79eefb4306f0\", vm: \"VirtualMachine:vm-87 [VirtualCenterHost: 10.160.41.232, UUID: 4224256b-0e41-f05c-898f-04c7b5b43c57, Datacenter: Datacenter [Datacenter: Datacenter:datacenter-3, VirtualCenterHost: 10.160.41.232]]\", opId: \"4c7e6109\"","TraceId":"ad03f0f0-549a-43f1-bfb7-15ce20dc9706"}
2020-06-08T23:05:40.646504020Z {"level":"info","time":"2020-06-08T23:05:40.646243081Z","caller":"volume/manager.go:389","msg":"DetachVolume: Volume detached successfully. volumeID: \"0d289d4f-6b8c-450e-b936-79eefb4306f0\", vm: \"4c7e6109\", opId: \"VirtualMachine:vm-87 [VirtualCenterHost: 10.160.41.232, UUID: 4224256b-0e41-f05c-898f-04c7b5b43c57, Datacenter: Datacenter [Datacenter: Datacenter:datacenter-3, VirtualCenterHost: 10.160.41.232]]\"","TraceId":"ad03f0f0-549a-43f1-bfb7-15ce20dc9706"}
2020-06-08T23:05:40.656805518Z {"level":"info","time":"2020-06-08T23:05:40.655981936Z","caller":"vanilla/controller.go:656","msg":"ControllerUnpublishVolume: called with args {VolumeId:[vsanDatastore] 879cd65e-6165-91a3-d047-02000359156d/7cdf786b2f5b4303aa94853c7783b44c.vmdk NodeId:k8s-node2 Secrets:map[] XXX_NoUnkeyedLiteral:{} XXX_unrecognized:[] XXX_sizecache:0}","TraceId":"4dc91133-382c-4565-bf6e-ebee77e6fa4f"}
2020-06-08T23:05:40.656822914Z {"level":"info","time":"2020-06-08T23:05:40.656165596Z","caller":"migration/migration.go:155","msg":"VolumeID: \"0d289d4f-6b8c-450e-b936-79eefb4306f0\" found from the cache for for VolumePath: \"[vsanDatastore] 879cd65e-6165-91a3-d047-02000359156d/7cdf786b2f5b4303aa94853c7783b44c.vmdk\"","TraceId":"4dc91133-382c-4565-bf6e-ebee77e6fa4f"}
2020-06-08T23:05:42.700267729Z {"level":"info","time":"2020-06-08T23:05:42.699164233Z","caller":"volume/manager.go:359","msg":"DetachVolume: volumeID: \"0d289d4f-6b8c-450e-b936-79eefb4306f0\", vm: \"VirtualMachine:vm-87 [VirtualCenterHost: 10.160.41.232, UUID: 4224256b-0e41-f05c-898f-04c7b5b43c57, Datacenter: Datacenter [Datacenter: Datacenter:datacenter-3, VirtualCenterHost: 10.160.41.232]]\", opId: \"4c7e610a\"","TraceId":"4dc91133-382c-4565-bf6e-ebee77e6fa4f"}
2020-06-08T23:05:42.707068084Z {"level":"info","time":"2020-06-08T23:05:42.70672366Z","caller":"volume/manager.go:380","msg":"DetachVolume: volumeID: \"0d289d4f-6b8c-450e-b936-79eefb4306f0\" not found on vm: VirtualMachine:vm-87 [VirtualCenterHost: 10.160.41.232, UUID: 4224256b-0e41-f05c-898f-04c7b5b43c57, Datacenter: Datacenter [Datacenter: Datacenter:datacenter-3, VirtualCenterHost: 10.160.41.232]]. Assuming volume is already detached","TraceId":"4dc91133-382c-4565-bf6e-ebee77e6fa4f"}
Delete Volume
-------------
2020-06-08T23:05:51.254032050Z {"level":"info","time":"2020-06-08T23:05:51.253470937Z","caller":"vanilla/controller.go:498","msg":"DeleteVolume: called with args: {VolumeId:[vsanDatastore] 879cd65e-6165-91a3-d047-02000359156d/7cdf786b2f5b4303aa94853c7783b44c.vmdk Secrets:map[] XXX_NoUnkeyedLiteral:{} XXX_unrecognized:[] XXX_sizecache:0}","TraceId":"7f36619b-8816-478a-a29f-0ecd00a83b74"}
2020-06-08T23:05:51.254348464Z {"level":"info","time":"2020-06-08T23:05:51.254196898Z","caller":"migration/migration.go:155","msg":"VolumeID: \"0d289d4f-6b8c-450e-b936-79eefb4306f0\" found from the cache for for VolumePath: \"[vsanDatastore] 879cd65e-6165-91a3-d047-02000359156d/7cdf786b2f5b4303aa94853c7783b44c.vmdk\"","TraceId":"7f36619b-8816-478a-a29f-0ecd00a83b74"}
2020-06-08T23:05:56.942012635Z {"level":"info","time":"2020-06-08T23:05:56.941664808Z","caller":"volume/manager.go:428","msg":"DeleteVolume: volumeID: \"0d289d4f-6b8c-450e-b936-79eefb4306f0\", opId: \"4c7e610c\"","TraceId":"7f36619b-8816-478a-a29f-0ecd00a83b74"}
2020-06-08T23:05:56.943192659Z {"level":"info","time":"2020-06-08T23:05:56.94230925Z","caller":"volume/manager.go:446","msg":"DeleteVolume: Volume deleted successfully. volumeID: \"0d289d4f-6b8c-450e-b936-79eefb4306f0\", opId: \"4c7e610c\"","TraceId":"7f36619b-8816-478a-a29f-0ecd00a83b74"}
2020-06-08T23:05:56.969380429Z {"level":"info","time":"2020-06-08T23:05:56.968972792Z","caller":"migration/migration.go:129","msg":"successfully deleted volumePath: \"[vsanDatastore] 879cd65e-6165-91a3-d047-02000359156d/7cdf786b2f5b4303aa94853c7783b44c.vmdk\", volumeID: \"0d289d4f-6b8c-450e-b936-79eefb4306f0\" mapping from cache","TraceId":"3627cc04-173d-40dc-9a15-ae89eb8bfab7"}
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment