This job view page is being replaced by Spyglass soon. Check out the new job view.
PRandyzhangx: fix: filesystem is not resized when restoring from snapshot with a bigger size
ResultABORTED
Tests 0 failed / 0 succeeded
Started2022-05-01 13:04
Elapsed43m45s
Revisionb9079ac367a70b52c1cb25345e856049980910d8
Refs 1309

No Test Failures!


Error lines from build-log.txt

... skipping 222 lines ...

  0     0    0     0    0     0      0      0 --:--:-- --:--:-- --:--:--     0
100 11156  100 11156    0     0   201k      0 --:--:-- --:--:-- --:--:--  201k
Downloading https://get.helm.sh/helm-v3.8.2-linux-amd64.tar.gz
Verifying checksum... Done.
Preparing to install helm into /usr/local/bin
helm installed into /usr/local/bin/helm
docker pull k8sprow.azurecr.io/azuredisk-csi:v1.18.0-59de170d5999bf1826de94c94c24f912e8346dd3 || make container-all push-manifest
Error response from daemon: manifest for k8sprow.azurecr.io/azuredisk-csi:v1.18.0-59de170d5999bf1826de94c94c24f912e8346dd3 not found: manifest unknown: manifest tagged by "v1.18.0-59de170d5999bf1826de94c94c24f912e8346dd3" is not found
make[2]: Entering directory '/home/prow/go/src/sigs.k8s.io/azuredisk-csi-driver'
CGO_ENABLED=0 GOOS=windows go build -a -ldflags "-X sigs.k8s.io/azuredisk-csi-driver/pkg/azuredisk.driverVersion=v1.18.0-59de170d5999bf1826de94c94c24f912e8346dd3 -X sigs.k8s.io/azuredisk-csi-driver/pkg/azuredisk.gitCommit=59de170d5999bf1826de94c94c24f912e8346dd3 -X sigs.k8s.io/azuredisk-csi-driver/pkg/azuredisk.buildDate=2022-05-01T13:09:52Z -extldflags "-static""  -mod vendor -o _output/amd64/azurediskplugin.exe ./pkg/azurediskplugin
docker buildx rm container-builder || true
error: no builder "container-builder" found
docker buildx create --use --name=container-builder
container-builder
# enable qemu for arm64 build
# https://github.com/docker/buildx/issues/464#issuecomment-741507760
docker run --privileged --rm tonistiigi/binfmt --uninstall qemu-aarch64
Unable to find image 'tonistiigi/binfmt:latest' locally
... skipping 1616 lines ...
                    type: string
                type: object
                oneOf:
                - required: ["persistentVolumeClaimName"]
                - required: ["volumeSnapshotContentName"]
              volumeSnapshotClassName:
                description: 'VolumeSnapshotClassName is the name of the VolumeSnapshotClass requested by the VolumeSnapshot. VolumeSnapshotClassName may be left nil to indicate that the default SnapshotClass should be used. A given cluster may have multiple default Volume SnapshotClasses: one default per CSI Driver. If a VolumeSnapshot does not specify a SnapshotClass, VolumeSnapshotSource will be checked to figure out what the associated CSI Driver is, and the default VolumeSnapshotClass associated with that CSI Driver will be used. If more than one VolumeSnapshotClass exist for a given CSI Driver and more than one have been marked as default, CreateSnapshot will fail and generate an event. Empty string is not allowed for this field.'
                type: string
            required:
            - source
            type: object
          status:
            description: status represents the current information of a snapshot. Consumers must verify binding between VolumeSnapshot and VolumeSnapshotContent objects is successful (by validating that both VolumeSnapshot and VolumeSnapshotContent point at each other) before using this object.
... skipping 2 lines ...
                description: 'boundVolumeSnapshotContentName is the name of the VolumeSnapshotContent object to which this VolumeSnapshot object intends to bind to. If not specified, it indicates that the VolumeSnapshot object has not been successfully bound to a VolumeSnapshotContent object yet. NOTE: To avoid possible security issues, consumers must verify binding between VolumeSnapshot and VolumeSnapshotContent objects is successful (by validating that both VolumeSnapshot and VolumeSnapshotContent point at each other) before using this object.'
                type: string
              creationTime:
                description: creationTime is the timestamp when the point-in-time snapshot is taken by the underlying storage system. In dynamic snapshot creation case, this field will be filled in by the snapshot controller with the "creation_time" value returned from CSI "CreateSnapshot" gRPC call. For a pre-existing snapshot, this field will be filled with the "creation_time" value returned from the CSI "ListSnapshots" gRPC call if the driver supports it. If not specified, it may indicate that the creation time of the snapshot is unknown.
                format: date-time
                type: string
              error:
                description: error is the last observed error during snapshot creation, if any. This field could be helpful to upper level controllers(i.e., application controller) to decide whether they should continue on waiting for the snapshot to be created based on the type of error reported. The snapshot controller will keep retrying when an error occurrs during the snapshot creation. Upon success, this error field will be cleared.
                properties:
                  message:
                    description: 'message is a string detailing the encountered error during snapshot creation if specified. NOTE: message may be logged, and it should not contain sensitive information.'
                    type: string
                  time:
                    description: time is the timestamp when the error was encountered.
                    format: date-time
                    type: string
                type: object
              readyToUse:
                description: readyToUse indicates if the snapshot is ready to be used to restore a volume. In dynamic snapshot creation case, this field will be filled in by the snapshot controller with the "ready_to_use" value returned from CSI "CreateSnapshot" gRPC call. For a pre-existing snapshot, this field will be filled with the "ready_to_use" value returned from the CSI "ListSnapshots" gRPC call if the driver supports it, otherwise, this field will be set to "True". If not specified, it means the readiness of a snapshot is unknown.
                type: boolean
              restoreSize:
                type: string
                description: restoreSize represents the minimum size of volume required to create a volume from this snapshot. In dynamic snapshot creation case, this field will be filled in by the snapshot controller with the "size_bytes" value returned from CSI "CreateSnapshot" gRPC call. For a pre-existing snapshot, this field will be filled with the "size_bytes" value returned from the CSI "ListSnapshots" gRPC call if the driver supports it. When restoring a volume from this snapshot, the size of the volume MUST NOT be smaller than the restoreSize if it is specified, otherwise the restoration will fail. If not specified, it indicates that the size is unknown.
                pattern: ^(\+|-)?(([0-9]+(\.[0-9]*)?)|(\.[0-9]+))(([KMGTPE]i)|[numkMGTPE]|([eE](\+|-)?(([0-9]+(\.[0-9]*)?)|(\.[0-9]+))))?$
                x-kubernetes-int-or-string: true
            type: object
        required:
        - spec
        type: object
... skipping 60 lines ...
                    type: string
                  volumeSnapshotContentName:
                    description: volumeSnapshotContentName specifies the name of a pre-existing VolumeSnapshotContent object representing an existing volume snapshot. This field should be set if the snapshot already exists and only needs a representation in Kubernetes. This field is immutable.
                    type: string
                type: object
              volumeSnapshotClassName:
                description: 'VolumeSnapshotClassName is the name of the VolumeSnapshotClass requested by the VolumeSnapshot. VolumeSnapshotClassName may be left nil to indicate that the default SnapshotClass should be used. A given cluster may have multiple default Volume SnapshotClasses: one default per CSI Driver. If a VolumeSnapshot does not specify a SnapshotClass, VolumeSnapshotSource will be checked to figure out what the associated CSI Driver is, and the default VolumeSnapshotClass associated with that CSI Driver will be used. If more than one VolumeSnapshotClass exist for a given CSI Driver and more than one have been marked as default, CreateSnapshot will fail and generate an event. Empty string is not allowed for this field.'
                type: string
            required:
            - source
            type: object
          status:
            description: status represents the current information of a snapshot. Consumers must verify binding between VolumeSnapshot and VolumeSnapshotContent objects is successful (by validating that both VolumeSnapshot and VolumeSnapshotContent point at each other) before using this object.
