This job view page is being replaced by Spyglass soon. Check out the new job view.
PRandyzhangx: fix: switch base image to fix CVEs
ResultFAILURE
Tests 0 failed / 0 succeeded
Started2023-01-29 04:05
Elapsed2m53s
Revisioncf89f397b97f324f2562dcb6f175612715802606
Refs 1704

No Test Failures!


Error lines from build-log.txt

... 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
W0129 04:06:32.774351   11561 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/azure/scsi1/ failed, error: read /dev/disk/azure/scsi1/ error: bad dir
W0129 04:06:32.774447   11561 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:
W0129 04:06:32.781734   11561 azure_disk_utils.go:230] get kubeconfig() failed with error: open /var/run/secrets/kubernetes.io/serviceaccount/token: no such file or directory
I0129 04:06:32.785510   11561 driver.go:81] Enabling controller service capability: CREATE_DELETE_VOLUME
I0129 04:06:32.785536   11561 driver.go:81] Enabling controller service capability: PUBLISH_UNPUBLISH_VOLUME
I0129 04:06:32.785542   11561 driver.go:81] Enabling controller service capability: CREATE_DELETE_SNAPSHOT
I0129 04:06:32.785546   11561 driver.go:81] Enabling controller service capability: CLONE_VOLUME
I0129 04:06:32.785550   11561 driver.go:81] Enabling controller service capability: EXPAND_VOLUME
I0129 04:06:32.785557   11561 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:
W0129 04:06:32.790257   11561 azure_disk_utils.go:230] get kubeconfig() failed with error: open /var/run/secrets/kubernetes.io/serviceaccount/token: no such file or directory
I0129 04:06:32.793408   11561 driver.go:81] Enabling controller service capability: CREATE_DELETE_VOLUME
I0129 04:06:32.793442   11561 driver.go:81] Enabling controller service capability: PUBLISH_UNPUBLISH_VOLUME
I0129 04:06:32.793450   11561 driver.go:81] Enabling controller service capability: CREATE_DELETE_SNAPSHOT
I0129 04:06:32.793466   11561 driver.go:81] Enabling controller service capability: CLONE_VOLUME
I0129 04:06:32.793473   11561 driver.go:81] Enabling controller service capability: EXPAND_VOLUME
I0129 04:06:32.793480   11561 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:
W0129 04:06:32.794304   11561 azure_disk_utils.go:230] get kubeconfig() failed with error: open /var/run/secrets/kubernetes.io/serviceaccount/token: no such file or directory
E0129 04:06:33.034273   11561 util.go:138] Send.sendRequest: error in parsing response body string "": unexpected end of JSON input, Skip retrying regional host
E0129 04:06:33.034413   11561 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: 12d63da5-b8ea-427f-be63-99d524002800\r\nCorrelation ID: 0258dfab-e2fe-42db-8fc8-7d0b49cc7468\r\nTimestamp: 2023-01-29 04:06:32Z","error_codes":[90002],"timestamp":"2023-01-29 04:06:32Z","trace_id":"12d63da5-b8ea-427f-be63-99d524002800","correlation_id":"0258dfab-e2fe-42db-8fc8-7d0b49cc7468","error_uri":"https://login.microsoftonline.com/error?code=90002"} Endpoint https://login.microsoftonline.com/1234/oauth2/token
W0129 04:06:33.034459   11561 azuredisk.go:220] 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: 12d63da5-b8ea-427f-be63-99d524002800\r\nCorrelation ID: 0258dfab-e2fe-42db-8fc8-7d0b49cc7468\r\nTimestamp: 2023-01-29 04:06:32Z","error_codes":[90002],"timestamp":"2023-01-29 04:06:32Z","trace_id":"12d63da5-b8ea-427f-be63-99d524002800","correlation_id":"0258dfab-e2fe-42db-8fc8-7d0b49cc7468","error_uri":"https://login.microsoftonline.com/error?code=90002"} Endpoint https://login.microsoftonline.com/1234/oauth2/token
I0129 04:06:33.037908   11561 driver.go:81] Enabling controller service capability: CREATE_DELETE_VOLUME
I0129 04:06:33.037945   11561 driver.go:81] Enabling controller service capability: PUBLISH_UNPUBLISH_VOLUME
I0129 04:06:33.037950   11561 driver.go:81] Enabling controller service capability: CREATE_DELETE_SNAPSHOT
I0129 04:06:33.037954   11561 driver.go:81] Enabling controller service capability: CLONE_VOLUME
I0129 04:06:33.037958   11561 driver.go:81] Enabling controller service capability: EXPAND_VOLUME
I0129 04:06:33.037963   11561 driver.go:81] Enabling controller service capability: SINGLE_NODE_MULTI_WRITER
... skipping 258 lines ...
I0129 04:06:33.107846   11561 driver.go:81] Enabling controller service capability: LIST_SNAPSHOTS
I0129 04:06:33.107850   11561 driver.go:81] Enabling controller service capability: CLONE_VOLUME
I0129 04:06:33.107854   11561 driver.go:81] Enabling controller service capability: EXPAND_VOLUME
I0129 04:06:33.107858   11561 driver.go:81] Enabling controller service capability: LIST_VOLUMES
I0129 04:06:33.107861   11561 driver.go:81] Enabling controller service capability: LIST_VOLUMES_PUBLISHED_NODES
I0129 04:06:33.107867   11561 driver.go:100] Enabling volume access mode: SINGLE_NODE_WRITER
E0129 04:06:33.108031   11561 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
I0129 04:06:33.110715   11561 driver.go:81] Enabling controller service capability: CREATE_DELETE_VOLUME
I0129 04:06:33.110799   11561 driver.go:81] Enabling controller service capability: PUBLISH_UNPUBLISH_VOLUME
I0129 04:06:33.110820   11561 driver.go:81] Enabling controller service capability: CREATE_DELETE_SNAPSHOT
I0129 04:06:33.110835   11561 driver.go:81] Enabling controller service capability: LIST_SNAPSHOTS
... skipping 54 lines ...
I0129 04:06:33.124657   11561 driver.go:81] Enabling controller service capability: LIST_VOLUMES
I0129 04:06:33.124660   11561 driver.go:81] Enabling controller service capability: LIST_VOLUMES_PUBLISHED_NODES
I0129 04:06:33.124665   11561 driver.go:100] Enabling volume access mode: SINGLE_NODE_WRITER
=== RUN   TestControllerPublishVolume/diskName_error
=== RUN   TestControllerPublishVolume/NodeID_missing
=== RUN   TestControllerPublishVolume/failed_provisioning_state
W0129 04:06:33.125064   11561 controllerserver.go:392] VM(unit-test-node) is in failed state, update VM first
=== RUN   TestControllerPublishVolume/Volume_already_attached_success
I0129 04:06:33.127844   11561 driver.go:81] Enabling controller service capability: CREATE_DELETE_VOLUME
I0129 04:06:33.127869   11561 driver.go:81] Enabling controller service capability: PUBLISH_UNPUBLISH_VOLUME
I0129 04:06:33.127874   11561 driver.go:81] Enabling controller service capability: CREATE_DELETE_SNAPSHOT
I0129 04:06:33.127878   11561 driver.go:81] Enabling controller service capability: LIST_SNAPSHOTS
I0129 04:06:33.127881   11561 driver.go:81] Enabling controller service capability: CLONE_VOLUME
... skipping 671 lines ...
I0129 04:06:33.297202   11561 driver.go:81] Enabling controller service capability: LIST_SNAPSHOTS
I0129 04:06:33.297206   11561 driver.go:81] Enabling controller service capability: CLONE_VOLUME
I0129 04:06:33.297214   11561 driver.go:81] Enabling controller service capability: EXPAND_VOLUME
I0129 04:06:33.297219   11561 driver.go:81] Enabling controller service capability: LIST_VOLUMES
I0129 04:06:33.297222   11561 driver.go:81] Enabling controller service capability: LIST_VOLUMES_PUBLISHED_NODES
I0129 04:06:33.297227   11561 driver.go:100] Enabling volume access mode: SINGLE_NODE_WRITER
E0129 04:06:33.297292   11561 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
I0129 04:06:33.300093   11561 driver.go:81] Enabling controller service capability: CREATE_DELETE_VOLUME
I0129 04:06:33.300114   11561 driver.go:81] Enabling controller service capability: PUBLISH_UNPUBLISH_VOLUME
I0129 04:06:33.300119   11561 driver.go:81] Enabling controller service capability: CREATE_DELETE_SNAPSHOT
... skipping 11 lines ...
I0129 04:06:33.302937   11561 driver.go:81] Enabling controller service capability: CLONE_VOLUME
I0129 04:06:33.302946   11561 driver.go:81] Enabling controller service capability: EXPAND_VOLUME
I0129 04:06:33.302950   11561 driver.go:81] Enabling controller service capability: LIST_VOLUMES
I0129 04:06:33.302953   11561 driver.go:81] Enabling controller service capability: LIST_VOLUMES_PUBLISHED_NODES
I0129 04:06:33.302958   11561 driver.go:100] Enabling volume access mode: SINGLE_NODE_WRITER
W0129 04:06:33.303039   11561 azure_wrap.go:77] Unable to find node 185e8694-9f8a-11ed-84db-8e4167dcf6ad: instance not found
W0129 04:06:33.303058   11561 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
I0129 04:06:33.306123   11561 driver.go:81] Enabling controller service capability: CREATE_DELETE_VOLUME
I0129 04:06:33.306155   11561 driver.go:81] Enabling controller service capability: PUBLISH_UNPUBLISH_VOLUME
... skipping 12 lines ...
I0129 04:06:33.309255   11561 driver.go:81] Enabling controller service capability: LIST_SNAPSHOTS
I0129 04:06:33.309259   11561 driver.go:81] Enabling controller service capability: CLONE_VOLUME
I0129 04:06:33.309293   11561 driver.go:81] Enabling controller service capability: EXPAND_VOLUME
I0129 04:06:33.309297   11561 driver.go:81] Enabling controller service capability: LIST_VOLUMES
I0129 04:06:33.309308   11561 driver.go:81] Enabling controller service capability: LIST_VOLUMES_PUBLISHED_NODES
I0129 04:06:33.309313   11561 driver.go:100] Enabling volume access mode: SINGLE_NODE_WRITER
W0129 04:06:33.309507   11561 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/azure/scsi1/ failed, error: read /dev/disk/azure/scsi1/ error: bad dir
W0129 04:06:33.309529   11561 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/by-id/ failed, error: read /dev/disk/by-id/ error: bad dir
E0129 04:06:33.309569   11561 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'
W0129 04:06:33.309589   11561 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/azure/scsi1/ failed, error: read /dev/disk/azure/scsi1/ error: bad dir
W0129 04:06:33.309603   11561 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/by-id/ failed, error: read /dev/disk/by-id/ error: bad dir
W0129 04:06:33.309635   11561 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/azure/scsi1/ failed, error: read /dev/disk/azure/scsi1/ error: bad dir
W0129 04:06:33.309651   11561 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/by-id/ failed, error: read /dev/disk/by-id/ error: bad dir
W0129 04:06:33.309702   11561 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/azure/scsi1/ failed, error: read /dev/disk/azure/scsi1/ error: bad dir
W0129 04:06:33.309715   11561 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/by-id/ failed, error: read /dev/disk/by-id/ error: bad dir
I0129 04:06:33.309748   11561 mount_linux.go:529] Disk "/dev/sdd" appears to be unformatted, attempting to format as type: "ext4" with options: [-F -m0 /dev/sdd]
I0129 04:06:33.309772   11561 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
E0129 04:06:33.309786   11561 nodeserver.go:169] NodeStageVolume: could not determine if volume vol_1 needs to be resized: Failed readonly device check. Expected 1 or 0, got ''
W0129 04:06:33.309822   11561 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/azure/scsi1/ failed, error: read /dev/disk/azure/scsi1/ error: bad dir
W0129 04:06:33.309834   11561 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/by-id/ failed, error: read /dev/disk/by-id/ error: bad dir
W0129 04:06:33.309863   11561 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/azure/scsi1/ failed, error: read /dev/disk/azure/scsi1/ error: bad dir
W0129 04:06:33.309878   11561 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/by-id/ failed, error: read /dev/disk/by-id/ error: bad dir
E0129 04:06:33.309904   11561 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
I0129 04:06:33.312753   11561 driver.go:81] Enabling controller service capability: CREATE_DELETE_VOLUME
I0129 04:06:33.312786   11561 driver.go:81] Enabling controller service capability: PUBLISH_UNPUBLISH_VOLUME
I0129 04:06:33.312791   11561 driver.go:81] Enabling controller service capability: CREATE_DELETE_SNAPSHOT
I0129 04:06:33.312795   11561 driver.go:81] Enabling controller service capability: LIST_SNAPSHOTS
... skipping 11 lines ...
I0129 04:06:33.315790   11561 driver.go:81] Enabling controller service capability: LIST_SNAPSHOTS
I0129 04:06:33.315794   11561 driver.go:81] Enabling controller service capability: CLONE_VOLUME
I0129 04:06:33.315798   11561 driver.go:81] Enabling controller service capability: EXPAND_VOLUME
I0129 04:06:33.315801   11561 driver.go:81] Enabling controller service capability: LIST_VOLUMES
I0129 04:06:33.315805   11561 driver.go:81] Enabling controller service capability: LIST_VOLUMES_PUBLISHED_NODES
I0129 04:06:33.315809   11561 driver.go:100] Enabling volume access mode: SINGLE_NODE_WRITER
E0129 04:06:33.315947   11561 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
I0129 04:06:33.318929   11561 driver.go:81] Enabling controller service capability: CREATE_DELETE_VOLUME
I0129 04:06:33.318960   11561 driver.go:81] Enabling controller service capability: PUBLISH_UNPUBLISH_VOLUME
I0129 04:06:33.318965   11561 driver.go:81] Enabling controller service capability: CREATE_DELETE_SNAPSHOT
I0129 04:06:33.318974   11561 driver.go:81] Enabling controller service capability: LIST_SNAPSHOTS
... skipping 33 lines ...
I0129 04:06:33.333478   11561 driver.go:81] Enabling controller service capability: LIST_SNAPSHOTS
I0129 04:06:33.333483   11561 driver.go:81] Enabling controller service capability: CLONE_VOLUME
I0129 04:06:33.333489   11561 driver.go:81] Enabling controller service capability: EXPAND_VOLUME
I0129 04:06:33.333494   11561 driver.go:81] Enabling controller service capability: LIST_VOLUMES
I0129 04:06:33.333499   11561 driver.go:81] Enabling controller service capability: LIST_VOLUMES_PUBLISHED_NODES
I0129 04:06:33.333506   11561 driver.go:100] Enabling volume access mode: SINGLE_NODE_WRITER
E0129 04:06:33.334067   11561 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
I0129 04:06:33.337049   11561 driver.go:81] Enabling controller service capability: CREATE_DELETE_VOLUME
I0129 04:06:33.337077   11561 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
W0129 04:06:30.898964   11552 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
W0129 04:06:30.899134   11552 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
W0129 04:06:30.899229   11552 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.007s	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
W0129 04:06:38.938046   11913 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/azure/scsi1/ failed, error: read /dev/disk/azure/scsi1/ error: bad dir
W0129 04:06:38.938116   11913 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:
W0129 04:06:38.945547   11913 azure_disk_utils.go:230] get kubeconfig() failed with error: open /var/run/secrets/kubernetes.io/serviceaccount/token: no such file or directory
I0129 04:06:38.950071   11913 driver.go:81] Enabling controller service capability: CREATE_DELETE_VOLUME
I0129 04:06:38.950098   11913 driver.go:81] Enabling controller service capability: PUBLISH_UNPUBLISH_VOLUME
I0129 04:06:38.950105   11913 driver.go:81] Enabling controller service capability: CREATE_DELETE_SNAPSHOT
I0129 04:06:38.950110   11913 driver.go:81] Enabling controller service capability: LIST_SNAPSHOTS
I0129 04:06:38.950121   11913 driver.go:81] Enabling controller service capability: CLONE_VOLUME
I0129 04:06:38.950128   11913 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:
W0129 04:06:38.955277   11913 azure_disk_utils.go:230] get kubeconfig() failed with error: open /var/run/secrets/kubernetes.io/serviceaccount/token: no such file or directory
I0129 04:06:38.958075   11913 driver.go:81] Enabling controller service capability: CREATE_DELETE_VOLUME
I0129 04:06:38.958101   11913 driver.go:81] Enabling controller service capability: PUBLISH_UNPUBLISH_VOLUME
I0129 04:06:38.958105   11913 driver.go:81] Enabling controller service capability: CREATE_DELETE_SNAPSHOT
I0129 04:06:38.958114   11913 driver.go:81] Enabling controller service capability: LIST_SNAPSHOTS
I0129 04:06:38.958117   11913 driver.go:81] Enabling controller service capability: CLONE_VOLUME
I0129 04:06:38.958123   11913 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:
W0129 04:06:38.958715   11913 azure_disk_utils.go:230] get kubeconfig() failed with error: open /var/run/secrets/kubernetes.io/serviceaccount/token: no such file or directory
E0129 04:06:39.244013   11913 util.go:138] Send.sendRequest: error in parsing response body string "": unexpected end of JSON input, Skip retrying regional host
E0129 04:06:39.244183   11913 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: abb4614d-5039-4c62-a2c8-2dfd858a2800\r\nCorrelation ID: 99ae8748-f9c6-43a3-ad95-d4675bfc32f8\r\nTimestamp: 2023-01-29 04:06:39Z","error_codes":[90002],"timestamp":"2023-01-29 04:06:39Z","trace_id":"abb4614d-5039-4c62-a2c8-2dfd858a2800","correlation_id":"99ae8748-f9c6-43a3-ad95-d4675bfc32f8","error_uri":"https://login.microsoftonline.com/error?code=90002"} Endpoint https://login.microsoftonline.com/1234/oauth2/token
W0129 04:06:39.244211   11913 azuredisk.go:220] 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: abb4614d-5039-4c62-a2c8-2dfd858a2800\r\nCorrelation ID: 99ae8748-f9c6-43a3-ad95-d4675bfc32f8\r\nTimestamp: 2023-01-29 04:06:39Z","error_codes":[90002],"timestamp":"2023-01-29 04:06:39Z","trace_id":"abb4614d-5039-4c62-a2c8-2dfd858a2800","correlation_id":"99ae8748-f9c6-43a3-ad95-d4675bfc32f8","error_uri":"https://login.microsoftonline.com/error?code=90002"} Endpoint https://login.microsoftonline.com/1234/oauth2/token
I0129 04:06:39.247244   11913 driver.go:81] Enabling controller service capability: CREATE_DELETE_VOLUME
I0129 04:06:39.247274   11913 driver.go:81] Enabling controller service capability: PUBLISH_UNPUBLISH_VOLUME
I0129 04:06:39.247281   11913 driver.go:81] Enabling controller service capability: CREATE_DELETE_SNAPSHOT
I0129 04:06:39.247301   11913 driver.go:81] Enabling controller service capability: CLONE_VOLUME
I0129 04:06:39.247307   11913 driver.go:81] Enabling controller service capability: EXPAND_VOLUME
I0129 04:06:39.247318   11913 driver.go:81] Enabling controller service capability: SINGLE_NODE_MULTI_WRITER
... skipping 254 lines ...
I0129 04:06:39.309363   11913 driver.go:81] Enabling controller service capability: LIST_SNAPSHOTS
I0129 04:06:39.309371   11913 driver.go:81] Enabling controller service capability: CLONE_VOLUME
I0129 04:06:39.309377   11913 driver.go:81] Enabling controller service capability: EXPAND_VOLUME
I0129 04:06:39.309382   11913 driver.go:81] Enabling controller service capability: LIST_VOLUMES
I0129 04:06:39.309387   11913 driver.go:81] Enabling controller service capability: LIST_VOLUMES_PUBLISHED_NODES
I0129 04:06:39.309393   11913 driver.go:100] Enabling volume access mode: SINGLE_NODE_WRITER
E0129 04:06:39.309613   11913 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
W0129 04:06:39.309712   11913 fake_azuredisk_v2.go:57] Using DriverV2
I0129 04:06:39.312176   11913 driver.go:81] Enabling controller service capability: CREATE_DELETE_VOLUME
I0129 04:06:39.312196   11913 driver.go:81] Enabling controller service capability: PUBLISH_UNPUBLISH_VOLUME
I0129 04:06:39.312200   11913 driver.go:81] Enabling controller service capability: CREATE_DELETE_SNAPSHOT
... skipping 60 lines ...
I0129 04:06:39.326208   11913 driver.go:81] Enabling controller service capability: LIST_VOLUMES
I0129 04:06:39.326211   11913 driver.go:81] Enabling controller service capability: LIST_VOLUMES_PUBLISHED_NODES
I0129 04:06:39.326221   11913 driver.go:100] Enabling volume access mode: SINGLE_NODE_WRITER
=== RUN   TestControllerPublishVolume/diskName_error
=== RUN   TestControllerPublishVolume/NodeID_missing
=== RUN   TestControllerPublishVolume/failed_provisioning_state
W0129 04:06:39.326738   11913 controllerserver_v2.go:341] VM(unit-test-node) is in failed state, update VM first
=== RUN   TestControllerPublishVolume/Volume_already_attached_success
W0129 04:06:39.326921   11913 fake_azuredisk_v2.go:57] Using DriverV2
I0129 04:06:39.329823   11913 driver.go:81] Enabling controller service capability: CREATE_DELETE_VOLUME
I0129 04:06:39.329851   11913 driver.go:81] Enabling controller service capability: PUBLISH_UNPUBLISH_VOLUME
I0129 04:06:39.329860   11913 driver.go:81] Enabling controller service capability: CREATE_DELETE_SNAPSHOT
I0129 04:06:39.329864   11913 driver.go:81] Enabling controller service capability: LIST_SNAPSHOTS
... skipping 731 lines ...
I0129 04:06:39.507971   11913 driver.go:81] Enabling controller service capability: LIST_SNAPSHOTS
I0129 04:06:39.507974   11913 driver.go:81] Enabling controller service capability: CLONE_VOLUME
I0129 04:06:39.507979   11913 driver.go:81] Enabling controller service capability: EXPAND_VOLUME
I0129 04:06:39.507985   11913 driver.go:81] Enabling controller service capability: LIST_VOLUMES
I0129 04:06:39.507989   11913 driver.go:81] Enabling controller service capability: LIST_VOLUMES_PUBLISHED_NODES
I0129 04:06:39.507993   11913 driver.go:100] Enabling volume access mode: SINGLE_NODE_WRITER
E0129 04:06:39.508053   11913 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
W0129 04:06:39.508481   11913 fake_azuredisk_v2.go:57] Using DriverV2
I0129 04:06:39.511057   11913 driver.go:81] Enabling controller service capability: CREATE_DELETE_VOLUME
I0129 04:06:39.511081   11913 driver.go:81] Enabling controller service capability: PUBLISH_UNPUBLISH_VOLUME
... skipping 13 lines ...
I0129 04:06:39.514617   11913 driver.go:81] Enabling controller service capability: CLONE_VOLUME
I0129 04:06:39.514691   11913 driver.go:81] Enabling controller service capability: EXPAND_VOLUME
I0129 04:06:39.514759   11913 driver.go:81] Enabling controller service capability: LIST_VOLUMES
I0129 04:06:39.514799   11913 driver.go:81] Enabling controller service capability: LIST_VOLUMES_PUBLISHED_NODES
I0129 04:06:39.514821   11913 driver.go:100] Enabling volume access mode: SINGLE_NODE_WRITER
W0129 04:06:39.514944   11913 azure_wrap.go:77] Unable to find node 185e8694-9f8a-11ed-84db-8e4167dcf6ad: instance not found
W0129 04:06:39.514996   11913 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
W0129 04:06:39.515380   11913 fake_azuredisk_v2.go:57] Using DriverV2
I0129 04:06:39.518130   11913 driver.go:81] Enabling controller service capability: CREATE_DELETE_VOLUME
... skipping 14 lines ...
I0129 04:06:39.521147   11913 driver.go:81] Enabling controller service capability: LIST_SNAPSHOTS
I0129 04:06:39.521151   11913 driver.go:81] Enabling controller service capability: CLONE_VOLUME
I0129 04:06:39.521156   11913 driver.go:81] Enabling controller service capability: EXPAND_VOLUME
I0129 04:06:39.521160   11913 driver.go:81] Enabling controller service capability: LIST_VOLUMES
I0129 04:06:39.521164   11913 driver.go:81] Enabling controller service capability: LIST_VOLUMES_PUBLISHED_NODES
I0129 04:06:39.521168   11913 driver.go:100] Enabling volume access mode: SINGLE_NODE_WRITER
W0129 04:06:39.521392   11913 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/azure/scsi1/ failed, error: read /dev/disk/azure/scsi1/ error: bad dir
W0129 04:06:39.521416   11913 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/by-id/ failed, error: read /dev/disk/by-id/ error: bad dir
E0129 04:06:39.521472   11913 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'
W0129 04:06:39.521507   11913 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/azure/scsi1/ failed, error: read /dev/disk/azure/scsi1/ error: bad dir
W0129 04:06:39.521514   11913 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/by-id/ failed, error: read /dev/disk/by-id/ error: bad dir
W0129 04:06:39.521549   11913 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/azure/scsi1/ failed, error: read /dev/disk/azure/scsi1/ error: bad dir
W0129 04:06:39.521563   11913 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/by-id/ failed, error: read /dev/disk/by-id/ error: bad dir
W0129 04:06:39.521612   11913 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/azure/scsi1/ failed, error: read /dev/disk/azure/scsi1/ error: bad dir
W0129 04:06:39.521665   11913 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/by-id/ failed, error: read /dev/disk/by-id/ error: bad dir
I0129 04:06:39.521710   11913 mount_linux.go:529] Disk "/dev/sdd" appears to be unformatted, attempting to format as type: "ext4" with options: [-F -m0 /dev/sdd]
I0129 04:06:39.521728   11913 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
E0129 04:06:39.521741   11913 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 ''
W0129 04:06:39.521795   11913 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/azure/scsi1/ failed, error: read /dev/disk/azure/scsi1/ error: bad dir
W0129 04:06:39.521803   11913 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/by-id/ failed, error: read /dev/disk/by-id/ error: bad dir
W0129 04:06:39.521834   11913 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/azure/scsi1/ failed, error: read /dev/disk/azure/scsi1/ error: bad dir
W0129 04:06:39.521848   11913 azure_common_linux.go:188] azureDisk - getDiskLinkByDevName by sdd under /dev/disk/by-id/ failed, error: read /dev/disk/by-id/ error: bad dir
E0129 04:06:39.521876   11913 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
W0129 04:06:39.522051   11913 fake_azuredisk_v2.go:57] Using DriverV2
I0129 04:06:39.524633   11913 driver.go:81] Enabling controller service capability: CREATE_DELETE_VOLUME
I0129 04:06:39.524656   11913 driver.go:81] Enabling controller service capability: PUBLISH_UNPUBLISH_VOLUME
I0129 04:06:39.524661   11913 driver.go:81] Enabling controller service capability: CREATE_DELETE_SNAPSHOT
... skipping 13 lines ...
I0129 04:06:39.528034   11913 driver.go:81] Enabling controller service capability: LIST_SNAPSHOTS
I0129 04:06:39.528037   11913 driver.go:81] Enabling controller service capability: CLONE_VOLUME
I0129 04:06:39.528047   11913 driver.go:81] Enabling controller service capability: EXPAND_VOLUME
I0129 04:06:39.528051   11913 driver.go:81] Enabling controller service capability: LIST_VOLUMES
I0129 04:06:39.528055   11913 driver.go:81] Enabling controller service capability: LIST_VOLUMES_PUBLISHED_NODES
I0129 04:06:39.528059   11913 driver.go:100] Enabling volume access mode: SINGLE_NODE_WRITER
E0129 04:06:39.528232   11913 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
W0129 04:06:39.528581   11913 fake_azuredisk_v2.go:57] Using DriverV2
I0129 04:06:39.531425   11913 driver.go:81] Enabling controller service capability: CREATE_DELETE_VOLUME
I0129 04:06:39.531453   11913 driver.go:81] Enabling controller service capability: PUBLISH_UNPUBLISH_VOLUME
I0129 04:06:39.531459   11913 driver.go:81] Enabling controller service capability: CREATE_DELETE_SNAPSHOT
... skipping 37 lines ...
I0129 04:06:39.543395   11913 driver.go:81] Enabling controller service capability: LIST_SNAPSHOTS
I0129 04:06:39.543401   11913 driver.go:81] Enabling controller service capability: CLONE_VOLUME
I0129 04:06:39.543409   11913 driver.go:81] Enabling controller service capability: EXPAND_VOLUME
I0129 04:06:39.543414   11913 driver.go:81] Enabling controller service capability: LIST_VOLUMES
I0129 04:06:39.543418   11913 driver.go:81] Enabling controller service capability: LIST_VOLUMES_PUBLISHED_NODES
I0129 04:06:39.543430   11913 driver.go:100] Enabling volume access mode: SINGLE_NODE_WRITER
E0129 04:06:39.544026   11913 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
W0129 04:06:39.544258   11913 fake_azuredisk_v2.go:57] Using DriverV2
I0129 04:06:39.547093   11913 driver.go:81] Enabling controller service capability: CREATE_DELETE_VOLUME
... skipping 1114 lines ...
azuredisk-csi-driver/azuredisk-csi-driver	v1.0.0       	v1.0.0     	Azure disk Container Storage Interface (CSI) St...
helm chart index verified.
Running helm lint
==> Linting /home/prow/go/src/sigs.k8s.io/azuredisk-csi-driver/charts/latest/azuredisk-csi-driver
[INFO] Chart.yaml: icon is recommended

