Recent runs || View in Spyglass
PR | andyzhangx: [WIP] test |
Result | ABORTED |
Tests | 0 failed / 0 succeeded |
Started | |
Elapsed | 2m15s |
Revision | 5916b4686125b493881f175d375f7803f797feda |
Refs |
1705 |
... skipping 3 lines ... + make verify go test -v -cover ./pkg/... ./test/utils/credentials ? sigs.k8s.io/azuredisk-csi-driver/pkg/azureconstants [no test files] === RUN TestRescanAllVolumes --- PASS: TestRescanAllVolumes (0.00s) === RUN TestFindDiskByLun W0131 13:49:45.591723 11575 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/azure/scsi1/ failed, error: read /dev/disk/azure/scsi1/ error: bad dir W0131 13:49:45.591819 11575 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/by-id/ failed, error: read /dev/disk/by-id/ error: bad dir --- PASS: TestFindDiskByLun (0.00s) === RUN TestStrFirstLetterToUpper --- PASS: TestStrFirstLetterToUpper (0.00s) === RUN TestNewDriverV1 --- PASS: TestNewDriverV1 (0.00s) === RUN TestCheckDiskCapacity ... skipping 28 lines ... Git Commit: N/A Go Version: go1.19.5 Platform: linux/amd64 Topology Key: topology.disk.csi.azure.com/zone Streaming logs below: W0131 13:49:45.599336 11575 azure_disk_utils.go:230] get kubeconfig() failed with error: open /var/run/secrets/kubernetes.io/serviceaccount/token: no such file or directory I0131 13:49:45.603258 11575 driver.go:81] Enabling controller service capability: CREATE_DELETE_VOLUME I0131 13:49:45.603315 11575 driver.go:81] Enabling controller service capability: PUBLISH_UNPUBLISH_VOLUME I0131 13:49:45.603320 11575 driver.go:81] Enabling controller service capability: CREATE_DELETE_SNAPSHOT I0131 13:49:45.603325 11575 driver.go:81] Enabling controller service capability: CLONE_VOLUME I0131 13:49:45.603328 11575 driver.go:81] Enabling controller service capability: EXPAND_VOLUME I0131 13:49:45.603333 11575 driver.go:81] Enabling controller service capability: SINGLE_NODE_MULTI_WRITER ... skipping 22 lines ... Git Commit: N/A Go Version: go1.19.5 Platform: linux/amd64 Topology Key: topology.disk.csi.azure.com/zone Streaming logs below: W0131 13:49:45.607267 11575 azure_disk_utils.go:230] get kubeconfig() failed with error: open /var/run/secrets/kubernetes.io/serviceaccount/token: no such file or directory W0131 13:49:45.607302 11575 azure_disk_utils.go:189] load azure config from file(/etc/kubernetes/azure.json) failed with open /etc/kubernetes/azure.json: no such file or directory I0131 13:49:45.610047 11575 driver.go:81] Enabling controller service capability: CREATE_DELETE_VOLUME I0131 13:49:45.610076 11575 driver.go:81] Enabling controller service capability: PUBLISH_UNPUBLISH_VOLUME I0131 13:49:45.610081 11575 driver.go:81] Enabling controller service capability: CREATE_DELETE_SNAPSHOT I0131 13:49:45.610085 11575 driver.go:81] Enabling controller service capability: CLONE_VOLUME I0131 13:49:45.610088 11575 driver.go:81] Enabling controller service capability: EXPAND_VOLUME I0131 13:49:45.610093 11575 driver.go:81] Enabling controller service capability: SINGLE_NODE_MULTI_WRITER ... skipping 22 lines ... Git Commit: N/A Go Version: go1.19.5 Platform: linux/amd64 Topology Key: topology.disk.csi.azure.com/zone Streaming logs below: W0131 13:49:45.614046 11575 azure_disk_utils.go:230] get kubeconfig() failed with error: open /var/run/secrets/kubernetes.io/serviceaccount/token: no such file or directory I0131 13:49:45.617395 11575 driver.go:81] Enabling controller service capability: CREATE_DELETE_VOLUME I0131 13:49:45.617424 11575 driver.go:81] Enabling controller service capability: PUBLISH_UNPUBLISH_VOLUME I0131 13:49:45.617429 11575 driver.go:81] Enabling controller service capability: CREATE_DELETE_SNAPSHOT I0131 13:49:45.617433 11575 driver.go:81] Enabling controller service capability: CLONE_VOLUME I0131 13:49:45.617436 11575 driver.go:81] Enabling controller service capability: EXPAND_VOLUME I0131 13:49:45.617441 11575 driver.go:81] Enabling controller service capability: SINGLE_NODE_MULTI_WRITER ... skipping 13 lines ... Git Commit: N/A Go Version: go1.19.5 Platform: linux/amd64 Topology Key: topology.disk.csi.azure.com/zone Streaming logs below: W0131 13:49:45.618273 11575 azure_disk_utils.go:230] get kubeconfig() failed with error: open /var/run/secrets/kubernetes.io/serviceaccount/token: no such file or directory E0131 13:49:45.950577 11575 util.go:138] Send.sendRequest: error in parsing response body string "": unexpected end of JSON input, Skip retrying regional host E0131 13:49:45.950777 11575 azure_standard.go:587] as.GetInstanceTypeByNodeName() failed: as.getVirtualMachine() err=Retriable: false, RetryAfter: 0s, HTTPStatusCode: 400, RawError: azure.BearerAuthorizer#WithAuthorization: Failed to refresh the Token for request to https://management.azure.com/subscriptions/12345/resourceGroups/rg1/providers/Microsoft.Compute/virtualMachines/?%24expand=instanceView&api-version=2022-03-01: StatusCode=400 -- Original Error: adal: Refresh request failed. Status Code = '400'. Response body: {"error":"invalid_request","error_description":"AADSTS90002: Tenant '1234' not found. Check to make sure you have the correct tenant ID and are signing into the correct cloud. Check with your subscription administrator, this may happen if there are no active subscriptions for the tenant.\r\nTrace ID: 6a4327ba-69a1-47b4-b2b4-f7d289dbdd00\r\nCorrelation ID: 1e1fbf74-0bdf-416e-8318-f2f7cfcb1fbc\r\nTimestamp: 2023-01-31 13:49:45Z","error_codes":[90002],"timestamp":"2023-01-31 13:49:45Z","trace_id":"6a4327ba-69a1-47b4-b2b4-f7d289dbdd00","correlation_id":"1e1fbf74-0bdf-416e-8318-f2f7cfcb1fbc","error_uri":"https://login.microsoftonline.com/error?code=90002"} Endpoint https://login.microsoftonline.com/1234/oauth2/token W0131 13:49:45.950806 11575 azuredisk.go:224] Failed to get node info. Error: NewNodeInfo: Failed to get instance type from Azure cloud provider, nodeName: , error: Retriable: false, RetryAfter: 0s, HTTPStatusCode: 400, RawError: azure.BearerAuthorizer#WithAuthorization: Failed to refresh the Token for request to https://management.azure.com/subscriptions/12345/resourceGroups/rg1/providers/Microsoft.Compute/virtualMachines/?%24expand=instanceView&api-version=2022-03-01: StatusCode=400 -- Original Error: adal: Refresh request failed. Status Code = '400'. Response body: {"error":"invalid_request","error_description":"AADSTS90002: Tenant '1234' not found. Check to make sure you have the correct tenant ID and are signing into the correct cloud. Check with your subscription administrator, this may happen if there are no active subscriptions for the tenant.\r\nTrace ID: 6a4327ba-69a1-47b4-b2b4-f7d289dbdd00\r\nCorrelation ID: 1e1fbf74-0bdf-416e-8318-f2f7cfcb1fbc\r\nTimestamp: 2023-01-31 13:49:45Z","error_codes":[90002],"timestamp":"2023-01-31 13:49:45Z","trace_id":"6a4327ba-69a1-47b4-b2b4-f7d289dbdd00","correlation_id":"1e1fbf74-0bdf-416e-8318-f2f7cfcb1fbc","error_uri":"https://login.microsoftonline.com/error?code=90002"} Endpoint https://login.microsoftonline.com/1234/oauth2/token I0131 13:49:45.954039 11575 driver.go:81] Enabling controller service capability: CREATE_DELETE_VOLUME I0131 13:49:45.954074 11575 driver.go:81] Enabling controller service capability: PUBLISH_UNPUBLISH_VOLUME I0131 13:49:45.954080 11575 driver.go:81] Enabling controller service capability: CREATE_DELETE_SNAPSHOT I0131 13:49:45.954084 11575 driver.go:81] Enabling controller service capability: CLONE_VOLUME I0131 13:49:45.954088 11575 driver.go:81] Enabling controller service capability: EXPAND_VOLUME I0131 13:49:45.954092 11575 driver.go:81] Enabling controller service capability: SINGLE_NODE_MULTI_WRITER ... skipping 259 lines ... I0131 13:49:46.021594 11575 driver.go:81] Enabling controller service capability: LIST_SNAPSHOTS I0131 13:49:46.021599 11575 driver.go:81] Enabling controller service capability: CLONE_VOLUME I0131 13:49:46.021604 11575 driver.go:81] Enabling controller service capability: EXPAND_VOLUME I0131 13:49:46.021608 11575 driver.go:81] Enabling controller service capability: LIST_VOLUMES I0131 13:49:46.021612 11575 driver.go:81] Enabling controller service capability: LIST_VOLUMES_PUBLISHED_NODES I0131 13:49:46.021618 11575 driver.go:100] Enabling volume access mode: SINGLE_NODE_WRITER E0131 13:49:46.021805 11575 controllerserver.go:302] validateDiskURI(123) in DeleteVolume failed with error: invalid DiskURI: 123, correct format: [/subscriptions/{sub-id}/resourcegroups/{group-name}/providers/microsoft.compute/disks/{disk-id}] --- PASS: TestDeleteVolume (0.00s) === RUN TestControllerGetVolume I0131 13:49:46.025144 11575 driver.go:81] Enabling controller service capability: CREATE_DELETE_VOLUME I0131 13:49:46.025177 11575 driver.go:81] Enabling controller service capability: PUBLISH_UNPUBLISH_VOLUME I0131 13:49:46.025182 11575 driver.go:81] Enabling controller service capability: CREATE_DELETE_SNAPSHOT I0131 13:49:46.025186 11575 driver.go:81] Enabling controller service capability: LIST_SNAPSHOTS ... skipping 54 lines ... I0131 13:49:46.041525 11575 driver.go:81] Enabling controller service capability: LIST_VOLUMES I0131 13:49:46.041538 11575 driver.go:81] Enabling controller service capability: LIST_VOLUMES_PUBLISHED_NODES I0131 13:49:46.041557 11575 driver.go:100] Enabling volume access mode: SINGLE_NODE_WRITER === RUN TestControllerPublishVolume/diskName_error === RUN TestControllerPublishVolume/NodeID_missing === RUN TestControllerPublishVolume/failed_provisioning_state W0131 13:49:46.042067 11575 controllerserver.go:392] VM(unit-test-node) is in failed state, update VM first === RUN TestControllerPublishVolume/Volume_already_attached_success I0131 13:49:46.045346 11575 driver.go:81] Enabling controller service capability: CREATE_DELETE_VOLUME I0131 13:49:46.045374 11575 driver.go:81] Enabling controller service capability: PUBLISH_UNPUBLISH_VOLUME I0131 13:49:46.045380 11575 driver.go:81] Enabling controller service capability: CREATE_DELETE_SNAPSHOT I0131 13:49:46.045384 11575 driver.go:81] Enabling controller service capability: LIST_SNAPSHOTS I0131 13:49:46.045388 11575 driver.go:81] Enabling controller service capability: CLONE_VOLUME ... skipping 671 lines ... I0131 13:49:46.238748 11575 driver.go:81] Enabling controller service capability: LIST_SNAPSHOTS I0131 13:49:46.238759 11575 driver.go:81] Enabling controller service capability: CLONE_VOLUME I0131 13:49:46.238765 11575 driver.go:81] Enabling controller service capability: EXPAND_VOLUME I0131 13:49:46.238771 11575 driver.go:81] Enabling controller service capability: LIST_VOLUMES I0131 13:49:46.238776 11575 driver.go:81] Enabling controller service capability: LIST_VOLUMES_PUBLISHED_NODES I0131 13:49:46.238781 11575 driver.go:100] Enabling volume access mode: SINGLE_NODE_WRITER E0131 13:49:46.238910 11575 nodeserver.go:558] mkdir failed on target: /home/prow/go/src/sigs.k8s.io/azuredisk-csi-driver/pkg/azuredisk/azuredisk.go (mkdir /home/prow/go/src/sigs.k8s.io/azuredisk-csi-driver/pkg/azuredisk/azuredisk.go: not a directory) --- PASS: TestEnsureMountPoint (0.00s) === RUN TestNodeGetInfo === RUN TestNodeGetInfo/[Success]_Get_node_information_for_existing_VM I0131 13:49:46.242031 11575 driver.go:81] Enabling controller service capability: CREATE_DELETE_VOLUME I0131 13:49:46.242069 11575 driver.go:81] Enabling controller service capability: PUBLISH_UNPUBLISH_VOLUME I0131 13:49:46.242080 11575 driver.go:81] Enabling controller service capability: CREATE_DELETE_SNAPSHOT ... skipping 11 lines ... I0131 13:49:46.245170 11575 driver.go:81] Enabling controller service capability: CLONE_VOLUME I0131 13:49:46.245176 11575 driver.go:81] Enabling controller service capability: EXPAND_VOLUME I0131 13:49:46.245182 11575 driver.go:81] Enabling controller service capability: LIST_VOLUMES I0131 13:49:46.245187 11575 driver.go:81] Enabling controller service capability: LIST_VOLUMES_PUBLISHED_NODES I0131 13:49:46.245194 11575 driver.go:100] Enabling volume access mode: SINGLE_NODE_WRITER W0131 13:49:46.245304 11575 azure_wrap.go:77] Unable to find node e3482586-a16d-11ed-8155-16ce42f88e6b: instance not found W0131 13:49:46.245341 11575 nodeserver.go:339] get zone(fakeNodeID) failed with: instance not found, fall back to get zone from node labels --- PASS: TestNodeGetInfo (0.01s) --- PASS: TestNodeGetInfo/[Success]_Get_node_information_for_existing_VM (0.00s) --- PASS: TestNodeGetInfo/[Failure]_Get_node_information_for_non-existing_VM (0.00s) === RUN TestNodeGetVolumeStats I0131 13:49:46.248466 11575 driver.go:81] Enabling controller service capability: CREATE_DELETE_VOLUME I0131 13:49:46.248505 11575 driver.go:81] Enabling controller service capability: PUBLISH_UNPUBLISH_VOLUME ... skipping 12 lines ... I0131 13:49:46.251875 11575 driver.go:81] Enabling controller service capability: LIST_SNAPSHOTS I0131 13:49:46.251884 11575 driver.go:81] Enabling controller service capability: CLONE_VOLUME I0131 13:49:46.251890 11575 driver.go:81] Enabling controller service capability: EXPAND_VOLUME I0131 13:49:46.251895 11575 driver.go:81] Enabling controller service capability: LIST_VOLUMES I0131 13:49:46.251900 11575 driver.go:81] Enabling controller service capability: LIST_VOLUMES_PUBLISHED_NODES I0131 13:49:46.251907 11575 driver.go:100] Enabling volume access mode: SINGLE_NODE_WRITER W0131 13:49:46.252136 11575 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/azure/scsi1/ failed, error: read /dev/disk/azure/scsi1/ error: bad dir W0131 13:49:46.252156 11575 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/by-id/ failed, error: read /dev/disk/by-id/ error: bad dir E0131 13:49:46.252196 11575 nodeserver.go:169] NodeStageVolume: could not determine if volume vol_1 needs to be resized: Failed readonly device check. Expected 1 or 0, got '16106127360' W0131 13:49:46.252224 11575 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/azure/scsi1/ failed, error: read /dev/disk/azure/scsi1/ error: bad dir W0131 13:49:46.252240 11575 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/by-id/ failed, error: read /dev/disk/by-id/ error: bad dir W0131 13:49:46.252279 11575 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/azure/scsi1/ failed, error: read /dev/disk/azure/scsi1/ error: bad dir W0131 13:49:46.252304 11575 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/by-id/ failed, error: read /dev/disk/by-id/ error: bad dir W0131 13:49:46.252363 11575 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/azure/scsi1/ failed, error: read /dev/disk/azure/scsi1/ error: bad dir W0131 13:49:46.252375 11575 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/by-id/ failed, error: read /dev/disk/by-id/ error: bad dir I0131 13:49:46.252407 11575 mount_linux.go:529] Disk "/dev/sdd" appears to be unformatted, attempting to format as type: "ext4" with options: [-F -m0 /dev/sdd] I0131 13:49:46.252425 11575 mount_linux.go:539] Disk successfully formatted (mkfs): ext4 - /dev/sdd /home/prow/go/src/sigs.k8s.io/azuredisk-csi-driver/pkg/azuredisk/source_test E0131 13:49:46.252442 11575 nodeserver.go:169] NodeStageVolume: could not determine if volume vol_1 needs to be resized: Failed readonly device check. Expected 1 or 0, got '' W0131 13:49:46.252476 11575 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/azure/scsi1/ failed, error: read /dev/disk/azure/scsi1/ error: bad dir W0131 13:49:46.252488 11575 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/by-id/ failed, error: read /dev/disk/by-id/ error: bad dir W0131 13:49:46.252523 11575 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/azure/scsi1/ failed, error: read /dev/disk/azure/scsi1/ error: bad dir W0131 13:49:46.252537 11575 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/by-id/ failed, error: read /dev/disk/by-id/ error: bad dir E0131 13:49:46.252569 11575 nodeserver.go:169] NodeStageVolume: could not determine if volume vol_1 needs to be resized: Failed readonly device check. Expected 1 or 0, got '16106127360' --- PASS: TestNodeStageVolume (0.00s) === RUN TestNodeUnstageVolume I0131 13:49:46.255604 11575 driver.go:81] Enabling controller service capability: CREATE_DELETE_VOLUME I0131 13:49:46.255702 11575 driver.go:81] Enabling controller service capability: PUBLISH_UNPUBLISH_VOLUME I0131 13:49:46.255720 11575 driver.go:81] Enabling controller service capability: CREATE_DELETE_SNAPSHOT I0131 13:49:46.255735 11575 driver.go:81] Enabling controller service capability: LIST_SNAPSHOTS ... skipping 11 lines ... I0131 13:49:46.259609 11575 driver.go:81] Enabling controller service capability: LIST_SNAPSHOTS I0131 13:49:46.259622 11575 driver.go:81] Enabling controller service capability: CLONE_VOLUME I0131 13:49:46.259652 11575 driver.go:81] Enabling controller service capability: EXPAND_VOLUME I0131 13:49:46.259677 11575 driver.go:81] Enabling controller service capability: LIST_VOLUMES I0131 13:49:46.259694 11575 driver.go:81] Enabling controller service capability: LIST_VOLUMES_PUBLISHED_NODES I0131 13:49:46.259709 11575 driver.go:100] Enabling volume access mode: SINGLE_NODE_WRITER E0131 13:49:46.259920 11575 nodeserver.go:558] mkdir failed on target: /home/prow/go/src/sigs.k8s.io/azuredisk-csi-driver/pkg/azuredisk/azuredisk.go (mkdir /home/prow/go/src/sigs.k8s.io/azuredisk-csi-driver/pkg/azuredisk/azuredisk.go: not a directory) --- PASS: TestNodePublishVolume (0.00s) === RUN TestNodeUnpublishVolume I0131 13:49:46.263293 11575 driver.go:81] Enabling controller service capability: CREATE_DELETE_VOLUME I0131 13:49:46.263379 11575 driver.go:81] Enabling controller service capability: PUBLISH_UNPUBLISH_VOLUME I0131 13:49:46.263399 11575 driver.go:81] Enabling controller service capability: CREATE_DELETE_SNAPSHOT I0131 13:49:46.263414 11575 driver.go:81] Enabling controller service capability: LIST_SNAPSHOTS ... skipping 33 lines ... I0131 13:49:46.278723 11575 driver.go:81] Enabling controller service capability: LIST_SNAPSHOTS I0131 13:49:46.278727 11575 driver.go:81] Enabling controller service capability: CLONE_VOLUME I0131 13:49:46.278733 11575 driver.go:81] Enabling controller service capability: EXPAND_VOLUME I0131 13:49:46.278737 11575 driver.go:81] Enabling controller service capability: LIST_VOLUMES I0131 13:49:46.278741 11575 driver.go:81] Enabling controller service capability: LIST_VOLUMES_PUBLISHED_NODES I0131 13:49:46.278746 11575 driver.go:100] Enabling volume access mode: SINGLE_NODE_WRITER E0131 13:49:46.279352 11575 nodeserver.go:558] mkdir failed on target: /home/prow/go/src/sigs.k8s.io/azuredisk-csi-driver/pkg/azuredisk/test (mkdir /home/prow/go/src/sigs.k8s.io/azuredisk-csi-driver/pkg/azuredisk/test: not a directory) --- PASS: TestEnsureBlockTargetFile (0.00s) === RUN TestMakeDir --- PASS: TestMakeDir (0.00s) === RUN TestGetDevicePathWithLUN I0131 13:49:46.283632 11575 driver.go:81] Enabling controller service capability: CREATE_DELETE_VOLUME I0131 13:49:46.283732 11575 driver.go:81] Enabling controller service capability: PUBLISH_UNPUBLISH_VOLUME ... skipping 44 lines ... --- PASS: TestCheckDiskName (0.00s) === RUN TestGetCachingMode --- PASS: TestGetCachingMode (0.00s) === RUN TestGetKubeConfig --- PASS: TestGetKubeConfig (0.00s) === RUN TestGetCloudProvider W0131 13:49:43.913057 11568 azure_disk_utils.go:189] load azure config from file(/etc/kubernetes/azure.json) failed with open /etc/kubernetes/azure.json: no such file or directory W0131 13:49:43.913232 11568 azure_disk_utils.go:230] get kubeconfig(/home/prow/go/src/sigs.k8s.io/azuredisk-csi-driver/pkg/azureutils/empty-kube-config) failed with error: invalid configuration: no configuration has been provided, try setting KUBERNETES_MASTER environment variable W0131 13:49:43.913341 11568 azure_disk_utils.go:230] get kubeconfig() failed with error: open /var/run/secrets/kubernetes.io/serviceaccount/token: no such file or directory --- PASS: TestGetCloudProvider (0.00s) === RUN TestGetDiskLUN --- PASS: TestGetDiskLUN (0.00s) === RUN TestGetDiskName --- PASS: TestGetDiskName (0.00s) === RUN TestGetFStype ... skipping 426 lines ... coverage: 78.0% of statements ok sigs.k8s.io/azuredisk-csi-driver/test/utils/credentials 0.008s coverage: 78.0% of statements go test -v -cover -tags azurediskv2 ./pkg/azuredisk --temp-use-driver-v2 === RUN TestRescanAllVolumes --- PASS: TestRescanAllVolumes (0.00s) === RUN TestFindDiskByLun W0131 13:49:51.789046 11950 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/azure/scsi1/ failed, error: read /dev/disk/azure/scsi1/ error: bad dir W0131 13:49:51.789116 11950 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/by-id/ failed, error: read /dev/disk/by-id/ error: bad dir --- PASS: TestFindDiskByLun (0.00s) === RUN TestStrFirstLetterToUpper --- PASS: TestStrFirstLetterToUpper (0.00s) === RUN TestNewDriverV1 --- PASS: TestNewDriverV1 (0.00s) === RUN TestCheckDiskCapacity ... skipping 30 lines ... Git Commit: N/A Go Version: go1.19.5 Platform: linux/amd64 Topology Key: topology.disk.csi.azure.com/zone Streaming logs below: W0131 13:49:51.796690 11950 azure_disk_utils.go:230] get kubeconfig() failed with error: open /var/run/secrets/kubernetes.io/serviceaccount/token: no such file or directory I0131 13:49:51.800172 11950 driver.go:81] Enabling controller service capability: CREATE_DELETE_VOLUME I0131 13:49:51.800199 11950 driver.go:81] Enabling controller service capability: PUBLISH_UNPUBLISH_VOLUME I0131 13:49:51.800204 11950 driver.go:81] Enabling controller service capability: CREATE_DELETE_SNAPSHOT I0131 13:49:51.800208 11950 driver.go:81] Enabling controller service capability: LIST_SNAPSHOTS I0131 13:49:51.800212 11950 driver.go:81] Enabling controller service capability: CLONE_VOLUME I0131 13:49:51.800217 11950 driver.go:81] Enabling controller service capability: EXPAND_VOLUME ... skipping 26 lines ... Git Commit: N/A Go Version: go1.19.5 Platform: linux/amd64 Topology Key: topology.disk.csi.azure.com/zone Streaming logs below: W0131 13:49:51.804293 11950 azure_disk_utils.go:230] get kubeconfig() failed with error: open /var/run/secrets/kubernetes.io/serviceaccount/token: no such file or directory W0131 13:49:51.804329 11950 azure_disk_utils.go:189] load azure config from file(/etc/kubernetes/azure.json) failed with open /etc/kubernetes/azure.json: no such file or directory I0131 13:49:51.807027 11950 driver.go:81] Enabling controller service capability: CREATE_DELETE_VOLUME I0131 13:49:51.807053 11950 driver.go:81] Enabling controller service capability: PUBLISH_UNPUBLISH_VOLUME I0131 13:49:51.807059 11950 driver.go:81] Enabling controller service capability: CREATE_DELETE_SNAPSHOT I0131 13:49:51.807065 11950 driver.go:81] Enabling controller service capability: LIST_SNAPSHOTS I0131 13:49:51.807070 11950 driver.go:81] Enabling controller service capability: CLONE_VOLUME I0131 13:49:51.807076 11950 driver.go:81] Enabling controller service capability: EXPAND_VOLUME ... skipping 26 lines ... Git Commit: N/A Go Version: go1.19.5 Platform: linux/amd64 Topology Key: topology.disk.csi.azure.com/zone Streaming logs below: W0131 13:49:51.811103 11950 azure_disk_utils.go:230] get kubeconfig() failed with error: open /var/run/secrets/kubernetes.io/serviceaccount/token: no such file or directory I0131 13:49:51.814096 11950 driver.go:81] Enabling controller service capability: CREATE_DELETE_VOLUME I0131 13:49:51.814125 11950 driver.go:81] Enabling controller service capability: PUBLISH_UNPUBLISH_VOLUME I0131 13:49:51.814130 11950 driver.go:81] Enabling controller service capability: CREATE_DELETE_SNAPSHOT I0131 13:49:51.814135 11950 driver.go:81] Enabling controller service capability: LIST_SNAPSHOTS I0131 13:49:51.814139 11950 driver.go:81] Enabling controller service capability: CLONE_VOLUME I0131 13:49:51.814144 11950 driver.go:81] Enabling controller service capability: EXPAND_VOLUME ... skipping 16 lines ... Git Commit: N/A Go Version: go1.19.5 Platform: linux/amd64 Topology Key: topology.disk.csi.azure.com/zone Streaming logs below: W0131 13:49:51.815053 11950 azure_disk_utils.go:230] get kubeconfig() failed with error: open /var/run/secrets/kubernetes.io/serviceaccount/token: no such file or directory E0131 13:49:52.029614 11950 util.go:138] Send.sendRequest: error in parsing response body string "": unexpected end of JSON input, Skip retrying regional host E0131 13:49:52.029727 11950 azure_standard.go:587] as.GetInstanceTypeByNodeName() failed: as.getVirtualMachine() err=Retriable: false, RetryAfter: 0s, HTTPStatusCode: 400, RawError: azure.BearerAuthorizer#WithAuthorization: Failed to refresh the Token for request to https://management.azure.com/subscriptions/12345/resourceGroups/rg1/providers/Microsoft.Compute/virtualMachines/?%24expand=instanceView&api-version=2022-03-01: StatusCode=400 -- Original Error: adal: Refresh request failed. Status Code = '400'. Response body: {"error":"invalid_request","error_description":"AADSTS90002: Tenant '1234' not found. Check to make sure you have the correct tenant ID and are signing into the correct cloud. Check with your subscription administrator, this may happen if there are no active subscriptions for the tenant.\r\nTrace ID: 3593bbda-7973-46d1-a88c-7a4fa4be6800\r\nCorrelation ID: 8cc200fc-5789-40cb-b642-500142dabf19\r\nTimestamp: 2023-01-31 13:49:51Z","error_codes":[90002],"timestamp":"2023-01-31 13:49:51Z","trace_id":"3593bbda-7973-46d1-a88c-7a4fa4be6800","correlation_id":"8cc200fc-5789-40cb-b642-500142dabf19","error_uri":"https://login.microsoftonline.com/error?code=90002"} Endpoint https://login.microsoftonline.com/1234/oauth2/token W0131 13:49:52.029744 11950 azuredisk.go:224] Failed to get node info. Error: NewNodeInfo: Failed to get instance type from Azure cloud provider, nodeName: , error: Retriable: false, RetryAfter: 0s, HTTPStatusCode: 400, RawError: azure.BearerAuthorizer#WithAuthorization: Failed to refresh the Token for request to https://management.azure.com/subscriptions/12345/resourceGroups/rg1/providers/Microsoft.Compute/virtualMachines/?%24expand=instanceView&api-version=2022-03-01: StatusCode=400 -- Original Error: adal: Refresh request failed. Status Code = '400'. Response body: {"error":"invalid_request","error_description":"AADSTS90002: Tenant '1234' not found. Check to make sure you have the correct tenant ID and are signing into the correct cloud. Check with your subscription administrator, this may happen if there are no active subscriptions for the tenant.\r\nTrace ID: 3593bbda-7973-46d1-a88c-7a4fa4be6800\r\nCorrelation ID: 8cc200fc-5789-40cb-b642-500142dabf19\r\nTimestamp: 2023-01-31 13:49:51Z","error_codes":[90002],"timestamp":"2023-01-31 13:49:51Z","trace_id":"3593bbda-7973-46d1-a88c-7a4fa4be6800","correlation_id":"8cc200fc-5789-40cb-b642-500142dabf19","error_uri":"https://login.microsoftonline.com/error?code=90002"} Endpoint https://login.microsoftonline.com/1234/oauth2/token I0131 13:49:52.032860 11950 driver.go:81] Enabling controller service capability: CREATE_DELETE_VOLUME I0131 13:49:52.032901 11950 driver.go:81] Enabling controller service capability: PUBLISH_UNPUBLISH_VOLUME I0131 13:49:52.032909 11950 driver.go:81] Enabling controller service capability: CREATE_DELETE_SNAPSHOT I0131 13:49:52.032914 11950 driver.go:81] Enabling controller service capability: CLONE_VOLUME I0131 13:49:52.032917 11950 driver.go:81] Enabling controller service capability: EXPAND_VOLUME I0131 13:49:52.032922 11950 driver.go:81] Enabling controller service capability: SINGLE_NODE_MULTI_WRITER ... skipping 255 lines ... I0131 13:49:52.100012 11950 driver.go:81] Enabling controller service capability: LIST_SNAPSHOTS I0131 13:49:52.100028 11950 driver.go:81] Enabling controller service capability: CLONE_VOLUME I0131 13:49:52.100060 11950 driver.go:81] Enabling controller service capability: EXPAND_VOLUME I0131 13:49:52.100090 11950 driver.go:81] Enabling controller service capability: LIST_VOLUMES I0131 13:49:52.100109 11950 driver.go:81] Enabling controller service capability: LIST_VOLUMES_PUBLISHED_NODES I0131 13:49:52.100122 11950 driver.go:100] Enabling volume access mode: SINGLE_NODE_WRITER E0131 13:49:52.100369 11950 controllerserver_v2.go:256] validateDiskURI(123) in DeleteVolume failed with error: invalid DiskURI: 123, correct format: [/subscriptions/{sub-id}/resourcegroups/{group-name}/providers/microsoft.compute/disks/{disk-id}] --- PASS: TestDeleteVolume (0.00s) === RUN TestControllerGetVolume W0131 13:49:52.100459 11950 fake_azuredisk_v2.go:57] Using DriverV2 I0131 13:49:52.103174 11950 driver.go:81] Enabling controller service capability: CREATE_DELETE_VOLUME I0131 13:49:52.103208 11950 driver.go:81] Enabling controller service capability: PUBLISH_UNPUBLISH_VOLUME I0131 13:49:52.103213 11950 driver.go:81] Enabling controller service capability: CREATE_DELETE_SNAPSHOT ... skipping 60 lines ... I0131 13:49:52.119114 11950 driver.go:81] Enabling controller service capability: LIST_VOLUMES I0131 13:49:52.119117 11950 driver.go:81] Enabling controller service capability: LIST_VOLUMES_PUBLISHED_NODES I0131 13:49:52.119122 11950 driver.go:100] Enabling volume access mode: SINGLE_NODE_WRITER === RUN TestControllerPublishVolume/diskName_error === RUN TestControllerPublishVolume/NodeID_missing === RUN TestControllerPublishVolume/failed_provisioning_state W0131 13:49:52.119507 11950 controllerserver_v2.go:341] VM(unit-test-node) is in failed state, update VM first === RUN TestControllerPublishVolume/Volume_already_attached_success W0131 13:49:52.119632 11950 fake_azuredisk_v2.go:57] Using DriverV2 I0131 13:49:52.122513 11950 driver.go:81] Enabling controller service capability: CREATE_DELETE_VOLUME I0131 13:49:52.122542 11950 driver.go:81] Enabling controller service capability: PUBLISH_UNPUBLISH_VOLUME I0131 13:49:52.122547 11950 driver.go:81] Enabling controller service capability: CREATE_DELETE_SNAPSHOT I0131 13:49:52.122551 11950 driver.go:81] Enabling controller service capability: LIST_SNAPSHOTS ... skipping 731 lines ... I0131 13:49:52.291041 11950 driver.go:81] Enabling controller service capability: LIST_SNAPSHOTS I0131 13:49:52.291045 11950 driver.go:81] Enabling controller service capability: CLONE_VOLUME I0131 13:49:52.291049 11950 driver.go:81] Enabling controller service capability: EXPAND_VOLUME I0131 13:49:52.291052 11950 driver.go:81] Enabling controller service capability: LIST_VOLUMES I0131 13:49:52.291055 11950 driver.go:81] Enabling controller service capability: LIST_VOLUMES_PUBLISHED_NODES I0131 13:49:52.291082 11950 driver.go:100] Enabling volume access mode: SINGLE_NODE_WRITER E0131 13:49:52.291158 11950 nodeserver_v2.go:543] mkdir failed on target: /home/prow/go/src/sigs.k8s.io/azuredisk-csi-driver/pkg/azuredisk/azuredisk.go (mkdir /home/prow/go/src/sigs.k8s.io/azuredisk-csi-driver/pkg/azuredisk/azuredisk.go: not a directory) --- PASS: TestEnsureMountPoint (0.00s) === RUN TestNodeGetInfo === RUN TestNodeGetInfo/[Success]_Get_node_information_for_existing_VM W0131 13:49:52.291447 11950 fake_azuredisk_v2.go:57] Using DriverV2 I0131 13:49:52.293716 11950 driver.go:81] Enabling controller service capability: CREATE_DELETE_VOLUME I0131 13:49:52.293735 11950 driver.go:81] Enabling controller service capability: PUBLISH_UNPUBLISH_VOLUME ... skipping 13 lines ... I0131 13:49:52.296384 11950 driver.go:81] Enabling controller service capability: CLONE_VOLUME I0131 13:49:52.296388 11950 driver.go:81] Enabling controller service capability: EXPAND_VOLUME I0131 13:49:52.296394 11950 driver.go:81] Enabling controller service capability: LIST_VOLUMES I0131 13:49:52.296397 11950 driver.go:81] Enabling controller service capability: LIST_VOLUMES_PUBLISHED_NODES I0131 13:49:52.296410 11950 driver.go:100] Enabling volume access mode: SINGLE_NODE_WRITER W0131 13:49:52.296486 11950 azure_wrap.go:77] Unable to find node e3482586-a16d-11ed-8155-16ce42f88e6b: instance not found W0131 13:49:52.296500 11950 nodeserver_v2.go:336] get zone(fakeNodeID) failed with: instance not found, fall back to get zone from node labels --- PASS: TestNodeGetInfo (0.01s) --- PASS: TestNodeGetInfo/[Success]_Get_node_information_for_existing_VM (0.00s) --- PASS: TestNodeGetInfo/[Failure]_Get_node_information_for_non-existing_VM (0.00s) === RUN TestNodeGetVolumeStats W0131 13:49:52.296661 11950 fake_azuredisk_v2.go:57] Using DriverV2 I0131 13:49:52.299094 11950 driver.go:81] Enabling controller service capability: CREATE_DELETE_VOLUME ... skipping 14 lines ... I0131 13:49:52.301686 11950 driver.go:81] Enabling controller service capability: LIST_SNAPSHOTS I0131 13:49:52.301690 11950 driver.go:81] Enabling controller service capability: CLONE_VOLUME I0131 13:49:52.301694 11950 driver.go:81] Enabling controller service capability: EXPAND_VOLUME I0131 13:49:52.301698 11950 driver.go:81] Enabling controller service capability: LIST_VOLUMES I0131 13:49:52.301701 11950 driver.go:81] Enabling controller service capability: LIST_VOLUMES_PUBLISHED_NODES I0131 13:49:52.301728 11950 driver.go:100] Enabling volume access mode: SINGLE_NODE_WRITER W0131 13:49:52.302043 11950 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/azure/scsi1/ failed, error: read /dev/disk/azure/scsi1/ error: bad dir W0131 13:49:52.302059 11950 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/by-id/ failed, error: read /dev/disk/by-id/ error: bad dir E0131 13:49:52.302122 11950 nodeserver_v2.go:157] NodeStageVolume: could not determine if volume vol_1 needs to be resized: Failed readonly device check. Expected 1 or 0, got '16106127360' W0131 13:49:52.302172 11950 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/azure/scsi1/ failed, error: read /dev/disk/azure/scsi1/ error: bad dir W0131 13:49:52.302183 11950 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/by-id/ failed, error: read /dev/disk/by-id/ error: bad dir W0131 13:49:52.302256 11950 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/azure/scsi1/ failed, error: read /dev/disk/azure/scsi1/ error: bad dir W0131 13:49:52.302273 11950 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/by-id/ failed, error: read /dev/disk/by-id/ error: bad dir W0131 13:49:52.302350 11950 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/azure/scsi1/ failed, error: read /dev/disk/azure/scsi1/ error: bad dir W0131 13:49:52.302386 11950 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/by-id/ failed, error: read /dev/disk/by-id/ error: bad dir I0131 13:49:52.302425 11950 mount_linux.go:529] Disk "/dev/sdd" appears to be unformatted, attempting to format as type: "ext4" with options: [-F -m0 /dev/sdd] I0131 13:49:52.302477 11950 mount_linux.go:539] Disk successfully formatted (mkfs): ext4 - /dev/sdd /home/prow/go/src/sigs.k8s.io/azuredisk-csi-driver/pkg/azuredisk/source_test E0131 13:49:52.302508 11950 nodeserver_v2.go:157] NodeStageVolume: could not determine if volume vol_1 needs to be resized: Failed readonly device check. Expected 1 or 0, got '' W0131 13:49:52.302573 11950 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/azure/scsi1/ failed, error: read /dev/disk/azure/scsi1/ error: bad dir W0131 13:49:52.302633 11950 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/by-id/ failed, error: read /dev/disk/by-id/ error: bad dir W0131 13:49:52.302684 11950 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/azure/scsi1/ failed, error: read /dev/disk/azure/scsi1/ error: bad dir W0131 13:49:52.302695 11950 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/by-id/ failed, error: read /dev/disk/by-id/ error: bad dir E0131 13:49:52.302774 11950 nodeserver_v2.go:157] NodeStageVolume: could not determine if volume vol_1 needs to be resized: Failed readonly device check. Expected 1 or 0, got '16106127360' --- PASS: TestNodeStageVolume (0.00s) === RUN TestNodeUnstageVolume W0131 13:49:52.302942 11950 fake_azuredisk_v2.go:57] Using DriverV2 I0131 13:49:52.305241 11950 driver.go:81] Enabling controller service capability: CREATE_DELETE_VOLUME I0131 13:49:52.305262 11950 driver.go:81] Enabling controller service capability: PUBLISH_UNPUBLISH_VOLUME I0131 13:49:52.305266 11950 driver.go:81] Enabling controller service capability: CREATE_DELETE_SNAPSHOT ... skipping 13 lines ... I0131 13:49:52.308209 11950 driver.go:81] Enabling controller service capability: LIST_SNAPSHOTS I0131 13:49:52.308212 11950 driver.go:81] Enabling controller service capability: CLONE_VOLUME I0131 13:49:52.308217 11950 driver.go:81] Enabling controller service capability: EXPAND_VOLUME I0131 13:49:52.308220 11950 driver.go:81] Enabling controller service capability: LIST_VOLUMES I0131 13:49:52.308224 11950 driver.go:81] Enabling controller service capability: LIST_VOLUMES_PUBLISHED_NODES I0131 13:49:52.308228 11950 driver.go:100] Enabling volume access mode: SINGLE_NODE_WRITER E0131 13:49:52.308339 11950 nodeserver_v2.go:543] mkdir failed on target: /home/prow/go/src/sigs.k8s.io/azuredisk-csi-driver/pkg/azuredisk/azuredisk.go (mkdir /home/prow/go/src/sigs.k8s.io/azuredisk-csi-driver/pkg/azuredisk/azuredisk.go: not a directory) --- PASS: TestNodePublishVolume (0.00s) === RUN TestNodeUnpublishVolume W0131 13:49:52.308595 11950 fake_azuredisk_v2.go:57] Using DriverV2 I0131 13:49:52.310987 11950 driver.go:81] Enabling controller service capability: CREATE_DELETE_VOLUME I0131 13:49:52.311058 11950 driver.go:81] Enabling controller service capability: PUBLISH_UNPUBLISH_VOLUME I0131 13:49:52.311090 11950 driver.go:81] Enabling controller service capability: CREATE_DELETE_SNAPSHOT ... skipping 37 lines ... I0131 13:49:52.322031 11950 driver.go:81] Enabling controller service capability: LIST_SNAPSHOTS I0131 13:49:52.322035 11950 driver.go:81] Enabling controller service capability: CLONE_VOLUME I0131 13:49:52.322039 11950 driver.go:81] Enabling controller service capability: EXPAND_VOLUME I0131 13:49:52.322044 11950 driver.go:81] Enabling controller service capability: LIST_VOLUMES I0131 13:49:52.322047 11950 driver.go:81] Enabling controller service capability: LIST_VOLUMES_PUBLISHED_NODES I0131 13:49:52.322052 11950 driver.go:100] Enabling volume access mode: SINGLE_NODE_WRITER E0131 13:49:52.322616 11950 nodeserver_v2.go:543] mkdir failed on target: /home/prow/go/src/sigs.k8s.io/azuredisk-csi-driver/pkg/azuredisk/test (mkdir /home/prow/go/src/sigs.k8s.io/azuredisk-csi-driver/pkg/azuredisk/test: not a directory) --- PASS: TestEnsureBlockTargetFile (0.00s) === RUN TestMakeDir --- PASS: TestMakeDir (0.00s) === RUN TestGetDevicePathWithLUN W0131 13:49:52.322886 11950 fake_azuredisk_v2.go:57] Using DriverV2 I0131 13:49:52.325250 11950 driver.go:81] Enabling controller service capability: CREATE_DELETE_VOLUME ... skipping 47 lines ...