... skipping 2 lines ...
                description: 'boundVolumeSnapshotContentName is the name of the VolumeSnapshotContent object to which this VolumeSnapshot object intends to bind to. If not specified, it indicates that the VolumeSnapshot object has not been successfully bound to a VolumeSnapshotContent object yet. NOTE: To avoid possible security issues, consumers must verify binding between VolumeSnapshot and VolumeSnapshotContent objects is successful (by validating that both VolumeSnapshot and VolumeSnapshotContent point at each other) before using this object.'
                type: string
              creationTime:
                description: creationTime is the timestamp when the point-in-time snapshot is taken by the underlying storage system. In dynamic snapshot creation case, this field will be filled in by the snapshot controller with the "creation_time" value returned from CSI "CreateSnapshot" gRPC call. For a pre-existing snapshot, this field will be filled with the "creation_time" value returned from the CSI "ListSnapshots" gRPC call if the driver supports it. If not specified, it may indicate that the creation time of the snapshot is unknown.
                format: date-time
                type: string
              error:
                description: error is the last observed error during snapshot creation, if any. This field could be helpful to upper level controllers(i.e., application controller) to decide whether they should continue on waiting for the snapshot to be created based on the type of error reported. The snapshot controller will keep retrying when an error occurrs during the snapshot creation. Upon success, this error field will be cleared.
                properties:
                  message:
                    description: 'message is a string detailing the encountered error during snapshot creation if specified. NOTE: message may be logged, and it should not contain sensitive information.'
                    type: string
                  time:
                    description: time is the timestamp when the error was encountered.
                    format: date-time
                    type: string
                type: object
              readyToUse:
                description: readyToUse indicates if the snapshot is ready to be used to restore a volume. In dynamic snapshot creation case, this field will be filled in by the snapshot controller with the "ready_to_use" value returned from CSI "CreateSnapshot" gRPC call. For a pre-existing snapshot, this field will be filled with the "ready_to_use" value returned from the CSI "ListSnapshots" gRPC call if the driver supports it, otherwise, this field will be set to "True". If not specified, it means the readiness of a snapshot is unknown.
                type: boolean
              restoreSize:
                type: string
                description: restoreSize represents the minimum size of volume required to create a volume from this snapshot. In dynamic snapshot creation case, this field will be filled in by the snapshot controller with the "size_bytes" value returned from CSI "CreateSnapshot" gRPC call. For a pre-existing snapshot, this field will be filled with the "size_bytes" value returned from the CSI "ListSnapshots" gRPC call if the driver supports it. When restoring a volume from this snapshot, the size of the volume MUST NOT be smaller than the restoreSize if it is specified, otherwise the restoration will fail. If not specified, it indicates that the size is unknown.
                pattern: ^(\+|-)?(([0-9]+(\.[0-9]*)?)|(\.[0-9]+))(([KMGTPE]i)|[numkMGTPE]|([eE](\+|-)?(([0-9]+(\.[0-9]*)?)|(\.[0-9]+))))?$
                x-kubernetes-int-or-string: true
            type: object
        required:
        - spec
        type: object
... skipping 254 lines ...
            description: status represents the current information of a snapshot.
            properties:
              creationTime:
                description: creationTime is the timestamp when the point-in-time snapshot is taken by the underlying storage system. In dynamic snapshot creation case, this field will be filled in by the CSI snapshotter sidecar with the "creation_time" value returned from CSI "CreateSnapshot" gRPC call. For a pre-existing snapshot, this field will be filled with the "creation_time" value returned from the CSI "ListSnapshots" gRPC call if the driver supports it. If not specified, it indicates the creation time is unknown. The format of this field is a Unix nanoseconds time encoded as an int64. On Unix, the command `date +%s%N` returns the current time in nanoseconds since 1970-01-01 00:00:00 UTC.
                format: int64
                type: integer
              error:
                description: error is the last observed error during snapshot creation, if any. Upon success after retry, this error field will be cleared.
                properties:
                  message:
                    description: 'message is a string detailing the encountered error during snapshot creation if specified. NOTE: message may be logged, and it should not contain sensitive information.'
                    type: string
                  time:
                    description: time is the timestamp when the error was encountered.
                    format: date-time
                    type: string
                type: object
              readyToUse:
                description: readyToUse indicates if a snapshot is ready to be used to restore a volume. In dynamic snapshot creation case, this field will be filled in by the CSI snapshotter sidecar with the "ready_to_use" value returned from CSI "CreateSnapshot" gRPC call. For a pre-existing snapshot, this field will be filled with the "ready_to_use" value returned from the CSI "ListSnapshots" gRPC call if the driver supports it, otherwise, this field will be set to "True". If not specified, it means the readiness of a snapshot is unknown.
                type: boolean
              restoreSize:
                description: restoreSize represents the complete size of the snapshot in bytes. In dynamic snapshot creation case, this field will be filled in by the CSI snapshotter sidecar with the "size_bytes" value returned from CSI "CreateSnapshot" gRPC call. For a pre-existing snapshot, this field will be filled with the "size_bytes" value returned from the CSI "ListSnapshots" gRPC call if the driver supports it. When restoring a volume from this snapshot, the size of the volume MUST NOT be smaller than the restoreSize if it is specified, otherwise the restoration will fail. If not specified, it indicates that the size is unknown.
                format: int64
                minimum: 0
                type: integer
              snapshotHandle:
                description: snapshotHandle is the CSI "snapshot_id" of a snapshot on the underlying storage system. If not specified, it indicates that dynamic snapshot creation has either failed or it is still in progress.
                type: string
            type: object
        required:
        - spec
        type: object
    served: true
... skipping 108 lines ...
            description: status represents the current information of a snapshot.
            properties:
              creationTime:
                description: creationTime is the timestamp when the point-in-time snapshot is taken by the underlying storage system. In dynamic snapshot creation case, this field will be filled in by the CSI snapshotter sidecar with the "creation_time" value returned from CSI "CreateSnapshot" gRPC call. For a pre-existing snapshot, this field will be filled with the "creation_time" value returned from the CSI "ListSnapshots" gRPC call if the driver supports it. If not specified, it indicates the creation time is unknown. The format of this field is a Unix nanoseconds time encoded as an int64. On Unix, the command `date +%s%N` returns the current time in nanoseconds since 1970-01-01 00:00:00 UTC.
                format: int64
                type: integer
              error:
                description: error is the last observed error during snapshot creation, if any. Upon success after retry, this error field will be cleared.
                properties:
                  message:
                    description: 'message is a string detailing the encountered error during snapshot creation if specified. NOTE: message may be logged, and it should not contain sensitive information.'
                    type: string
                  time:
                    description: time is the timestamp when the error was encountered.
                    format: date-time
                    type: string
                type: object
              readyToUse:
                description: readyToUse indicates if a snapshot is ready to be used to restore a volume. In dynamic snapshot creation case, this field will be filled in by the CSI snapshotter sidecar with the "ready_to_use" value returned from CSI "CreateSnapshot" gRPC call. For a pre-existing snapshot, this field will be filled with the "ready_to_use" value returned from the CSI "ListSnapshots" gRPC call if the driver supports it, otherwise, this field will be set to "True". If not specified, it means the readiness of a snapshot is unknown.
                type: boolean
              restoreSize:
                description: restoreSize represents the complete size of the snapshot in bytes. In dynamic snapshot creation case, this field will be filled in by the CSI snapshotter sidecar with the "size_bytes" value returned from CSI "CreateSnapshot" gRPC call. For a pre-existing snapshot, this field will be filled with the "size_bytes" value returned from the CSI "ListSnapshots" gRPC call if the driver supports it. When restoring a volume from this snapshot, the size of the volume MUST NOT be smaller than the restoreSize if it is specified, otherwise the restoration will fail. If not specified, it indicates that the size is unknown.
                format: int64
                minimum: 0
                type: integer
              snapshotHandle:
                description: snapshotHandle is the CSI "snapshot_id" of a snapshot on the underlying storage system. If not specified, it indicates that dynamic snapshot creation has either failed or it is still in progress.
                type: string
            type: object
        required:
        - spec
        type: object
    served: true
... skipping 861 lines ...
          image: "mcr.microsoft.com/oss/kubernetes-csi/csi-resizer:v1.4.0"
          args:
            - "-csi-address=$(ADDRESS)"
            - "-v=2"
            - "-leader-election"
            - "--leader-election-namespace=kube-system"
            - '-handle-volume-inuse-error=false'
            - '-feature-gates=RecoverVolumeExpansionFailure=true'
            - "-timeout=240s"
          env:
            - name: ADDRESS
              value: /csi/csi.sock
          volumeMounts:
... skipping 214 lines ...

S [SKIPPING] in Spec Setup (BeforeEach) [0.001 seconds]
External Storage [Driver: test.csi.azure.com]
/workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:174
  [Testpattern: Pre-provisioned PV (default fs)] subPath
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should fail if non-existent subpath is outside the volume [Slow][LinuxOnly] [BeforeEach]
    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:267

    Driver "test.csi.azure.com" does not support volume type "PreprovisionedPV" - skipping

    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:262
------------------------------
... skipping 128 lines ...

S [SKIPPING] in Spec Setup (BeforeEach) [0.001 seconds]
External Storage [Driver: test.csi.azure.com]
/workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:174
  [Testpattern: Dynamic PV (ntfs)][Feature:Windows] subPath
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should fail if non-existent subpath is outside the volume [Slow][LinuxOnly] [BeforeEach]
    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:267

    Distro debian doesn't support ntfs -- skipping

    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:127
------------------------------
... skipping 149 lines ...
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:186
May  1 13:18:47.890: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
STEP: Destroying namespace "volumelimits-6234" for this suite.

•
------------------------------
{"msg":"PASSED External Storage [Driver: test.csi.azure.com] [Testpattern: Dynamic PV (filesystem volmode)] volumeLimits should verify that all csinodes have volume limits","total":29,"completed":1,"skipped":192,"failed":0}