1 chart(s) linted, 0 chart(s) failed
Comparing image version between helm chart and manifests in deploy folder
Collecting argcomplete==2.0.0
  Downloading argcomplete-2.0.0-py2.py3-none-any.whl (37 kB)
Collecting importlib-metadata==0.23
  Downloading importlib_metadata-0.23-py2.py3-none-any.whl (28 kB)
Collecting pyyaml==6.0
... skipping 5 lines ...
  Downloading xmltodict-0.13.0-py2.py3-none-any.whl (10.0 kB)
Collecting yq==3.1.0
  Downloading yq-3.1.0-py3-none-any.whl (17 kB)
Collecting zipp==3.11.0
  Downloading zipp-3.11.0-py3-none-any.whl (6.6 kB)
Installing collected packages: zipp, xmltodict, toml, pyyaml, importlib-metadata, argcomplete, yq
ERROR: pip's dependency resolver does not currently take into account all the packages that are installed. This behaviour is the source of the following dependency conflicts.
awscli 1.27.50 requires PyYAML<5.5,>=3.10, but you have pyyaml 6.0 which is incompatible.
Successfully installed argcomplete-2.0.0 importlib-metadata-0.23 pyyaml-6.0 toml-0.10.2 xmltodict-0.13.0 yq-3.1.0 zipp-3.11.0
WARNING: Running pip as the 'root' user can result in broken permissions and conflicting behaviour with the system package manager. It is recommended to use a virtual environment instead: https://pip.pypa.io/warnings/venv

[notice] A new release of pip available: 22.3 -> 22.3.1
[notice] To update, run: python3 -m pip install --upgrade pip
Images in deploy/ matches those in the latest helm chart.
begin to verify all URLs in /home/prow/go/src/sigs.k8s.io/azuredisk-csi-driver/charts/index.yaml ...
make: *** [Makefile:85: verify] Error 28
+ EXIT_VALUE=2
+ set +o xtrace