This job view page is being replaced by Spyglass soon. Check out the new job view.
ResultFAILURE
Tests 0 failed / 0 succeeded
Started2022-08-06 15:09
Elapsed1h19m
Revision
Builderb49d78b3-1599-11ed-bcf2-1217529f69d6
infra-commite29f272f4
reposigs.k8s.io/gcp-compute-persistent-disk-csi-driver
repo-commit7a126c25d05ffe04feecf950e0b0fb89e4d7af67
repos{u'sigs.k8s.io/gcp-compute-persistent-disk-csi-driver': u'master'}

No Test Failures!


Error lines from build-log.txt

... skipping 332 lines ...
W0806 15:12:14.176] I0806 15:12:14.176230    9868 utils.go:17] cmd env=[]
W0806 15:12:14.177] I0806 15:12:14.176236    9868 utils.go:18] cmd args=[make -C /go/src/sigs.k8s.io/gcp-compute-persistent-disk-csi-driver build-and-push-multi-arch GCE_PD_CSI_STAGING_VERSION=b0534223-1f26-41d5-9c61-c268c1de8ee3 GCE_PD_CSI_STAGING_IMAGE=gcr.io/k8s-gci-gce-ingress1-5/gcp-persistent-disk-csi-driver]
W0806 15:12:14.178] Makefile:48: gcp-pd-driver-windows only supports amd64.
I0806 15:12:14.278] make: Entering directory '/go/src/sigs.k8s.io/gcp-compute-persistent-disk-csi-driver'
I0806 15:12:14.279] # Ensure we use a builder that can leverage it (the default on linux will not)
I0806 15:12:14.279] DOCKER_CLI_EXPERIMENTAL=enabled docker buildx rm multiarch-multiplatform-builder
W0806 15:12:14.395] error: no builder "multiarch-multiplatform-builder" found
W0806 15:12:14.404] make: [Makefile:134: init-buildx] Error 1 (ignored)
I0806 15:12:14.504] DOCKER_CLI_EXPERIMENTAL=enabled docker buildx create --use --name=multiarch-multiplatform-builder
I0806 15:12:14.564] multiarch-multiplatform-builder
I0806 15:12:14.573] DOCKER_CLI_EXPERIMENTAL=enabled docker run --rm --privileged multiarch/qemu-user-static --reset --credential yes --persistent yes
W0806 15:12:14.674] Unable to find image 'multiarch/qemu-user-static:latest' locally
W0806 15:12:15.575] latest: Pulling from multiarch/qemu-user-static
W0806 15:12:15.575] 19d511225f94: Pulling fs layer
... skipping 239 lines ...
W0806 15:12:40.125] #11 7.856 Setting up libtinfo6:amd64 (6.1+20181013-2+deb10u2) ...
W0806 15:12:40.225] #11 7.928 Selecting previously unselected package bash.
W0806 15:12:40.226] #11 7.928 (Reading database ... 
(Reading database ... 5%
(Reading database ... 10%
(Reading database ... 15%
(Reading database ... 20%
(Reading database ... 25%
(Reading database ... 30%
(Reading database ... 35%
(Reading database ... 40%
(Reading database ... 45%
(Reading database ... 50%
(Reading database ... 55%
(Reading database ... 60%
(Reading database ... 65%
(Reading database ... 70%
(Reading database ... 75%
(Reading database ... 80%
(Reading database ... 85%
(Reading database ... 90%
(Reading database ... 95%
(Reading database ... 100%
(Reading database ... 3900 files and directories currently installed.)
W0806 15:12:40.226] #11 7.940 Preparing to unpack .../archives/bash_5.0-4_amd64.deb ...
W0806 15:12:40.226] #11 7.957 Unpacking bash (5.0-4) ...
W0806 15:12:40.677] #11 8.297 Setting up bash (5.0-4) ...
W0806 15:12:40.677] #11 8.336 update-alternatives: error: alternative path /usr/share/man/man7/bash-builtins.7.gz doesn't exist

W0806 15:12:40.781] #11 8.436 Selecting previously unselected package libuuid1:amd64.
W0806 15:12:40.782] #11 8.436 (Reading database ... 
(Reading database ... 5%
(Reading database ... 10%
(Reading database ... 15%
(Reading database ... 20%
(Reading database ... 25%
(Reading database ... 30%
(Reading database ... 35%
(Reading database ... 40%
(Reading database ... 45%
(Reading database ... 50%
(Reading database ... 55%
(Reading database ... 60%
(Reading database ... 65%
(Reading database ... 70%
(Reading database ... 75%
(Reading database ... 80%
(Reading database ... 85%
(Reading database ... 90%
(Reading database ... 95%
(Reading database ... 100%
(Reading database ... 3972 files and directories currently installed.)
W0806 15:12:40.782] #11 8.449 Preparing to unpack .../libuuid1_2.33.1-0.1_amd64.deb ...
W0806 15:12:40.782] #11 8.457 Unpacking libuuid1:amd64 (2.33.1-0.1) ...
W0806 15:12:40.782] #11 8.512 Setting up libuuid1:amd64 (2.33.1-0.1) ...
W0806 15:12:40.932] #11 8.583 Selecting previously unselected package libblkid1:amd64.
... skipping 501 lines ...
W0806 15:14:53.034] #12 70.18 Setting up libtinfo6:arm64 (6.1+20181013-2+deb10u2) ...
W0806 15:14:54.191] #12 71.44 Selecting previously unselected package bash.
W0806 15:14:54.342] #12 71.45 (Reading database ... 
(Reading database ... 5%
(Reading database ... 10%
(Reading database ... 15%
(Reading database ... 20%
(Reading database ... 25%
(Reading database ... 30%
(Reading database ... 35%
(Reading database ... 40%
(Reading database ... 45%
(Reading database ... 50%
(Reading database ... 55%
(Reading database ... 60%
(Reading database ... 65%
(Reading database ... 70%
(Reading database ... 75%
(Reading database ... 80%
(Reading database ... 85%
(Reading database ... 90%
(Reading database ... 95%
(Reading database ... 100%
(Reading database ... 3897 files and directories currently installed.)
W0806 15:14:54.343] #12 71.49 Preparing to unpack .../archives/bash_5.0-4_arm64.deb ...
W0806 15:14:54.493] #12 71.66 Unpacking bash (5.0-4) ...
W0806 15:14:56.151] #12 73.29 Setting up bash (5.0-4) ...
W0806 15:14:56.450] #12 73.62 update-alternatives: error: alternative path /usr/share/man/man7/bash-builtins.7.gz doesn't exist

W0806 15:14:58.704] #12 75.97 Selecting previously unselected package libuuid1:arm64.
W0806 15:14:58.851] #12 75.97 (Reading database ... 
(Reading database ... 5%
(Reading database ... 10%
(Reading database ... 15%
(Reading database ... 20%
(Reading database ... 25%
(Reading database ... 30%
(Reading database ... 35%
(Reading database ... 40%
(Reading database ... 45%
(Reading database ... 50%
(Reading database ... 55%
(Reading database ... 60%
(Reading database ... 65%
(Reading database ... 70%
(Reading database ... 75%
(Reading database ... 80%
(Reading database ... 85%
(Reading database ... 90%
(Reading database ... 95%
(Reading database ... 100%
(Reading database ... 3969 files and directories currently installed.)
W0806 15:14:58.852] #12 76.00 Preparing to unpack .../libuuid1_2.33.1-0.1_arm64.deb ...
W0806 15:14:58.852] #12 76.02 Unpacking libuuid1:arm64 (2.33.1-0.1) ...
W0806 15:14:59.894] #12 77.17 Setting up libuuid1:arm64 (2.33.1-0.1) ...
W0806 15:15:00.339] #12 77.61 Selecting previously unselected package libblkid1:arm64.
... skipping 918 lines ...
W0806 15:59:27.794] NODE_NAMES=e2e-test-prow-minion-group-scn6
W0806 15:59:27.794] Trying to find master named 'e2e-test-prow-master'
W0806 15:59:27.794] Looking for address 'e2e-test-prow-master-ip'
I0806 15:59:28.980] Waiting up to 300 seconds for cluster initialization.
I0806 15:59:28.980] 
I0806 15:59:28.981]   This will continually check to see if the API for kubernetes is reachable.
I0806 15:59:28.981]   This may time out if there was some uncaught error during start up.
I0806 15:59:28.981] 
I0806 15:59:49.400] .......Kubernetes cluster created.
W0806 15:59:49.500] Using master: e2e-test-prow-master (external IP: 34.134.86.53; internal IP: (not set))
I0806 15:59:49.601] Cluster "k8s-gci-gce-ingress1-5_e2e-test-prow" set.
I0806 15:59:49.691] User "k8s-gci-gce-ingress1-5_e2e-test-prow" set.
I0806 15:59:49.855] Context "k8s-gci-gce-ingress1-5_e2e-test-prow" created.
... skipping 51 lines ...
I0806 16:07:32.437] e2e-test-prow-minion-group-scn6         Ready                      <none>   7m12s   v1.25.0-beta.0.16+985c9202ccd250
I0806 16:07:32.437] e2e-test-prow-windows-node-group-n6zv   Ready                      <none>   33s     v1.25.0-beta.0.16+985c9202ccd250
I0806 16:07:32.437] e2e-test-prow-windows-node-group-v7f8   Ready                      <none>   19s     v1.25.0-beta.0.16+985c9202ccd250
I0806 16:07:32.438] e2e-test-prow-windows-node-group-w15b   Ready                      <none>   31s     v1.25.0-beta.0.16+985c9202ccd250
W0806 16:07:32.602] Warning: v1 ComponentStatus is deprecated in v1.19+
I0806 16:07:32.703] Validate output:
I0806 16:07:32.776] NAME                 STATUS    MESSAGE                         ERROR
I0806 16:07:32.776] etcd-0               Healthy   {"health":"true","reason":""}   
I0806 16:07:32.777] etcd-1               Healthy   {"health":"true","reason":""}   
I0806 16:07:32.777] controller-manager   Healthy   ok                              
I0806 16:07:32.777] scheduler            Healthy   ok                              
I0806 16:07:32.780] Cluster validation succeeded
W0806 16:07:32.881] Warning: v1 ComponentStatus is deprecated in v1.19+
... skipping 98 lines ...
I0806 16:09:05.844] GCE_PD_SA_DIR is /tmp/gcp-pd-driver-tmp3528387920
I0806 16:09:05.845] PKGDIR is /go/src/sigs.k8s.io/gcp-compute-persistent-disk-csi-driver
I0806 16:09:05.845] installing kustomize
I0806 16:09:06.743] {Version:kustomize/v3.9.4 GitCommit:e41d94ddef8cca7af2709c4104b41c4d43cd236c BuildDate:2021-02-09T19:22:10Z GoOs:linux GoArch:amd64}
W0806 16:09:06.893] + [[ true != true ]]
W0806 16:09:06.894] + /tmp/gcp-pd-driver-tmp235504005/kubernetes/cluster/kubectl.sh get namespace gce-pd-csi-driver -v=2
W0806 16:09:07.068] Error from server (NotFound): namespaces "gce-pd-csi-driver" not found
W0806 16:09:07.073] + /tmp/gcp-pd-driver-tmp235504005/kubernetes/cluster/kubectl.sh create namespace gce-pd-csi-driver -v=2
I0806 16:09:07.231] namespace/gce-pd-csi-driver created
W0806 16:09:07.332] + [[ ! stable-master == *noauth* ]]
W0806 16:09:07.332] + /tmp/gcp-pd-driver-tmp235504005/kubernetes/cluster/kubectl.sh get secret cloud-sa -v=2 -n gce-pd-csi-driver
W0806 16:09:07.401] Error from server (NotFound): secrets "cloud-sa" not found
W0806 16:09:07.406] + /tmp/gcp-pd-driver-tmp235504005/kubernetes/cluster/kubectl.sh create secret generic cloud-sa -v=2 --from-file=/tmp/gcp-pd-driver-tmp3528387920/cloud-sa.json -n gce-pd-csi-driver
I0806 16:09:07.562] secret/cloud-sa created
W0806 16:09:07.662] + /tmp/gcp-pd-driver-tmp235504005/kubernetes/cluster/kubectl.sh get clusterrolebinding -v=2 cluster-admin-binding
W0806 16:09:07.721] Error from server (NotFound): clusterrolebindings.rbac.authorization.k8s.io "cluster-admin-binding" not found
W0806 16:09:07.725] ++ gcloud config get-value account
W0806 16:09:08.457] + /tmp/gcp-pd-driver-tmp235504005/kubernetes/cluster/kubectl.sh create clusterrolebinding cluster-admin-binding -v=2 --clusterrole cluster-admin --user pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0806 16:09:08.600] clusterrolebinding.rbac.authorization.k8s.io/cluster-admin-binding created
W0806 16:09:08.701] + /tmp/gcp-pd-driver-tmp235504005/kubernetes/cluster/kubectl.sh version
W0806 16:09:08.748] WARNING: This version information is deprecated and will be replaced with the output from kubectl version --short.  Use --output=yaml|json to get the full version.
W0806 16:09:08.752] + readonly tmp_spec=/tmp/gcp-compute-persistent-disk-csi-driver-specs-generated.yaml
... skipping 521 lines ...
I0806 16:09:10.019]       - args:
I0806 16:09:10.019]         - --v=5
I0806 16:09:10.019]         - --csi-address=/csi/csi.sock
I0806 16:09:10.019]         - --http-endpoint=:22013
I0806 16:09:10.019]         - --leader-election
I0806 16:09:10.019]         - --leader-election-namespace=$(PDCSI_NAMESPACE)
I0806 16:09:10.020]         - --handle-volume-inuse-error=false
I0806 16:09:10.020]         env:
I0806 16:09:10.020]         - name: PDCSI_NAMESPACE
I0806 16:09:10.020]           valueFrom:
I0806 16:09:10.020]             fieldRef:
I0806 16:09:10.020]               fieldPath: metadata.namespace
I0806 16:09:10.021]         image: k8s.gcr.io/sig-storage/csi-resizer:v1.4.0
... skipping 370 lines ...
W0806 16:19:51.128]     Args:
W0806 16:19:51.129]       --v=5
W0806 16:19:51.129]       --csi-address=/csi/csi.sock
W0806 16:19:51.129]       --http-endpoint=:22013
W0806 16:19:51.129]       --leader-election
W0806 16:19:51.129]       --leader-election-namespace=$(PDCSI_NAMESPACE)
W0806 16:19:51.129]       --handle-volume-inuse-error=false
W0806 16:19:51.129]     State:          Running
W0806 16:19:51.130]       Started:      Sat, 06 Aug 2022 16:09:17 +0000
W0806 16:19:51.130]     Ready:          True
W0806 16:19:51.130]     Restart Count:  0
W0806 16:19:51.130]     Liveness:       http-get http://:http-endpoint/healthz/leader-election delay=10s timeout=10s period=20s #success=1 #failure=1
W0806 16:19:51.130]     Environment:
... skipping 736 lines ...
W0806 16:19:51.229]                              node.kubernetes.io/unreachable:NoExecute op=Exists
W0806 16:19:51.230]                              node.kubernetes.io/unschedulable:NoSchedule op=Exists
W0806 16:19:51.230] Events:
W0806 16:19:51.230]   Type     Reason       Age   From               Message
W0806 16:19:51.232]   ----     ------       ----  ----               -------
W0806 16:19:51.232]   Normal   Scheduled    10m   default-scheduler  Successfully assigned gce-pd-csi-driver/csi-gce-pd-node-win-xx56x to e2e-test-prow-windows-node-group-w15b
W0806 16:19:51.232]   Warning  FailedMount  10m   kubelet            MountVolume.SetUp failed for volume "kube-api-access-qjp4n" : failed to sync configmap cache: timed out waiting for the condition
W0806 16:19:51.233]   Normal   Pulling      10m   kubelet            Pulling image "k8s.gcr.io/sig-storage/csi-node-driver-registrar:v2.5.0"
W0806 16:19:51.234]   Normal   Pulled       10m   kubelet            Successfully pulled image "k8s.gcr.io/sig-storage/csi-node-driver-registrar:v2.5.0" in 17.7120706s
W0806 16:19:51.234]   Normal   Created      10m   kubelet            Created container csi-driver-registrar
W0806 16:19:51.235]   Normal   Started      10m   kubelet            Started container csi-driver-registrar
W0806 16:19:51.235]   Normal   Pulling      10m   kubelet            Pulling image "gcr.io/k8s-gci-gce-ingress1-5/gcp-persistent-disk-csi-driver:b0534223-1f26-41d5-9c61-c268c1de8ee3"
W0806 16:19:51.236]   Normal   Pulled       19s   kubelet            Successfully pulled image "gcr.io/k8s-gci-gce-ingress1-5/gcp-persistent-disk-csi-driver:b0534223-1f26-41d5-9c61-c268c1de8ee3" in 9m55.3208324s
... skipping 12 lines ...
W0806 16:19:53.653] I0806 16:19:53.652142    9868 utils.go:18] cmd args=[kubetest2 gce --run-id=b49d78b3-1599-11ed-bcf2-1217529f69d6 --test=ginkgo --legacy-mode --repo-root=/tmp/gcp-pd-driver-tmp235504005/kubernetes --artifacts=/workspace/_artifacts/sc-windows -- --use-built-binaries --focus-regex=External.Storage --skip-regex=\[Disruptive\]|\[Serial\]|\[LinuxOnly\] --parallel=4 --test-args=--storage.testdriver=/go/src/sigs.k8s.io/gcp-compute-persistent-disk-csi-driver/test/k8s-integration/config/test-config.yaml  --node-os-distro=windows --allowed-not-ready-nodes=2]
W0806 16:19:53.763] I0806 16:19:53.762823  178475 app.go:61] The files in RunDir shall not be part of Artifacts
W0806 16:19:53.763] I0806 16:19:53.762950  178475 app.go:62] pass rundir-in-artifacts flag True for RunDir to be part of Artifacts
W0806 16:19:53.763] I0806 16:19:53.762971  178475 app.go:64] RunDir for this run: "/go/src/sigs.k8s.io/gcp-compute-persistent-disk-csi-driver/deploy/kubernetes/overlays/stable-master/_rundir/b49d78b3-1599-11ed-bcf2-1217529f69d6"
W0806 16:19:53.768] I0806 16:19:53.768654  178475 app.go:128] ID for this run: "b49d78b3-1599-11ed-bcf2-1217529f69d6"
W0806 16:19:53.792] I0806 16:19:53.792433  178493 ginkgo.go:136] Using kubeconfig at /root/.kube/config
W0806 16:19:53.793] F0806 16:19:53.793089  178493 ginkgo.go:254] failed to run ginkgo tester: failed to validate pre-built binary kubectl (checked at "/go/src/sigs.k8s.io/gcp-compute-persistent-disk-csi-driver/deploy/kubernetes/overlays/stable-master/_rundir/b49d78b3-1599-11ed-bcf2-1217529f69d6/kubectl"): stat /go/src/sigs.k8s.io/gcp-compute-persistent-disk-csi-driver/deploy/kubernetes/overlays/stable-master/_rundir/b49d78b3-1599-11ed-bcf2-1217529f69d6/kubectl: no such file or directory
W0806 16:19:53.798] Error: exit status 255
W0806 16:19:53.804] I0806 16:19:53.803772    9868 main.go:750] Copying kubernetes binaries to path=/workspace/_artifacts/pd-volumesnapshotclass/b49d78b3-1599-11ed-bcf2-1217529f69d6 to run the tests
W0806 16:19:53.804] I0806 16:19:53.803826    9868 main.go:805] copying /tmp/gcp-pd-driver-tmp235504005/kubernetes/_output/dockerized/bin/linux/amd64/kubectl to /workspace/_artifacts/pd-volumesnapshotclass/b49d78b3-1599-11ed-bcf2-1217529f69d6/kubectl
W0806 16:19:54.011] I0806 16:19:54.010623    9868 main.go:805] copying /tmp/gcp-pd-driver-tmp235504005/kubernetes/_output/dockerized/bin/linux/amd64/e2e.test to /workspace/_artifacts/pd-volumesnapshotclass/b49d78b3-1599-11ed-bcf2-1217529f69d6/e2e.test
W0806 16:19:55.145] I0806 16:19:55.145348    9868 main.go:805] copying /tmp/gcp-pd-driver-tmp235504005/kubernetes/_output/dockerized/bin/linux/amd64/ginkgo to /workspace/_artifacts/pd-volumesnapshotclass/b49d78b3-1599-11ed-bcf2-1217529f69d6/ginkgo
W0806 16:19:55.197] I0806 16:19:55.196893    9868 utils.go:16] Running Tests
W0806 16:19:55.197] I0806 16:19:55.197361    9868 utils.go:17] cmd env=[]
W0806 16:19:55.198] I0806 16:19:55.197648    9868 utils.go:18] cmd args=[kubetest2 gce --run-id=b49d78b3-1599-11ed-bcf2-1217529f69d6 --test=ginkgo --legacy-mode --repo-root=/tmp/gcp-pd-driver-tmp235504005/kubernetes --artifacts=/workspace/_artifacts/pd-volumesnapshotclass -- --use-built-binaries --focus-regex=Driver:\s*csi-gcepd.*Feature:VolumeSnapshotDataSource --skip-regex=\[Disruptive\]|\[Serial\]|\[LinuxOnly\] --parallel=4 --test-args=--storage.testdriver=/go/src/sigs.k8s.io/gcp-compute-persistent-disk-csi-driver/test/k8s-integration/config/test-config.yaml  --node-os-distro=windows --allowed-not-ready-nodes=2]
W0806 16:19:55.266] I0806 16:19:55.266310  178510 app.go:61] The files in RunDir shall not be part of Artifacts
W0806 16:19:55.266] I0806 16:19:55.266405  178510 app.go:62] pass rundir-in-artifacts flag True for RunDir to be part of Artifacts
W0806 16:19:55.267] I0806 16:19:55.266433  178510 app.go:64] RunDir for this run: "/go/src/sigs.k8s.io/gcp-compute-persistent-disk-csi-driver/deploy/kubernetes/overlays/stable-master/_rundir/b49d78b3-1599-11ed-bcf2-1217529f69d6"
W0806 16:19:55.270] I0806 16:19:55.270377  178510 app.go:128] ID for this run: "b49d78b3-1599-11ed-bcf2-1217529f69d6"
W0806 16:19:55.293] I0806 16:19:55.292829  178525 ginkgo.go:136] Using kubeconfig at /root/.kube/config
W0806 16:19:55.294] F0806 16:19:55.293511  178525 ginkgo.go:254] failed to run ginkgo tester: failed to validate pre-built binary kubectl (checked at "/go/src/sigs.k8s.io/gcp-compute-persistent-disk-csi-driver/deploy/kubernetes/overlays/stable-master/_rundir/b49d78b3-1599-11ed-bcf2-1217529f69d6/kubectl"): stat /go/src/sigs.k8s.io/gcp-compute-persistent-disk-csi-driver/deploy/kubernetes/overlays/stable-master/_rundir/b49d78b3-1599-11ed-bcf2-1217529f69d6/kubectl: no such file or directory
W0806 16:19:55.298] Error: exit status 255
W0806 16:19:55.303] I0806 16:19:55.302886    9868 utils.go:16] Deleting driver
W0806 16:19:55.306] I0806 16:19:55.302906    9868 utils.go:17] cmd env=[KUBERNETES_SERVICE_PORT_HTTPS=443 GCE_SSH_PUBLIC_KEY_FILE=/etc/ssh-key-secret/ssh-public KUBERNETES_SERVICE_PORT=443 JOB_TYPE=periodic BOSKOS_METRICS_SERVICE_PORT=9090 JENKINS_GCE_SSH_PRIVATE_KEY_FILE=/etc/ssh-key-secret/ssh-private HOSTNAME=b49d78b3-1599-11ed-bcf2-1217529f69d6 BOSKOS_PORT_80_TCP_ADDR=10.63.250.132 KUBE_GCE_ENABLE_IP_ALIASES=true CLOUDSDK_CORE_DISABLE_PROMPTS=1 BOSKOS_METRICS_SERVICE_HOST=10.63.252.110 PREPULL_YAML=/go/src/sigs.k8s.io/gcp-compute-persistent-disk-csi-driver/test/k8s-integration/prepull.yaml LOG_DUMP_SCRIPT_PATH=/workspace/log-dump.sh GCS_ARTIFACTS_DIR=gs://kubernetes-jenkins/logs/ci-gce-pd-csi-driver-latest-k8s-master-windows-20h2/1555933975585755136/artifacts DOCKER_IN_DOCKER_IPV6_ENABLED=false PWD=/go/src/sigs.k8s.io/gcp-compute-persistent-disk-csi-driver BOSKOS_SERVICE_PORT=80 SOURCE_DATE_EPOCH=1659454995 BOSKOS_SERVICE_HOST=10.63.250.132 GOOGLE_APPLICATION_CREDENTIALS=/etc/service-account/service-account.json BUILD_NUMBER=1555933975585755136 NUM_WINDOWS_NODES=3 TEST_TMPDIR=/bazel-scratch/.cache/bazel DOCKER_IN_DOCKER_ENABLED=true HOME=/root AWS_ROLE_SESSION_NAME=b49d78b3-1599-11ed-bcf2-1217529f69d6 ARTIFACTS=/workspace/_artifacts KUBERNETES_PORT_443_TCP=tcp://10.63.240.1:443 IMAGE=gcr.io/k8s-staging-test-infra/kubekins-e2e:v20220804-4fa19ea91a-master BOSKOS_METRICS_PORT_9090_TCP_PORT=9090 KUBETEST_IN_DOCKER=true BAZEL_REMOTE_CACHE_ENABLED=false CLOUDSDK_CONFIG=/go/src/sigs.k8s.io/gcp-compute-persistent-disk-csi-driver/.config/gcloud BOOTSTRAP_MIGRATION=yes GCE_SSH_PRIVATE_KEY_FILE=/etc/ssh-key-secret/ssh-private PROW_JOB_ID=b49d78b3-1599-11ed-bcf2-1217529f69d6 JOB_NAME=ci-gce-pd-csi-driver-latest-k8s-master-windows-20h2 BOSKOS_SERVICE_PORT_DEFAULT=80 BOSKOS_PORT_80_TCP_PORT=80 WORKSPACE=/workspace BOSKOS_METRICS_PORT_9090_TCP_PROTO=tcp JENKINS_GCE_SSH_PUBLIC_KEY_FILE=/etc/ssh-key-secret/ssh-public BOSKOS_METRICS_SERVICE_PORT_METRICS=9090 BOSKOS_PORT=tcp://10.63.250.132:80 BOSKOS_PORT_80_TCP=tcp://10.63.250.132:80 BOSKOS_PORT_80_TCP_PROTO=tcp TERM=xterm NODE_NAME=b49d78b3-1599-11ed-bcf2-1217529f69d6 USER=prow KUBE_BUILD_PLATFORMS=linux/amd64 windows/amd64 AWS_SSH_PRIVATE_KEY_FILE=/root/.ssh/kube_aws_rsa BOSKOS_METRICS_PORT_9090_TCP_ADDR=10.63.252.110 GOPROXY=https://proxy.golang.org SHLVL=2 USE_TEST_INFRA_LOG_DUMPING=true KUBERNETES_PORT_443_TCP_PROTO=tcp KUBERNETES_PORT_443_TCP_ADDR=10.63.240.1 JOB_SPEC={"type":"periodic","job":"ci-gce-pd-csi-driver-latest-k8s-master-windows-20h2","buildid":"1555933975585755136","prowjobid":"b49d78b3-1599-11ed-bcf2-1217529f69d6","extra_refs":[{"org":"kubernetes-sigs","repo":"gcp-compute-persistent-disk-csi-driver","base_ref":"master","path_alias":"sigs.k8s.io/gcp-compute-persistent-disk-csi-driver"}]} KUBELET_TEST_ARGS=--feature-gates=KubeletPodResources=false BAZEL_VERSION=3.4.1 BOSKOS_METRICS_PORT=tcp://10.63.252.110:9090 E2E_GOOGLE_APPLICATION_CREDENTIALS=/etc/service-account/service-account.json BOSKOS_METRICS_PORT_9090_TCP=tcp://10.63.252.110:9090 KUBERNETES_SERVICE_HOST=10.63.240.1 KUBERNETES_NODE_PLATFORM=windows KUBERNETES_PORT=tcp://10.63.240.1:443 KUBERNETES_PORT_443_TCP_PORT=443 WINDOWS_ENABLE_DSR=true NUM_NODES=1 PATH=/go/bin:/go/bin:/usr/local/go/bin:/google-cloud-sdk/bin:/workspace:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin CI=true GOOGLE_APPLICATION_CREDENTIALS_DEPRECATED=Migrate to workload identity, contact sig-testing GO_TARBALL=go1.19.linux-amd64.tar.gz WINDOWS_NODE_OS_DISTRIBUTION=win20h2 BUILD_ID=1555933975585755136 AWS_SSH_PUBLIC_KEY_FILE=/root/.ssh/kube_aws_rsa.pub OLDPWD=/workspace/test-infra GOPATH=/go _=/go/src/sigs.k8s.io/gcp-compute-persistent-disk-csi-driver/bin/k8s-integration-test PROJECT=k8s-gci-gce-ingress1-5 GCE_PD_CSI_STAGING_VERSION=b0534223-1f26-41d5-9c61-c268c1de8ee3 GCE_PD_CSI_STAGING_IMAGE=gcr.io/k8s-gci-gce-ingress1-5/gcp-persistent-disk-csi-driver GCE_PD_KUBECTL=/tmp/gcp-pd-driver-tmp235504005/kubernetes/cluster/kubectl.sh MASTER_SIZE=n1-standard-4 KUBE_GCE_ZONE=us-central1-b KUBECONFIG=/root/.kube/config GOPATH=/go GCE_PD_DRIVER_VERSION=stable-master]
W0806 16:19:55.307] I0806 16:19:55.302953    9868 utils.go:18] cmd args=[/go/src/sigs.k8s.io/gcp-compute-persistent-disk-csi-driver/deploy/kubernetes/delete-driver.sh]
I0806 16:19:55.407] PKGDIR is /go/src/sigs.k8s.io/gcp-compute-persistent-disk-csi-driver
I0806 16:19:55.407] installing kustomize
I0806 16:19:56.608] {Version:kustomize/v3.9.4 GitCommit:e41d94ddef8cca7af2709c4104b41c4d43cd236c BuildDate:2021-02-09T19:22:10Z GoOs:linux GoArch:amd64}
... skipping 92 lines ...
W0806 16:28:11.952]   Associated tags:
W0806 16:28:11.954]  - b0534223-1f26-41d5-9c61-c268c1de8ee3
W0806 16:28:11.954] Tags:
W0806 16:28:11.955] - gcr.io/k8s-gci-gce-ingress1-5/gcp-persistent-disk-csi-driver:b0534223-1f26-41d5-9c61-c268c1de8ee3
W0806 16:28:12.160] Deleted [gcr.io/k8s-gci-gce-ingress1-5/gcp-persistent-disk-csi-driver:b0534223-1f26-41d5-9c61-c268c1de8ee3].
W0806 16:28:12.509] Deleted [gcr.io/k8s-gci-gce-ingress1-5/gcp-persistent-disk-csi-driver@sha256:50ba9932235804f86015c09fc38e698ba6296a5520fa4349e69690e2f9967f63].
W0806 16:28:14.393] F0806 16:28:14.393352    9868 main.go:196] Failed to run integration test: runCSITests failed: failed to run tests on e2e cluster: exit status 1 failed to run tests on e2e cluster: exit status 1
W0806 16:28:14.422] Traceback (most recent call last):
W0806 16:28:14.422]   File "/workspace/./test-infra/jenkins/../scenarios/execute.py", line 50, in <module>
W0806 16:28:14.428]     main(ARGS.env, ARGS.cmd + ARGS.args)
W0806 16:28:14.429]   File "/workspace/./test-infra/jenkins/../scenarios/execute.py", line 41, in main
W0806 16:28:14.429]     check(*cmd)
W0806 16:28:14.429]   File "/workspace/./test-infra/jenkins/../scenarios/execute.py", line 30, in check
W0806 16:28:14.430]     subprocess.check_call(cmd)
W0806 16:28:14.430]   File "/usr/lib/python2.7/subprocess.py", line 190, in check_call
W0806 16:28:14.436]     raise CalledProcessError(retcode, cmd)
W0806 16:28:14.437] subprocess.CalledProcessError: Command '('test/run-windows-k8s-integration.sh',)' returned non-zero exit status 255
E0806 16:28:14.451] Command failed
I0806 16:28:14.451] process 431 exited with code 1 after 79.0m
E0806 16:28:14.452] FAIL: ci-gce-pd-csi-driver-latest-k8s-master-windows-20h2
I0806 16:28:14.454] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0806 16:28:15.672] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0806 16:28:15.976] process 180022 exited with code 0 after 0.0m
I0806 16:28:15.977] Call:  gcloud config get-value account
I0806 16:28:17.249] process 180036 exited with code 0 after 0.0m
I0806 16:28:17.249] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0806 16:28:17.250] Upload result and artifacts...
I0806 16:28:17.250] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-gce-pd-csi-driver-latest-k8s-master-windows-20h2/1555933975585755136
I0806 16:28:17.251] Call:  gsutil ls gs://kubernetes-jenkins/logs/ci-gce-pd-csi-driver-latest-k8s-master-windows-20h2/1555933975585755136/artifacts
W0806 16:28:19.824] CommandException: One or more URLs matched no objects.
E0806 16:28:20.267] Command failed
I0806 16:28:20.267] process 180050 exited with code 1 after 0.1m
W0806 16:28:20.268] Remote dir gs://kubernetes-jenkins/logs/ci-gce-pd-csi-driver-latest-k8s-master-windows-20h2/1555933975585755136/artifacts not exist yet
I0806 16:28:20.268] Call:  gsutil -m -q -o GSUtil:use_magicfile=True cp -r -c -z log,txt,xml /workspace/_artifacts gs://kubernetes-jenkins/logs/ci-gce-pd-csi-driver-latest-k8s-master-windows-20h2/1555933975585755136/artifacts
I0806 16:28:26.142] process 180190 exited with code 0 after 0.1m
W0806 16:28:26.143] metadata path /workspace/_artifacts/metadata.json does not exist
W0806 16:28:26.143] metadata not found or invalid, init with empty metadata
... skipping 15 lines ...