SSSSSSSSSSSSSSSSS
------------------------------
External Storage [Driver: test.csi.azure.com] [Testpattern: Dynamic PV (ext3)] volumes 
  should allow exec of files on the volume
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/volumes.go:196
... skipping 19 lines ...
May  1 13:18:47.281: INFO: Waiting up to timeout=5m0s for PersistentVolumeClaims [test.csi.azure.compt6s5] to have phase Bound
May  1 13:18:47.388: INFO: PersistentVolumeClaim test.csi.azure.compt6s5 found but phase is Pending instead of Bound.
May  1 13:18:49.497: INFO: PersistentVolumeClaim test.csi.azure.compt6s5 found but phase is Pending instead of Bound.
May  1 13:18:51.606: INFO: PersistentVolumeClaim test.csi.azure.compt6s5 found and phase=Bound (4.324739147s)
STEP: Creating pod exec-volume-test-dynamicpv-trbq
STEP: Creating a pod to test exec-volume-test
May  1 13:18:51.929: INFO: Waiting up to 5m0s for pod "exec-volume-test-dynamicpv-trbq" in namespace "volume-9709" to be "Succeeded or Failed"
May  1 13:18:52.036: INFO: Pod "exec-volume-test-dynamicpv-trbq": Phase="Pending", Reason="", readiness=false. Elapsed: 107.108839ms
May  1 13:18:54.160: INFO: Pod "exec-volume-test-dynamicpv-trbq": Phase="Pending", Reason="", readiness=false. Elapsed: 2.23138265s
May  1 13:18:56.269: INFO: Pod "exec-volume-test-dynamicpv-trbq": Phase="Pending", Reason="", readiness=false. Elapsed: 4.339847679s
May  1 13:18:58.376: INFO: Pod "exec-volume-test-dynamicpv-trbq": Phase="Pending", Reason="", readiness=false. Elapsed: 6.447391305s
May  1 13:19:00.485: INFO: Pod "exec-volume-test-dynamicpv-trbq": Phase="Pending", Reason="", readiness=false. Elapsed: 8.555829549s
May  1 13:19:02.592: INFO: Pod "exec-volume-test-dynamicpv-trbq": Phase="Pending", Reason="", readiness=false. Elapsed: 10.663440065s
... skipping 7 lines ...
May  1 13:19:19.467: INFO: Pod "exec-volume-test-dynamicpv-trbq": Phase="Pending", Reason="", readiness=false. Elapsed: 27.538474665s
May  1 13:19:21.577: INFO: Pod "exec-volume-test-dynamicpv-trbq": Phase="Pending", Reason="", readiness=false. Elapsed: 29.648296374s
May  1 13:19:23.686: INFO: Pod "exec-volume-test-dynamicpv-trbq": Phase="Pending", Reason="", readiness=false. Elapsed: 31.756994432s
May  1 13:19:25.794: INFO: Pod "exec-volume-test-dynamicpv-trbq": Phase="Pending", Reason="", readiness=false. Elapsed: 33.865365019s
May  1 13:19:27.902: INFO: Pod "exec-volume-test-dynamicpv-trbq": Phase="Succeeded", Reason="", readiness=false. Elapsed: 35.973440869s
STEP: Saw pod success
May  1 13:19:27.902: INFO: Pod "exec-volume-test-dynamicpv-trbq" satisfied condition "Succeeded or Failed"
May  1 13:19:28.010: INFO: Trying to get logs from node k8s-agentpool1-14541319-vmss000002 pod exec-volume-test-dynamicpv-trbq container exec-container-dynamicpv-trbq: <nil>
STEP: delete the pod
May  1 13:19:28.260: INFO: Waiting for pod exec-volume-test-dynamicpv-trbq to disappear
May  1 13:19:28.367: INFO: Pod exec-volume-test-dynamicpv-trbq no longer exists
STEP: Deleting pod exec-volume-test-dynamicpv-trbq
May  1 13:19:28.367: INFO: Deleting pod "exec-volume-test-dynamicpv-trbq" in namespace "volume-9709"
... skipping 21 lines ...
/workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:174
  [Testpattern: Dynamic PV (ext3)] volumes
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should allow exec of files on the volume
    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/volumes.go:196
------------------------------
{"msg":"PASSED External Storage [Driver: test.csi.azure.com] [Testpattern: Dynamic PV (ext3)] volumes should allow exec of files on the volume","total":34,"completed":1,"skipped":60,"failed":0}

SSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Dynamic PV (ntfs)][Feature:Windows] multiVolume [Slow]
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:51
May  1 13:20:10.113: INFO: Distro debian doesn't support ntfs -- skipping
... skipping 24 lines ...

S [SKIPPING] in Spec Setup (BeforeEach) [0.001 seconds]
External Storage [Driver: test.csi.azure.com]
/workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:174
  [Testpattern: Pre-provisioned PV (default fs)] subPath
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should fail if subpath with backstepping is outside the volume [Slow][LinuxOnly] [BeforeEach]
    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:278

    Driver "test.csi.azure.com" does not support volume type "PreprovisionedPV" - skipping

    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:262
------------------------------
... skipping 8 lines ...

S [SKIPPING] in Spec Setup (BeforeEach) [0.001 seconds]
External Storage [Driver: test.csi.azure.com]
/workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:174
  [Testpattern: Pre-provisioned PV (block volmode)] volumeMode
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should fail to use a volume in a pod with mismatched mode [Slow] [BeforeEach]
    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/volumemode.go:297

    Driver "test.csi.azure.com" does not support volume type "PreprovisionedPV" - skipping

    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:262
------------------------------
... skipping 176 lines ...
/workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:174
  [Testpattern: Dynamic PV (xfs)][Slow] multiVolume [Slow]
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should concurrently access the single volume from pods on the same node
    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/multivolume.go:296
------------------------------
{"msg":"PASSED External Storage [Driver: test.csi.azure.com] [Testpattern: Dynamic PV (xfs)][Slow] multiVolume [Slow] should concurrently access the single volume from pods on the same node","total":31,"completed":1,"skipped":9,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
External Storage [Driver: test.csi.azure.com] [Testpattern: Dynamic PV (block volmode)] multiVolume [Slow] 
  should access to two volumes with the same volume mode and retain data across pod recreation on the same node
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/multivolume.go:136
... skipping 190 lines ...
/workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:174
  [Testpattern: Dynamic PV (block volmode)] multiVolume [Slow]
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should access to two volumes with the same volume mode and retain data across pod recreation on the same node
    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/multivolume.go:136
------------------------------
{"msg":"PASSED External Storage [Driver: test.csi.azure.com] [Testpattern: Dynamic PV (block volmode)] multiVolume [Slow] should access to two volumes with the same volume mode and retain data across pod recreation on the same node","total":36,"completed":1,"skipped":112,"failed":0}

S
------------------------------
External Storage [Driver: test.csi.azure.com] [Testpattern: Dynamic PV (xfs)][Slow] multiVolume [Slow] 
  should concurrently access the single read-only volume from pods on the same node
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/multivolume.go:421
... skipping 81 lines ...
/workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:174
  [Testpattern: Dynamic PV (xfs)][Slow] multiVolume [Slow]
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should concurrently access the single read-only volume from pods on the same node
    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/multivolume.go:421
------------------------------
{"msg":"PASSED External Storage [Driver: test.csi.azure.com] [Testpattern: Dynamic PV (xfs)][Slow] multiVolume [Slow] should concurrently access the single read-only volume from pods on the same node","total":29,"completed":2,"skipped":209,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Dynamic PV (ntfs)][Feature:Windows] multiVolume [Slow]
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:51
May  1 13:21:36.431: INFO: Distro debian doesn't support ntfs -- skipping
... skipping 137 lines ...
/workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:174
  [Testpattern: Dynamic PV (ext3)] volumes
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should store data
    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/volumes.go:159
------------------------------
{"msg":"PASSED External Storage [Driver: test.csi.azure.com] [Testpattern: Dynamic PV (ext3)] volumes should store data","total":39,"completed":1,"skipped":69,"failed":0}

S
------------------------------
[BeforeEach] [Testpattern: Dynamic PV (filesystem volmode)] multiVolume [Slow]
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:51
[BeforeEach] [Testpattern: Dynamic PV (filesystem volmode)] multiVolume [Slow]
... skipping 55 lines ...

S [SKIPPING] in Spec Setup (BeforeEach) [0.001 seconds]
External Storage [Driver: test.csi.azure.com]
/workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:174
  [Testpattern: Inline-volume (default fs)] subPath
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should fail if subpath file is outside the volume [Slow][LinuxOnly] [BeforeEach]
    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:256

    Driver "test.csi.azure.com" does not support volume type "InlineVolume" - skipping

    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:262
------------------------------
... skipping 104 lines ...
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should provision storage with pvc data source
    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/provisioning.go:239
------------------------------
S
------------------------------
{"msg":"PASSED External Storage [Driver: test.csi.azure.com] [Testpattern: Dynamic PV (block volmode)] provisioning should provision storage with pvc data source","total":35,"completed":1,"skipped":176,"failed":0}

SSSSSSS
------------------------------
[BeforeEach] [Testpattern: Inline-volume (default fs)] subPath
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:51
May  1 13:21:37.297: INFO: Driver "test.csi.azure.com" does not support volume type "InlineVolume" - skipping
... skipping 87 lines ...

S [SKIPPING] in Spec Setup (BeforeEach) [0.001 seconds]
External Storage [Driver: test.csi.azure.com]
/workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:174
  [Testpattern: Dynamic PV (ntfs)][Feature:Windows] subPath
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should fail if subpath with backstepping is outside the volume [Slow][LinuxOnly] [BeforeEach]
    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:278

    Distro debian doesn't support ntfs -- skipping

    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:127
------------------------------
... skipping 197 lines ...
/workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:174
  [Testpattern: Dynamic PV (ext4)] multiVolume [Slow]
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should access to two volumes with the same volume mode and retain data across pod recreation on different node
    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/multivolume.go:166
------------------------------
{"msg":"PASSED External Storage [Driver: test.csi.azure.com] [Testpattern: Dynamic PV (ext4)] multiVolume [Slow] should access to two volumes with the same volume mode and retain data across pod recreation on different node","total":27,"completed":1,"skipped":16,"failed":0}

SSSSSSSSSSSSSSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Dynamic PV (ntfs)][Feature:Windows] subPath
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:51
May  1 13:21:49.329: INFO: Distro debian doesn't support ntfs -- skipping
... skipping 58 lines ...
May  1 13:20:11.023: INFO: Waiting up to timeout=5m0s for PersistentVolumeClaims [test.csi.azure.com6xvkb] to have phase Bound
May  1 13:20:11.131: INFO: PersistentVolumeClaim test.csi.azure.com6xvkb found but phase is Pending instead of Bound.
May  1 13:20:13.248: INFO: PersistentVolumeClaim test.csi.azure.com6xvkb found but phase is Pending instead of Bound.
May  1 13:20:15.356: INFO: PersistentVolumeClaim test.csi.azure.com6xvkb found and phase=Bound (4.33278963s)
STEP: Creating pod pod-subpath-test-dynamicpv-knb4
STEP: Creating a pod to test subpath
May  1 13:20:15.680: INFO: Waiting up to 5m0s for pod "pod-subpath-test-dynamicpv-knb4" in namespace "provisioning-7056" to be "Succeeded or Failed"
May  1 13:20:15.788: INFO: Pod "pod-subpath-test-dynamicpv-knb4": Phase="Pending", Reason="", readiness=false. Elapsed: 108.017251ms
May  1 13:20:17.898: INFO: Pod "pod-subpath-test-dynamicpv-knb4": Phase="Pending", Reason="", readiness=false. Elapsed: 2.217503655s
May  1 13:20:20.006: INFO: Pod "pod-subpath-test-dynamicpv-knb4": Phase="Pending", Reason="", readiness=false. Elapsed: 4.325537482s
May  1 13:20:22.115: INFO: Pod "pod-subpath-test-dynamicpv-knb4": Phase="Pending", Reason="", readiness=false. Elapsed: 6.434279289s
May  1 13:20:24.222: INFO: Pod "pod-subpath-test-dynamicpv-knb4": Phase="Pending", Reason="", readiness=false. Elapsed: 8.541873011s
May  1 13:20:26.330: INFO: Pod "pod-subpath-test-dynamicpv-knb4": Phase="Pending", Reason="", readiness=false. Elapsed: 10.649529988s
... skipping 4 lines ...
May  1 13:20:36.871: INFO: Pod "pod-subpath-test-dynamicpv-knb4": Phase="Pending", Reason="", readiness=false. Elapsed: 21.190678521s
May  1 13:20:38.980: INFO: Pod "pod-subpath-test-dynamicpv-knb4": Phase="Pending", Reason="", readiness=false. Elapsed: 23.299427122s
May  1 13:20:41.089: INFO: Pod "pod-subpath-test-dynamicpv-knb4": Phase="Pending", Reason="", readiness=false. Elapsed: 25.408162755s
May  1 13:20:43.197: INFO: Pod "pod-subpath-test-dynamicpv-knb4": Phase="Pending", Reason="", readiness=false. Elapsed: 27.516498675s
May  1 13:20:45.306: INFO: Pod "pod-subpath-test-dynamicpv-knb4": Phase="Succeeded", Reason="", readiness=false. Elapsed: 29.625255101s
STEP: Saw pod success
May  1 13:20:45.306: INFO: Pod "pod-subpath-test-dynamicpv-knb4" satisfied condition "Succeeded or Failed"
May  1 13:20:45.413: INFO: Trying to get logs from node k8s-agentpool1-14541319-vmss000002 pod pod-subpath-test-dynamicpv-knb4 container test-container-volume-dynamicpv-knb4: <nil>
STEP: delete the pod
May  1 13:20:45.649: INFO: Waiting for pod pod-subpath-test-dynamicpv-knb4 to disappear
May  1 13:20:45.756: INFO: Pod pod-subpath-test-dynamicpv-knb4 no longer exists
STEP: Deleting pod pod-subpath-test-dynamicpv-knb4
May  1 13:20:45.756: INFO: Deleting pod "pod-subpath-test-dynamicpv-knb4" in namespace "provisioning-7056"
... skipping 29 lines ...
/workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:174
  [Testpattern: Dynamic PV (default fs)] subPath
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should support non-existent path
    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:194
------------------------------
{"msg":"PASSED External Storage [Driver: test.csi.azure.com] [Testpattern: Dynamic PV (default fs)] subPath should support non-existent path","total":34,"completed":2,"skipped":219,"failed":0}

SSSSSSSSSSSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Pre-provisioned PV (filesystem volmode)] multiVolume [Slow]
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:51
May  1 13:21:58.283: INFO: Driver "test.csi.azure.com" does not support volume type "PreprovisionedPV" - skipping
... skipping 235 lines ...
/workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:174
  [Testpattern: Dynamic PV (filesystem volmode)] multiVolume [Slow]
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should access to two volumes with the same volume mode and retain data across pod recreation on the same node
    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/multivolume.go:136
------------------------------
{"msg":"PASSED External Storage [Driver: test.csi.azure.com] [Testpattern: Dynamic PV (filesystem volmode)] multiVolume [Slow] should access to two volumes with the same volume mode and retain data across pod recreation on the same node","total":36,"completed":2,"skipped":113,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
External Storage [Driver: test.csi.azure.com] [Testpattern: Dynamic PV (block volmode)] multiVolume [Slow] 
  should concurrently access the single volume from pods on the same node
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/multivolume.go:296
... skipping 150 lines ...
/workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:174
  [Testpattern: Dynamic PV (block volmode)] multiVolume [Slow]
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should concurrently access the single volume from pods on the same node
    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/multivolume.go:296
------------------------------
{"msg":"PASSED External Storage [Driver: test.csi.azure.com] [Testpattern: Dynamic PV (block volmode)] multiVolume [Slow] should concurrently access the single volume from pods on the same node","total":39,"completed":2,"skipped":70,"failed":0}

SSSSSSSSSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Dynamic PV (block volmode)] provisioning
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:51
[BeforeEach] [Testpattern: Dynamic PV (block volmode)] provisioning
... skipping 126 lines ...
May  1 13:21:38.159: INFO: Waiting up to timeout=5m0s for PersistentVolumeClaims [test.csi.azure.com4r2qn] to have phase Bound
May  1 13:21:38.270: INFO: PersistentVolumeClaim test.csi.azure.com4r2qn found but phase is Pending instead of Bound.
May  1 13:21:40.379: INFO: PersistentVolumeClaim test.csi.azure.com4r2qn found but phase is Pending instead of Bound.
May  1 13:21:42.491: INFO: PersistentVolumeClaim test.csi.azure.com4r2qn found and phase=Bound (4.332739575s)
STEP: Creating pod pod-subpath-test-dynamicpv-s8qb
STEP: Creating a pod to test multi_subpath
May  1 13:21:42.815: INFO: Waiting up to 5m0s for pod "pod-subpath-test-dynamicpv-s8qb" in namespace "provisioning-7625" to be "Succeeded or Failed"
May  1 13:21:42.923: INFO: Pod "pod-subpath-test-dynamicpv-s8qb": Phase="Pending", Reason="", readiness=false. Elapsed: 107.441639ms
May  1 13:21:45.031: INFO: Pod "pod-subpath-test-dynamicpv-s8qb": Phase="Pending", Reason="", readiness=false. Elapsed: 2.215681462s
May  1 13:21:47.139: INFO: Pod "pod-subpath-test-dynamicpv-s8qb": Phase="Pending", Reason="", readiness=false. Elapsed: 4.323830025s
May  1 13:21:49.248: INFO: Pod "pod-subpath-test-dynamicpv-s8qb": Phase="Pending", Reason="", readiness=false. Elapsed: 6.43208831s
May  1 13:21:51.356: INFO: Pod "pod-subpath-test-dynamicpv-s8qb": Phase="Pending", Reason="", readiness=false. Elapsed: 8.540563134s
May  1 13:21:53.464: INFO: Pod "pod-subpath-test-dynamicpv-s8qb": Phase="Pending", Reason="", readiness=false. Elapsed: 10.648677213s
... skipping 19 lines ...
May  1 13:22:35.641: INFO: Pod "pod-subpath-test-dynamicpv-s8qb": Phase="Pending", Reason="", readiness=false. Elapsed: 52.825530312s
May  1 13:22:37.749: INFO: Pod "pod-subpath-test-dynamicpv-s8qb": Phase="Pending", Reason="", readiness=false. Elapsed: 54.93339788s
May  1 13:22:39.857: INFO: Pod "pod-subpath-test-dynamicpv-s8qb": Phase="Pending", Reason="", readiness=false. Elapsed: 57.041875478s
May  1 13:22:41.965: INFO: Pod "pod-subpath-test-dynamicpv-s8qb": Phase="Pending", Reason="", readiness=false. Elapsed: 59.149554897s
May  1 13:22:44.073: INFO: Pod "pod-subpath-test-dynamicpv-s8qb": Phase="Succeeded", Reason="", readiness=false. Elapsed: 1m1.257675333s
STEP: Saw pod success
May  1 13:22:44.073: INFO: Pod "pod-subpath-test-dynamicpv-s8qb" satisfied condition "Succeeded or Failed"
May  1 13:22:44.182: INFO: Trying to get logs from node k8s-agentpool1-14541319-vmss000001 pod pod-subpath-test-dynamicpv-s8qb container test-container-subpath-dynamicpv-s8qb: <nil>
STEP: delete the pod
May  1 13:22:44.415: INFO: Waiting for pod pod-subpath-test-dynamicpv-s8qb to disappear
May  1 13:22:44.522: INFO: Pod pod-subpath-test-dynamicpv-s8qb no longer exists
STEP: Deleting pod
May  1 13:22:44.522: INFO: Deleting pod "pod-subpath-test-dynamicpv-s8qb" in namespace "provisioning-7625"
... skipping 27 lines ...
/workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:174
  [Testpattern: Dynamic PV (default fs)] subPath
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should support creating multiple subpath from same volumes [Slow]
    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:294
------------------------------
{"msg":"PASSED External Storage [Driver: test.csi.azure.com] [Testpattern: Dynamic PV (default fs)] subPath should support creating multiple subpath from same volumes [Slow]","total":35,"completed":2,"skipped":287,"failed":0}

SSSSSSS
------------------------------
[BeforeEach] [Testpattern: Inline-volume (ntfs)][Feature:Windows] volumes
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:51
May  1 13:23:56.909: INFO: Driver "test.csi.azure.com" does not support volume type "InlineVolume" - skipping
... skipping 122 lines ...
/workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:174
  [Testpattern: Dynamic PV (xfs)][Slow] multiVolume [Slow]
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should concurrently access the volume and its clone from pods on the same node [LinuxOnly][Feature:VolumeSnapshotDataSource][Feature:VolumeSourceXFS]
    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/multivolume.go:376
------------------------------
{"msg":"PASSED External Storage [Driver: test.csi.azure.com] [Testpattern: Dynamic PV (xfs)][Slow] multiVolume [Slow] should concurrently access the volume and its clone from pods on the same node [LinuxOnly][Feature:VolumeSnapshotDataSource][Feature:VolumeSourceXFS]","total":31,"completed":2,"skipped":65,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
External Storage [Driver: test.csi.azure.com] [Testpattern: Generic Ephemeral-volume (default fs) (late-binding)] ephemeral 
  should create read/write inline ephemeral volume
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/ephemeral.go:194
... skipping 51 lines ...
/workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:174
  [Testpattern: Generic Ephemeral-volume (default fs) (late-binding)] ephemeral
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should create read/write inline ephemeral volume
    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/ephemeral.go:194
------------------------------
{"msg":"PASSED External Storage [Driver: test.csi.azure.com] [Testpattern: Generic Ephemeral-volume (default fs) (late-binding)] ephemeral should create read/write inline ephemeral volume","total":27,"completed":2,"skipped":67,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
External Storage [Driver: test.csi.azure.com] [Testpattern: Dynamic PV (block volmode)] volumeMode 
  should not mount / map unused volumes in a pod [LinuxOnly]
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/volumemode.go:352
... skipping 80 lines ...
/workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:174
  [Testpattern: Dynamic PV (block volmode)] volumeMode
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should not mount / map unused volumes in a pod [LinuxOnly]
    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/volumemode.go:352
------------------------------
{"msg":"PASSED External Storage [Driver: test.csi.azure.com] [Testpattern: Dynamic PV (block volmode)] volumeMode should not mount / map unused volumes in a pod [LinuxOnly]","total":34,"completed":3,"skipped":364,"failed":0}

SSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Inline-volume (default fs)] subPath
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:51
May  1 13:24:27.085: INFO: Driver "test.csi.azure.com" does not support volume type "InlineVolume" - skipping
... skipping 136 lines ...
/workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:174
  [Testpattern: Dynamic PV (block volmode)] volumes
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should store data
    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/volumes.go:159
------------------------------
{"msg":"PASSED External Storage [Driver: test.csi.azure.com] [Testpattern: Dynamic PV (block volmode)] volumes should store data","total":29,"completed":3,"skipped":347,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Inline-volume (default fs)] subPath
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:51
May  1 13:24:27.788: INFO: Driver "test.csi.azure.com" does not support volume type "InlineVolume" - skipping
... skipping 3 lines ...

S [SKIPPING] in Spec Setup (BeforeEach) [0.001 seconds]
External Storage [Driver: test.csi.azure.com]
/workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:174
  [Testpattern: Inline-volume (default fs)] subPath
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should fail if subpath directory is outside the volume [Slow][LinuxOnly] [BeforeEach]
    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:240

    Driver "test.csi.azure.com" does not support volume type "InlineVolume" - skipping

    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:262
------------------------------
... skipping 149 lines ...
/workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:174
  [Testpattern: Dynamic PV (ext4)] volumes
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should store data
    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/volumes.go:159
------------------------------
{"msg":"PASSED External Storage [Driver: test.csi.azure.com] [Testpattern: Dynamic PV (ext4)] volumes should store data","total":36,"completed":3,"skipped":156,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
External Storage [Driver: test.csi.azure.com] [Testpattern: Generic Ephemeral-volume (default fs) (immediate-binding)] ephemeral 
  should create read-only inline ephemeral volume
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/ephemeral.go:173
... skipping 51 lines ...
/workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:174
  [Testpattern: Generic Ephemeral-volume (default fs) (immediate-binding)] ephemeral
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should create read-only inline ephemeral volume
    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/ephemeral.go:173
------------------------------
{"msg":"PASSED External Storage [Driver: test.csi.azure.com] [Testpattern: Generic Ephemeral-volume (default fs) (immediate-binding)] ephemeral should create read-only inline ephemeral volume","total":39,"completed":3,"skipped":189,"failed":0}

SSSSSSSSSSSSSSSSSSSSS
------------------------------
External Storage [Driver: test.csi.azure.com] [Testpattern: Dynamic PV (default fs)] subPath 
  should support readOnly file specified in the volumeMount [LinuxOnly]
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:380
... skipping 16 lines ...
May  1 13:23:57.691: INFO: Waiting up to timeout=5m0s for PersistentVolumeClaims [test.csi.azure.comspgvj] to have phase Bound
May  1 13:23:57.798: INFO: PersistentVolumeClaim test.csi.azure.comspgvj found but phase is Pending instead of Bound.
May  1 13:23:59.907: INFO: PersistentVolumeClaim test.csi.azure.comspgvj found but phase is Pending instead of Bound.
May  1 13:24:02.015: INFO: PersistentVolumeClaim test.csi.azure.comspgvj found and phase=Bound (4.324510112s)
STEP: Creating pod pod-subpath-test-dynamicpv-fqjp
STEP: Creating a pod to test subpath
May  1 13:24:02.341: INFO: Waiting up to 5m0s for pod "pod-subpath-test-dynamicpv-fqjp" in namespace "provisioning-3750" to be "Succeeded or Failed"
May  1 13:24:02.450: INFO: Pod "pod-subpath-test-dynamicpv-fqjp": Phase="Pending", Reason="", readiness=false. Elapsed: 109.859224ms
May  1 13:24:04.560: INFO: Pod "pod-subpath-test-dynamicpv-fqjp": Phase="Pending", Reason="", readiness=false. Elapsed: 2.219135133s
May  1 13:24:06.668: INFO: Pod "pod-subpath-test-dynamicpv-fqjp": Phase="Pending", Reason="", readiness=false. Elapsed: 4.327703164s
May  1 13:24:08.782: INFO: Pod "pod-subpath-test-dynamicpv-fqjp": Phase="Pending", Reason="", readiness=false. Elapsed: 6.441248523s
May  1 13:24:10.890: INFO: Pod "pod-subpath-test-dynamicpv-fqjp": Phase="Pending", Reason="", readiness=false. Elapsed: 8.549787258s
May  1 13:24:13.001: INFO: Pod "pod-subpath-test-dynamicpv-fqjp": Phase="Pending", Reason="", readiness=false. Elapsed: 10.660093001s
May  1 13:24:15.113: INFO: Pod "pod-subpath-test-dynamicpv-fqjp": Phase="Pending", Reason="", readiness=false. Elapsed: 12.772287621s
May  1 13:24:17.220: INFO: Pod "pod-subpath-test-dynamicpv-fqjp": Phase="Pending", Reason="", readiness=false. Elapsed: 14.87961277s
May  1 13:24:19.328: INFO: Pod "pod-subpath-test-dynamicpv-fqjp": Phase="Pending", Reason="", readiness=false. Elapsed: 16.98765648s
May  1 13:24:21.436: INFO: Pod "pod-subpath-test-dynamicpv-fqjp": Phase="Succeeded", Reason="", readiness=false. Elapsed: 19.095216794s
STEP: Saw pod success
May  1 13:24:21.436: INFO: Pod "pod-subpath-test-dynamicpv-fqjp" satisfied condition "Succeeded or Failed"
May  1 13:24:21.543: INFO: Trying to get logs from node k8s-agentpool1-14541319-vmss000002 pod pod-subpath-test-dynamicpv-fqjp container test-container-subpath-dynamicpv-fqjp: <nil>
STEP: delete the pod
May  1 13:24:21.794: INFO: Waiting for pod pod-subpath-test-dynamicpv-fqjp to disappear
May  1 13:24:21.901: INFO: Pod pod-subpath-test-dynamicpv-fqjp no longer exists
STEP: Deleting pod pod-subpath-test-dynamicpv-fqjp
May  1 13:24:21.901: INFO: Deleting pod "pod-subpath-test-dynamicpv-fqjp" in namespace "provisioning-3750"
... skipping 41 lines ...
/workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:174
  [Testpattern: Dynamic PV (default fs)] subPath
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should support readOnly file specified in the volumeMount [LinuxOnly]
    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:380
------------------------------
{"msg":"PASSED External Storage [Driver: test.csi.azure.com] [Testpattern: Dynamic PV (default fs)] subPath should support readOnly file specified in the volumeMount [LinuxOnly]","total":35,"completed":3,"skipped":312,"failed":0}

SSSSSSSSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Pre-provisioned PV (default fs)] subPath
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:51
May  1 13:26:35.724: INFO: Driver "test.csi.azure.com" does not support volume type "PreprovisionedPV" - skipping
... skipping 3 lines ...

S [SKIPPING] in Spec Setup (BeforeEach) [0.001 seconds]
External Storage [Driver: test.csi.azure.com]
/workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:174
  [Testpattern: Pre-provisioned PV (default fs)] subPath
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should fail if subpath directory is outside the volume [Slow][LinuxOnly] [BeforeEach]
    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:240

    Driver "test.csi.azure.com" does not support volume type "PreprovisionedPV" - skipping

    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:262
------------------------------
... skipping 137 lines ...
/workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:174
  [Testpattern: Dynamic PV (default fs)] fsgroupchangepolicy
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    (OnRootMismatch)[LinuxOnly], pod created with an initial fsgroup, new pod fsgroup applied to volume contents
    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/fsgroupchangepolicy.go:214
------------------------------
{"msg":"PASSED External Storage [Driver: test.csi.azure.com] [Testpattern: Dynamic PV (default fs)] fsgroupchangepolicy (OnRootMismatch)[LinuxOnly], pod created with an initial fsgroup, new pod fsgroup applied to volume contents","total":29,"completed":4,"skipped":459,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
External Storage [Driver: test.csi.azure.com] [Testpattern: Dynamic PV (default fs)] fsgroupchangepolicy 
  (Always)[LinuxOnly], pod created with an initial fsgroup, new pod fsgroup applied to volume contents
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/fsgroupchangepolicy.go:214
... skipping 96 lines ...
/workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:174
  [Testpattern: Dynamic PV (default fs)] fsgroupchangepolicy
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    (Always)[LinuxOnly], pod created with an initial fsgroup, new pod fsgroup applied to volume contents
    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/fsgroupchangepolicy.go:214
------------------------------
{"msg":"PASSED External Storage [Driver: test.csi.azure.com] [Testpattern: Dynamic PV (default fs)] fsgroupchangepolicy (Always)[LinuxOnly], pod created with an initial fsgroup, new pod fsgroup applied to volume contents","total":27,"completed":3,"skipped":143,"failed":0}

SSSSSSS
------------------------------
[BeforeEach] [Testpattern: Pre-provisioned PV (filesystem volmode)] multiVolume [Slow]
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:51
May  1 13:28:13.975: INFO: Driver "test.csi.azure.com" does not support volume type "PreprovisionedPV" - skipping
... skipping 248 lines ...
/workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:174
  [Testpattern: Dynamic PV (default fs)] volumes
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should store data
    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/volumes.go:159
------------------------------
{"msg":"PASSED External Storage [Driver: test.csi.azure.com] [Testpattern: Dynamic PV (default fs)] volumes should store data","total":39,"completed":4,"skipped":210,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Pre-provisioned PV (ntfs)][Feature:Windows] volumes
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:51
May  1 13:28:46.083: INFO: Driver "test.csi.azure.com" does not support volume type "PreprovisionedPV" - skipping
... skipping 57 lines ...
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:186
May  1 13:28:47.158: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
STEP: Destroying namespace "volumelimits-4986" for this suite.

•
------------------------------
{"msg":"PASSED External Storage [Driver: test.csi.azure.com] [Testpattern: Generic Ephemeral-volume (default fs)] volumeLimits should verify that all csinodes have volume limits","total":39,"completed":5,"skipped":368,"failed":0}

SSSSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Pre-provisioned PV (default fs)] subPath
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:51
May  1 13:28:47.390: INFO: Driver "test.csi.azure.com" does not support volume type "PreprovisionedPV" - skipping
... skipping 86 lines ...
May  1 13:24:05.829: INFO: Warning: Making PVC: VolumeMode specified as invalid empty string, treating as nil
May  1 13:24:05.939: INFO: Waiting up to timeout=5m0s for PersistentVolumeClaims [test.csi.azure.com64wpb] to have phase Bound
May  1 13:24:06.048: INFO: PersistentVolumeClaim test.csi.azure.com64wpb found but phase is Pending instead of Bound.
May  1 13:24:08.157: INFO: PersistentVolumeClaim test.csi.azure.com64wpb found but phase is Pending instead of Bound.
May  1 13:24:10.268: INFO: PersistentVolumeClaim test.csi.azure.com64wpb found and phase=Bound (4.328319216s)
STEP: Creating pod to format volume volume-prep-provisioning-159
May  1 13:24:10.609: INFO: Waiting up to 5m0s for pod "volume-prep-provisioning-159" in namespace "provisioning-159" to be "Succeeded or Failed"
May  1 13:24:10.737: INFO: Pod "volume-prep-provisioning-159": Phase="Pending", Reason="", readiness=false. Elapsed: 128.039909ms
May  1 13:24:12.847: INFO: Pod "volume-prep-provisioning-159": Phase="Pending", Reason="", readiness=false. Elapsed: 2.237896785s
May  1 13:24:14.958: INFO: Pod "volume-prep-provisioning-159": Phase="Pending", Reason="", readiness=false. Elapsed: 4.348580461s
May  1 13:24:17.067: INFO: Pod "volume-prep-provisioning-159": Phase="Pending", Reason="", readiness=false. Elapsed: 6.458372593s
May  1 13:24:19.177: INFO: Pod "volume-prep-provisioning-159": Phase="Pending", Reason="", readiness=false. Elapsed: 8.567840852s
May  1 13:24:21.288: INFO: Pod "volume-prep-provisioning-159": Phase="Pending", Reason="", readiness=false. Elapsed: 10.678667336s
May  1 13:24:23.397: INFO: Pod "volume-prep-provisioning-159": Phase="Pending", Reason="", readiness=false. Elapsed: 12.788358097s
May  1 13:24:25.506: INFO: Pod "volume-prep-provisioning-159": Phase="Pending", Reason="", readiness=false. Elapsed: 14.897321209s
May  1 13:24:27.616: INFO: Pod "volume-prep-provisioning-159": Phase="Pending", Reason="", readiness=false. Elapsed: 17.006693169s
May  1 13:24:29.732: INFO: Pod "volume-prep-provisioning-159": Phase="Succeeded", Reason="", readiness=false. Elapsed: 19.123152352s
STEP: Saw pod success
May  1 13:24:29.732: INFO: Pod "volume-prep-provisioning-159" satisfied condition "Succeeded or Failed"
May  1 13:24:29.732: INFO: Deleting pod "volume-prep-provisioning-159" in namespace "provisioning-159"
May  1 13:24:29.845: INFO: Wait up to 5m0s for pod "volume-prep-provisioning-159" to be fully deleted
STEP: Creating pod pod-subpath-test-dynamicpv-bmnt
STEP: Checking for subpath error in container status
May  1 13:26:34.290: INFO: Deleting pod "pod-subpath-test-dynamicpv-bmnt" in namespace "provisioning-159"
May  1 13:26:34.405: INFO: Wait up to 5m0s for pod "pod-subpath-test-dynamicpv-bmnt" to be fully deleted
STEP: Deleting pod
May  1 13:26:34.514: INFO: Deleting pod "pod-subpath-test-dynamicpv-bmnt" in namespace "provisioning-159"
STEP: Deleting pvc
May  1 13:26:34.621: INFO: Deleting PersistentVolumeClaim "test.csi.azure.com64wpb"
... skipping 37 lines ...
/workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:174
  [Testpattern: Dynamic PV (default fs)] subPath
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should verify container cannot write to subpath readonly volumes [Slow]
    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:423
------------------------------
{"msg":"PASSED External Storage [Driver: test.csi.azure.com] [Testpattern: Dynamic PV (default fs)] subPath should verify container cannot write to subpath readonly volumes [Slow]","total":31,"completed":3,"skipped":120,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Pre-provisioned PV (filesystem volmode)] multiVolume [Slow]
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:51
May  1 13:28:48.286: INFO: Driver "test.csi.azure.com" does not support volume type "PreprovisionedPV" - skipping
... skipping 24 lines ...

S [SKIPPING] in Spec Setup (BeforeEach) [0.001 seconds]
External Storage [Driver: test.csi.azure.com]
/workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:174
  [Testpattern: Inline-volume (default fs)] subPath
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should fail if non-existent subpath is outside the volume [Slow][LinuxOnly] [BeforeEach]
    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:267

    Driver "test.csi.azure.com" does not support volume type "InlineVolume" - skipping

    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:262
------------------------------
... skipping 4 lines ...
[BeforeEach] [Testpattern: Dynamic PV (immediate binding)] topology
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:185
STEP: Creating a kubernetes client
May  1 13:28:48.164: INFO: >>> kubeConfig: /root/tmp559495955/kubeconfig/kubeconfig.westeurope.json
STEP: Building a namespace api object, basename topology
STEP: Waiting for a default service account to be provisioned in namespace
[It] should fail to schedule a pod which has topologies that conflict with AllowedTopologies
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/topology.go:192
May  1 13:28:48.700: INFO: Driver didn't provide topology keys -- skipping
[AfterEach] [Testpattern: Dynamic PV (immediate binding)] topology
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:186
May  1 13:28:48.701: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
STEP: Destroying namespace "topology-5493" for this suite.


S [SKIPPING] [0.754 seconds]
External Storage [Driver: test.csi.azure.com]
/workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:174
  [Testpattern: Dynamic PV (immediate binding)] topology
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should fail to schedule a pod which has topologies that conflict with AllowedTopologies [Measurement]
    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/topology.go:192

    Driver didn't provide topology keys -- skipping

    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/topology.go:124
------------------------------
... skipping 94 lines ...
May  1 13:26:36.531: INFO: Waiting up to timeout=5m0s for PersistentVolumeClaims [test.csi.azure.com9jp8s] to have phase Bound
May  1 13:26:36.638: INFO: PersistentVolumeClaim test.csi.azure.com9jp8s found but phase is Pending instead of Bound.
May  1 13:26:38.746: INFO: PersistentVolumeClaim test.csi.azure.com9jp8s found but phase is Pending instead of Bound.
May  1 13:26:40.854: INFO: PersistentVolumeClaim test.csi.azure.com9jp8s found and phase=Bound (4.323446095s)
STEP: Creating pod pod-subpath-test-dynamicpv-wh4t
STEP: Creating a pod to test subpath
May  1 13:26:41.183: INFO: Waiting up to 5m0s for pod "pod-subpath-test-dynamicpv-wh4t" in namespace "provisioning-5911" to be "Succeeded or Failed"
May  1 13:26:41.291: INFO: Pod "pod-subpath-test-dynamicpv-wh4t": Phase="Pending", Reason="", readiness=false. Elapsed: 107.7113ms
May  1 13:26:43.402: INFO: Pod "pod-subpath-test-dynamicpv-wh4t": Phase="Pending", Reason="", readiness=false. Elapsed: 2.219240575s
May  1 13:26:45.511: INFO: Pod "pod-subpath-test-dynamicpv-wh4t": Phase="Pending", Reason="", readiness=false. Elapsed: 4.328300341s
May  1 13:26:47.620: INFO: Pod "pod-subpath-test-dynamicpv-wh4t": Phase="Pending", Reason="", readiness=false. Elapsed: 6.437046975s
May  1 13:26:49.728: INFO: Pod "pod-subpath-test-dynamicpv-wh4t": Phase="Pending", Reason="", readiness=false. Elapsed: 8.544980644s
May  1 13:26:51.836: INFO: Pod "pod-subpath-test-dynamicpv-wh4t": Phase="Pending", Reason="", readiness=false. Elapsed: 10.653204236s
... skipping 31 lines ...
May  1 13:27:59.318: INFO: Pod "pod-subpath-test-dynamicpv-wh4t": Phase="Pending", Reason="", readiness=false. Elapsed: 1m18.134778997s
May  1 13:28:01.426: INFO: Pod "pod-subpath-test-dynamicpv-wh4t": Phase="Pending", Reason="", readiness=false. Elapsed: 1m20.242880807s
May  1 13:28:03.535: INFO: Pod "pod-subpath-test-dynamicpv-wh4t": Phase="Pending", Reason="", readiness=false. Elapsed: 1m22.352019545s
May  1 13:28:05.643: INFO: Pod "pod-subpath-test-dynamicpv-wh4t": Phase="Pending", Reason="", readiness=false. Elapsed: 1m24.460064612s
May  1 13:28:07.751: INFO: Pod "pod-subpath-test-dynamicpv-wh4t": Phase="Succeeded", Reason="", readiness=false. Elapsed: 1m26.568185162s
STEP: Saw pod success
May  1 13:28:07.751: INFO: Pod "pod-subpath-test-dynamicpv-wh4t" satisfied condition "Succeeded or Failed"
May  1 13:28:07.865: INFO: Trying to get logs from node k8s-agentpool1-14541319-vmss000002 pod pod-subpath-test-dynamicpv-wh4t container test-container-subpath-dynamicpv-wh4t: <nil>
STEP: delete the pod
May  1 13:28:08.093: INFO: Waiting for pod pod-subpath-test-dynamicpv-wh4t to disappear
May  1 13:28:08.201: INFO: Pod pod-subpath-test-dynamicpv-wh4t no longer exists
STEP: Deleting pod pod-subpath-test-dynamicpv-wh4t
May  1 13:28:08.201: INFO: Deleting pod "pod-subpath-test-dynamicpv-wh4t" in namespace "provisioning-5911"
... skipping 23 lines ...
/workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:174
  [Testpattern: Dynamic PV (default fs)] subPath
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should support readOnly directory specified in the volumeMount
    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:365
------------------------------
{"msg":"PASSED External Storage [Driver: test.csi.azure.com] [Testpattern: Dynamic PV (default fs)] subPath should support readOnly directory specified in the volumeMount","total":35,"completed":4,"skipped":379,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
External Storage [Driver: test.csi.azure.com] [Testpattern: Dynamic PV (xfs)][Slow] multiVolume [Slow] 
  should access to two volumes with different volume mode and retain data across pod recreation on different node
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/multivolume.go:246
... skipping 194 lines ...
/workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:174
  [Testpattern: Dynamic PV (xfs)][Slow] multiVolume [Slow]
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should access to two volumes with different volume mode and retain data across pod recreation on different node
    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/multivolume.go:246
------------------------------
{"msg":"PASSED External Storage [Driver: test.csi.azure.com] [Testpattern: Dynamic PV (xfs)][Slow] multiVolume [Slow] should access to two volumes with different volume mode and retain data across pod recreation on different node","total":34,"completed":4,"skipped":434,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
External Storage [Driver: test.csi.azure.com] [Testpattern: Dynamic PV (default fs)] subPath 
  should support existing single file [LinuxOnly]
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:219
... skipping 16 lines ...
May  1 13:26:54.688: INFO: Waiting up to timeout=5m0s for PersistentVolumeClaims [test.csi.azure.comstzs5] to have phase Bound
May  1 13:26:54.796: INFO: PersistentVolumeClaim test.csi.azure.comstzs5 found but phase is Pending instead of Bound.
May  1 13:26:56.904: INFO: PersistentVolumeClaim test.csi.azure.comstzs5 found but phase is Pending instead of Bound.
May  1 13:26:59.012: INFO: PersistentVolumeClaim test.csi.azure.comstzs5 found and phase=Bound (4.324210295s)
STEP: Creating pod pod-subpath-test-dynamicpv-sxpc
STEP: Creating a pod to test subpath
May  1 13:26:59.344: INFO: Waiting up to 5m0s for pod "pod-subpath-test-dynamicpv-sxpc" in namespace "provisioning-3092" to be "Succeeded or Failed"
May  1 13:26:59.452: INFO: Pod "pod-subpath-test-dynamicpv-sxpc": Phase="Pending", Reason="", readiness=false. Elapsed: 107.057674ms
May  1 13:27:01.562: INFO: Pod "pod-subpath-test-dynamicpv-sxpc": Phase="Pending", Reason="", readiness=false. Elapsed: 2.217644083s
May  1 13:27:03.671: INFO: Pod "pod-subpath-test-dynamicpv-sxpc": Phase="Pending", Reason="", readiness=false. Elapsed: 4.3265719s
May  1 13:27:05.779: INFO: Pod "pod-subpath-test-dynamicpv-sxpc": Phase="Pending", Reason="", readiness=false. Elapsed: 6.434320006s
May  1 13:27:07.887: INFO: Pod "pod-subpath-test-dynamicpv-sxpc": Phase="Pending", Reason="", readiness=false. Elapsed: 8.542586001s
May  1 13:27:09.996: INFO: Pod "pod-subpath-test-dynamicpv-sxpc": Phase="Pending", Reason="", readiness=false. Elapsed: 10.651502272s
... skipping 22 lines ...
May  1 13:27:58.500: INFO: Pod "pod-subpath-test-dynamicpv-sxpc": Phase="Pending", Reason="", readiness=false. Elapsed: 59.155105205s
May  1 13:28:00.609: INFO: Pod "pod-subpath-test-dynamicpv-sxpc": Phase="Pending", Reason="", readiness=false. Elapsed: 1m1.264030246s
May  1 13:28:02.719: INFO: Pod "pod-subpath-test-dynamicpv-sxpc": Phase="Pending", Reason="", readiness=false. Elapsed: 1m3.374119403s
May  1 13:28:04.828: INFO: Pod "pod-subpath-test-dynamicpv-sxpc": Phase="Pending", Reason="", readiness=false. Elapsed: 1m5.483167072s
May  1 13:28:06.936: INFO: Pod "pod-subpath-test-dynamicpv-sxpc": Phase="Succeeded", Reason="", readiness=false. Elapsed: 1m7.591757291s
STEP: Saw pod success
May  1 13:28:06.936: INFO: Pod "pod-subpath-test-dynamicpv-sxpc" satisfied condition "Succeeded or Failed"
May  1 13:28:07.044: INFO: Trying to get logs from node k8s-agentpool1-14541319-vmss000002 pod pod-subpath-test-dynamicpv-sxpc container test-container-subpath-dynamicpv-sxpc: <nil>
STEP: delete the pod
May  1 13:28:07.298: INFO: Waiting for pod pod-subpath-test-dynamicpv-sxpc to disappear
May  1 13:28:07.408: INFO: Pod pod-subpath-test-dynamicpv-sxpc no longer exists
STEP: Deleting pod pod-subpath-test-dynamicpv-sxpc
May  1 13:28:07.408: INFO: Deleting pod "pod-subpath-test-dynamicpv-sxpc" in namespace "provisioning-3092"
... skipping 40 lines ...
/workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:174
  [Testpattern: Dynamic PV (default fs)] subPath
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should support existing single file [LinuxOnly]
    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:219
------------------------------
{"msg":"PASSED External Storage [Driver: test.csi.azure.com] [Testpattern: Dynamic PV (default fs)] subPath should support existing single file [LinuxOnly]","total":29,"completed":5,"skipped":485,"failed":0}

SSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Dynamic PV (ntfs)][Feature:Windows] subPath
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:51
May  1 13:30:16.147: INFO: Distro debian doesn't support ntfs -- skipping
... skipping 225 lines ...
/workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:174
  [Testpattern: Dynamic PV (default fs)] fsgroupchangepolicy
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    (Always)[LinuxOnly], pod created with an initial fsgroup, volume contents ownership changed via chgrp in first pod, new pod with different fsgroup applied to the volume contents
    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/fsgroupchangepolicy.go:214
------------------------------
{"msg":"PASSED External Storage [Driver: test.csi.azure.com] [Testpattern: Dynamic PV (default fs)] fsgroupchangepolicy (Always)[LinuxOnly], pod created with an initial fsgroup, volume contents ownership changed via chgrp in first pod, new pod with different fsgroup applied to the volume contents","total":39,"completed":6,"skipped":438,"failed":0}

SSSSSSSSSSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Pre-provisioned PV (ext4)] volumes
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:51
May  1 13:31:07.123: INFO: Driver "test.csi.azure.com" does not support volume type "PreprovisionedPV" - skipping
... skipping 65 lines ...
/workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:174
  [Testpattern: Generic Ephemeral-volume (default fs) (late-binding)] ephemeral
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should create read-only inline ephemeral volume
    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/ephemeral.go:173
------------------------------
{"msg":"PASSED External Storage [Driver: test.csi.azure.com] [Testpattern: Generic Ephemeral-volume (default fs) (late-binding)] ephemeral should create read-only inline ephemeral volume","total":35,"completed":5,"skipped":412,"failed":0}

SSSSSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Inline-volume (xfs)][Slow] volumes
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:51
May  1 13:31:45.916: INFO: Driver "test.csi.azure.com" does not support volume type "InlineVolume" - skipping
... skipping 103 lines ...
/workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:174
  [Testpattern: Generic Ephemeral-volume (default fs) (immediate-binding)] ephemeral
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should support two pods which have the same volume definition
    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/ephemeral.go:214
------------------------------
{"msg":"PASSED External Storage [Driver: test.csi.azure.com] [Testpattern: Generic Ephemeral-volume (default fs) (immediate-binding)] ephemeral should support two pods which have the same volume definition","total":27,"completed":4,"skipped":484,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Inline-volume (default fs)] volumes
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:51
May  1 13:32:48.070: INFO: Driver "test.csi.azure.com" does not support volume type "InlineVolume" - skipping
... skipping 309 lines ...
/workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:174
  [Testpattern: Dynamic PV (xfs)][Slow] volumes
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should store data
    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/volumes.go:159
------------------------------
{"msg":"PASSED External Storage [Driver: test.csi.azure.com] [Testpattern: Dynamic PV (xfs)][Slow] volumes should store data","total":34,"completed":5,"skipped":487,"failed":0}

SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSS
------------------------------
[BeforeEach] [Testpattern: Dynamic PV (ntfs)][Feature:Windows] subPath
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:51
May  1 13:32:58.035: INFO: Distro debian doesn't support ntfs -- skipping
... skipping 3 lines ...

S [SKIPPING] in Spec Setup (BeforeEach) [0.001 seconds]
External Storage [Driver: test.csi.azure.com]
/workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:174
  [Testpattern: Dynamic PV (ntfs)][Feature:Windows] subPath
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should fail if subpath file is outside the volume [Slow][LinuxOnly] [BeforeEach]
    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:256

    Distro debian doesn't support ntfs -- skipping

    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:127
------------------------------
... skipping 8 lines ...

S [SKIPPING] in Spec Setup (BeforeEach) [0.001 seconds]
External Storage [Driver: test.csi.azure.com]
/workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:174
  [Testpattern: Pre-provisioned PV (default fs)] subPath
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should fail if subpath file is outside the volume [Slow][LinuxOnly] [BeforeEach]
    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/subpath.go:256

    Driver "test.csi.azure.com" does not support volume type "PreprovisionedPV" - skipping

    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:262
------------------------------
... skipping 56 lines ...
[BeforeEach] [Testpattern: Dynamic PV (delayed binding)] topology
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:185
STEP: Creating a kubernetes client
May  1 13:32:58.873: INFO: >>> kubeConfig: /root/tmp559495955/kubeconfig/kubeconfig.westeurope.json
STEP: Building a namespace api object, basename topology
STEP: Waiting for a default service account to be provisioned in namespace
[It] should fail to schedule a pod which has topologies that conflict with AllowedTopologies
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/topology.go:192
May  1 13:32:59.412: INFO: Driver didn't provide topology keys -- skipping
[AfterEach] [Testpattern: Dynamic PV (delayed binding)] topology
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:186
May  1 13:32:59.413: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
STEP: Destroying namespace "topology-9737" for this suite.


S [SKIPPING] [0.758 seconds]
External Storage [Driver: test.csi.azure.com]
/workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/external/external.go:174
  [Testpattern: Dynamic PV (delayed binding)] topology
  /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/framework/testsuite.go:50
    should fail to schedule a pod which has topologies that conflict with AllowedTopologies [Measurement]
    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/topology.go:192

    Driver didn't provide topology keys -- skipping

    /workspace/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/test/e2e/storage/testsuites/topology.go:124
------------------------------
SSSSSSS