This job view page is being replaced by Spyglass soon. Check out the new job view.
ResultFAILURE
Tests 0 failed / 0 succeeded
Started2022-06-26 19:11
Elapsed1h32m
Revision
Builderc21a6b31-f583-11ec-9e31-9224b4edca5e
infra-commit4f908f97b
reposigs.k8s.io/gcp-compute-persistent-disk-csi-driver
repo-commit8c3c4241cec03379e0a0a34c8f543c9234995a32
repos{u'sigs.k8s.io/gcp-compute-persistent-disk-csi-driver': u'master'}

No Test Failures!


Error lines from build-log.txt

... skipping 155 lines ...
W0626 19:14:13.147] I0626 19:14:13.147269    6529 utils.go:17] cmd env=[]
W0626 19:14:13.148] I0626 19:14:13.147277    6529 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=95dbcf30-5e87-4d9a-8001-5bff06252a81 GCE_PD_CSI_STAGING_IMAGE=gcr.io/k8s-gce-1-5/gcp-persistent-disk-csi-driver]
W0626 19:14:13.149] Makefile:48: gcp-pd-driver-windows only supports amd64.
I0626 19:14:13.249] make: Entering directory '/go/src/sigs.k8s.io/gcp-compute-persistent-disk-csi-driver'
I0626 19:14:13.250] # Ensure we use a builder that can leverage it (the default on linux will not)
I0626 19:14:13.250] DOCKER_CLI_EXPERIMENTAL=enabled docker buildx rm multiarch-multiplatform-builder
W0626 19:14:13.376] error: no builder "multiarch-multiplatform-builder" found
W0626 19:14:13.386] make: [Makefile:134: init-buildx] Error 1 (ignored)
I0626 19:14:13.487] DOCKER_CLI_EXPERIMENTAL=enabled docker buildx create --use --name=multiarch-multiplatform-builder
I0626 19:14:13.535] multiarch-multiplatform-builder
I0626 19:14:13.542] DOCKER_CLI_EXPERIMENTAL=enabled docker run --rm --privileged multiarch/qemu-user-static --reset --credential yes --persistent yes
W0626 19:14:13.643] Unable to find image 'multiarch/qemu-user-static:latest' locally
W0626 19:14:13.820] latest: Pulling from multiarch/qemu-user-static
W0626 19:14:13.820] 19d511225f94: Pulling fs layer
... skipping 250 lines ...
W0626 19:14:42.614] #11 8.211 Setting up libtinfo6:amd64 (6.1+20181013-2+deb10u2) ...
W0626 19:14:42.615] #11 8.276 Selecting previously unselected package bash.
W0626 19:14:42.615] #11 8.276 (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.)
W0626 19:14:42.616] #11 8.290 Preparing to unpack .../archives/bash_5.0-4_amd64.deb ...
W0626 19:14:42.616] #11 8.304 Unpacking bash (5.0-4) ...
W0626 19:14:42.616] #11 8.622 Setting up bash (5.0-4) ...
W0626 19:14:42.616] #11 8.653 update-alternatives: error: alternative path /usr/share/man/man7/bash-builtins.7.gz doesn't exist

W0626 19:14:42.617] #11 8.743 Selecting previously unselected package libuuid1:amd64.
W0626 19:14:42.617] #11 8.743 (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.)
W0626 19:14:42.618] #11 8.753 Preparing to unpack .../libuuid1_2.33.1-0.1_amd64.deb ...
W0626 19:14:42.618] #11 8.758 Unpacking libuuid1:amd64 (2.33.1-0.1) ...
W0626 19:14:42.618] #11 8.809 Setting up libuuid1:amd64 (2.33.1-0.1) ...
W0626 19:14:42.618] #11 8.865 Selecting previously unselected package libblkid1:amd64.
... skipping 493 lines ...
W0626 19:16:21.922] #12 49.19 Setting up libtinfo6:arm64 (6.1+20181013-2+deb10u2) ...
W0626 19:16:22.361] #12 49.49 Selecting previously unselected package bash.
W0626 19:16:22.362] #12 49.49 (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.)
W0626 19:16:22.362] #12 49.52 Preparing to unpack .../archives/bash_5.0-4_arm64.deb ...
W0626 19:16:22.362] #12 49.63 Unpacking bash (5.0-4) ...
W0626 19:16:23.695] #12 50.96 Setting up bash (5.0-4) ...
W0626 19:16:23.997] #12 51.15 update-alternatives: error: alternative path /usr/share/man/man7/bash-builtins.7.gz doesn't exist

W0626 19:16:25.502] #12 52.62 Selecting previously unselected package libuuid1:arm64.
W0626 19:16:25.503] #12 52.62 (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.)
W0626 19:16:25.503] #12 52.64 Preparing to unpack .../libuuid1_2.33.1-0.1_arm64.deb ...
W0626 19:16:25.503] #12 52.65 Unpacking libuuid1:arm64 (2.33.1-0.1) ...
W0626 19:16:25.803] #12 53.01 Setting up libuuid1:arm64 (2.33.1-0.1) ...
W0626 19:16:26.058] #12 53.32 Selecting previously unselected package libblkid1:arm64.
... skipping 879 lines ...
W0626 20:02:24.125] NODE_NAMES=e2e-test-prow-minion-group-j8j7
W0626 20:02:24.126] Trying to find master named 'e2e-test-prow-master'
W0626 20:02:24.126] Looking for address 'e2e-test-prow-master-ip'
I0626 20:02:25.401] Waiting up to 300 seconds for cluster initialization.
I0626 20:02:25.402] 
I0626 20:02:25.402]   This will continually check to see if the API for kubernetes is reachable.
I0626 20:02:25.402]   This may time out if there was some uncaught error during start up.
I0626 20:02:25.402] 
W0626 20:02:25.503] Using master: e2e-test-prow-master (external IP: 146.148.68.212; internal IP: (not set))
I0626 20:03:17.519] ................Kubernetes cluster created.
I0626 20:03:17.670] Cluster "k8s-gce-1-5_e2e-test-prow" set.
I0626 20:03:17.815] User "k8s-gce-1-5_e2e-test-prow" set.
I0626 20:03:17.957] Context "k8s-gce-1-5_e2e-test-prow" created.
... skipping 49 lines ...
I0626 20:10:15.831] e2e-test-prow-minion-group-j8j7         Ready                      <none>   6m20s   v1.25.0-alpha.1.139+f4abde9e57cc30
I0626 20:10:15.831] e2e-test-prow-windows-node-group-339z   Ready                      <none>   25s     v1.25.0-alpha.1.139+f4abde9e57cc30
I0626 20:10:15.831] e2e-test-prow-windows-node-group-kjr7   Ready                      <none>   20s     v1.25.0-alpha.1.139+f4abde9e57cc30
I0626 20:10:15.831] e2e-test-prow-windows-node-group-vdln   Ready                      <none>   14s     v1.25.0-alpha.1.139+f4abde9e57cc30
W0626 20:10:16.005] Warning: v1 ComponentStatus is deprecated in v1.19+
I0626 20:10:16.106] Validate output:
I0626 20:10:16.191] NAME                 STATUS    MESSAGE                         ERROR
I0626 20:10:16.191] etcd-1               Healthy   {"health":"true","reason":""}   
I0626 20:10:16.191] etcd-0               Healthy   {"health":"true","reason":""}   
I0626 20:10:16.191] scheduler            Healthy   ok                              
I0626 20:10:16.192] controller-manager   Healthy   ok                              
I0626 20:10:16.195] Cluster validation succeeded
W0626 20:10:16.296] Warning: v1 ComponentStatus is deprecated in v1.19+
... skipping 98 lines ...
I0626 20:12:20.640] GCE_PD_SA_DIR is /tmp/gcp-pd-driver-tmp514839081
I0626 20:12:20.640] PKGDIR is /go/src/sigs.k8s.io/gcp-compute-persistent-disk-csi-driver
I0626 20:12:20.640] installing kustomize
I0626 20:12:21.532] {Version:kustomize/v3.9.4 GitCommit:e41d94ddef8cca7af2709c4104b41c4d43cd236c BuildDate:2021-02-09T19:22:10Z GoOs:linux GoArch:amd64}
W0626 20:12:21.674] + [[ true != true ]]
W0626 20:12:21.674] + /tmp/gcp-pd-driver-tmp4236136942/kubernetes/cluster/kubectl.sh get namespace gce-pd-csi-driver -v=2
W0626 20:12:21.831] Error from server (NotFound): namespaces "gce-pd-csi-driver" not found
W0626 20:12:21.834] + /tmp/gcp-pd-driver-tmp4236136942/kubernetes/cluster/kubectl.sh create namespace gce-pd-csi-driver -v=2
I0626 20:12:21.993] namespace/gce-pd-csi-driver created
W0626 20:12:22.093] + [[ ! stable-master == *noauth* ]]
W0626 20:12:22.093] + /tmp/gcp-pd-driver-tmp4236136942/kubernetes/cluster/kubectl.sh get secret cloud-sa -v=2 -n gce-pd-csi-driver
W0626 20:12:22.150] Error from server (NotFound): secrets "cloud-sa" not found
W0626 20:12:22.154] + /tmp/gcp-pd-driver-tmp4236136942/kubernetes/cluster/kubectl.sh create secret generic cloud-sa -v=2 --from-file=/tmp/gcp-pd-driver-tmp514839081/cloud-sa.json -n gce-pd-csi-driver
I0626 20:12:22.303] secret/cloud-sa created
W0626 20:12:22.403] + /tmp/gcp-pd-driver-tmp4236136942/kubernetes/cluster/kubectl.sh get clusterrolebinding -v=2 cluster-admin-binding
W0626 20:12:22.460] Error from server (NotFound): clusterrolebindings.rbac.authorization.k8s.io "cluster-admin-binding" not found
W0626 20:12:22.464] ++ gcloud config get-value account
W0626 20:12:23.202] + /tmp/gcp-pd-driver-tmp4236136942/kubernetes/cluster/kubectl.sh create clusterrolebinding cluster-admin-binding -v=2 --clusterrole cluster-admin --user pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0626 20:12:23.350] clusterrolebinding.rbac.authorization.k8s.io/cluster-admin-binding created
W0626 20:12:23.453] + /tmp/gcp-pd-driver-tmp4236136942/kubernetes/cluster/kubectl.sh version
W0626 20:12:23.514] 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.
W0626 20:12:23.518] + readonly tmp_spec=/tmp/gcp-compute-persistent-disk-csi-driver-specs-generated.yaml
... skipping 521 lines ...
I0626 20:12:24.881]       - args:
I0626 20:12:24.881]         - --v=5
I0626 20:12:24.881]         - --csi-address=/csi/csi.sock
I0626 20:12:24.882]         - --http-endpoint=:22013
I0626 20:12:24.882]         - --leader-election
I0626 20:12:24.882]         - --leader-election-namespace=$(PDCSI_NAMESPACE)
I0626 20:12:24.882]         - --handle-volume-inuse-error=false
I0626 20:12:24.882]         env:
I0626 20:12:24.882]         - name: PDCSI_NAMESPACE
I0626 20:12:24.882]           valueFrom:
I0626 20:12:24.882]             fieldRef:
I0626 20:12:24.882]               fieldPath: metadata.namespace
I0626 20:12:24.882]         image: k8s.gcr.io/sig-storage/csi-resizer:v1.4.0
... skipping 383 lines ...
I0626 20:28:07.979]     Args:
I0626 20:28:07.979]       --v=5
I0626 20:28:07.979]       --csi-address=/csi/csi.sock
I0626 20:28:07.979]       --http-endpoint=:22013
I0626 20:28:07.979]       --leader-election
I0626 20:28:07.979]       --leader-election-namespace=$(PDCSI_NAMESPACE)
I0626 20:28:07.979]       --handle-volume-inuse-error=false
I0626 20:28:07.979]     State:          Running
I0626 20:28:07.979]       Started:      Sun, 26 Jun 2022 20:12:39 +0000
I0626 20:28:07.979]     Ready:          True
I0626 20:28:07.979]     Restart Count:  0
I0626 20:28:07.980]     Liveness:       http-get http://:http-endpoint/healthz/leader-election delay=10s timeout=10s period=20s #success=1 #failure=1
I0626 20:28:07.980]     Environment:
... skipping 481 lines ...
I0626 20:28:08.025]   Normal   Created    15m                    kubelet            Created container csi-driver-registrar
I0626 20:28:08.026]   Normal   Started    15m                    kubelet            Started container csi-driver-registrar
I0626 20:28:08.026]   Normal   Pulling    15m                    kubelet            Pulling image "gcr.io/k8s-gce-1-5/gcp-persistent-disk-csi-driver:95dbcf30-5e87-4d9a-8001-5bff06252a81"
I0626 20:28:08.026]   Normal   Pulled     3m51s                  kubelet            Successfully pulled image "gcr.io/k8s-gce-1-5/gcp-persistent-disk-csi-driver:95dbcf30-5e87-4d9a-8001-5bff06252a81" in 11m17.3142401s
I0626 20:28:08.026]   Normal   Created    3m51s                  kubelet            Created container gce-pd-driver
I0626 20:28:08.026]   Normal   Started    3m25s                  kubelet            Started container gce-pd-driver
I0626 20:28:08.026]   Warning  Unhealthy  2m41s (x2 over 3m19s)  kubelet            Liveness probe failed: command "/csi-node-driver-registrar.exe --kubelet-registration-path=C:\\\\var\\\\lib\\\\kubelet\\\\plugins\\\\pd.csi.storage.gke.io\\\\csi.sock --mode=kubelet-registration-probe" timed out
I0626 20:28:08.027] 
I0626 20:28:08.027] 
I0626 20:28:08.027] Name:                 csi-gce-pd-node-win-f55zr
I0626 20:28:08.027] Namespace:            gce-pd-csi-driver
I0626 20:28:08.027] Priority:             900001000
I0626 20:28:08.027] Priority Class Name:  csi-gce-pd-node
... skipping 118 lines ...
I0626 20:28:08.051]   ----     ------     ----                 ----               -------
I0626 20:28:08.052]   Normal   Scheduled  15m                  default-scheduler  Successfully assigned gce-pd-csi-driver/csi-gce-pd-node-win-f55zr to e2e-test-prow-windows-node-group-vdln
I0626 20:28:08.053]   Normal   Pulling    15m                  kubelet            Pulling image "k8s.gcr.io/sig-storage/csi-node-driver-registrar:v2.5.0"
I0626 20:28:08.053]   Normal   Pulled     15m                  kubelet            Successfully pulled image "k8s.gcr.io/sig-storage/csi-node-driver-registrar:v2.5.0" in 26.061297s
I0626 20:28:08.054]   Normal   Created    15m                  kubelet            Created container csi-driver-registrar
I0626 20:28:08.054]   Normal   Started    15m                  kubelet            Started container csi-driver-registrar
I0626 20:28:08.055]   Warning  Failed     4m57s                kubelet            Failed to pull image "gcr.io/k8s-gce-1-5/gcp-persistent-disk-csi-driver:95dbcf30-5e87-4d9a-8001-5bff06252a81": rpc error: code = Unknown desc = failed to pull and unpack image "gcr.io/k8s-gce-1-5/gcp-persistent-disk-csi-driver:95dbcf30-5e87-4d9a-8001-5bff06252a81": failed to extract layer sha256:a9d5f7b786acfbd84dfc048ddd0b5470593590a8fa3a8670633599561f968bb4: link \\?\C:\ProgramData\containerd\root\io.containerd.snapshotter.v1.windows\snapshots\40\Files\Windows\servicing\Packages\HyperV-IntegrationComponents-VirtualDevice-Core-Package~31bf3856ad364e35~amd64~~10.0.17763.1.cat \\?\C:\ProgramData\containerd\root\io.containerd.snapshotter.v1.windows\snapshots\41\Files\Windows\System32\CatRoot\{F750E6C3-38EE-11D1-85E5-00C04FC295EE}\HyperV-IntegrationComponents-VirtualDevice-Core-Package~31bf3856ad364e35~amd64~~10.0.17763.1.cat: Access is denied.: unknown
I0626 20:28:08.056]   Normal   BackOff    4m56s                kubelet            Back-off pulling image "gcr.io/k8s-gce-1-5/gcp-persistent-disk-csi-driver:95dbcf30-5e87-4d9a-8001-5bff06252a81"
I0626 20:28:08.056]   Warning  Unhealthy  4m48s                kubelet            Liveness probe failed: command "/csi-node-driver-registrar.exe --kubelet-registration-path=C:\\\\var\\\\lib\\\\kubelet\\\\plugins\\\\pd.csi.storage.gke.io\\\\csi.sock --mode=kubelet-registration-probe" timed out
I0626 20:28:08.056]   Normal   Pulling    4m43s (x2 over 15m)  kubelet            Pulling image "gcr.io/k8s-gce-1-5/gcp-persistent-disk-csi-driver:95dbcf30-5e87-4d9a-8001-5bff06252a81"
I0626 20:28:08.057]   Warning  Unhealthy  4m41s                kubelet            Liveness probe failed: F0626 20:23:27.117925    4068 main.go:159] Kubelet plugin registration hasn't succeeded yet, file=C:\var\lib\kubelet\plugins\pd.csi.storage.gke.io\registration doesn't exist.
I0626 20:28:08.057] goroutine 1 [running]:
I0626 20:28:08.058] k8s.io/klog/v2.stacks(0x1)
I0626 20:28:08.058]   /workspace/vendor/k8s.io/klog/v2/klog.go:1038 +0x8a
I0626 20:28:08.058] k8s.io/klog/v2.(*loggingT).output(0x1ec1b60, 0x3, 0x0, 0xc0001ead20, 0x0, {0x1b82787, 0x1}, 0xc00024c540, 0x0)
I0626 20:28:08.058]   /workspace/vendor/k8s.io/klog/v2/klog.go:987 +0x5fd
I0626 20:28:08.058] k8s.io/klog/v2.(*loggingT).printf(0x1995ee0, 0x4, 0x0, {0x0, 0x0}, {0x19bef3b, 0x48}, {0xc00024c540, 0x1, 0x1})
... skipping 5 lines ...
I0626 20:28:08.060] 
I0626 20:28:08.060] goroutine 7 [chan receive]:
I0626 20:28:08.060] k8s.io/klog/v2.(*loggingT).flushDaemon(0xc0000a4000)
I0626 20:28:08.060]   /workspace/vendor/k8s.io/klog/v2/klog.go:1181 +0x6a
I0626 20:28:08.060] created by k8s.io/klog/v2.init.0
I0626 20:28:08.061]            /workspace/vendor/k8s.io/klog/v2/klog.go:420 +0xfb
I0626 20:28:08.062]   Warning  Unhealthy  4m32s  kubelet  Liveness probe failed: F0626 20:23:36.951840    1844 main.go:159] Kubelet plugin registration hasn't succeeded yet, file=C:\var\lib\kubelet\plugins\pd.csi.storage.gke.io\registration doesn't exist.
I0626 20:28:08.062] goroutine 1 [running]:
I0626 20:28:08.063] k8s.io/klog/v2.stacks(0x1)
I0626 20:28:08.063]   /workspace/vendor/k8s.io/klog/v2/klog.go:1038 +0x8a
I0626 20:28:08.064] k8s.io/klog/v2.(*loggingT).output(0x1d11b60, 0x3, 0x0, 0xc0001bcc40, 0x0, {0x19d2787, 0x1}, 0xc00021e520, 0x0)
I0626 20:28:08.064]   /workspace/vendor/k8s.io/klog/v2/klog.go:987 +0x5fd
I0626 20:28:08.065] k8s.io/klog/v2.(*loggingT).printf(0x17e5ee0, 0x4, 0x0, {0x0, 0x0}, {0x180ef3b, 0x48}, {0xc00021e520, 0x1, 0x1})
... skipping 139 lines ...
I0626 20:28:08.081]   Normal   Created    15m                   kubelet            Created container csi-driver-registrar
I0626 20:28:08.081]   Normal   Started    15m                   kubelet            Started container csi-driver-registrar
I0626 20:28:08.081]   Normal   Pulling    15m                   kubelet            Pulling image "gcr.io/k8s-gce-1-5/gcp-persistent-disk-csi-driver:95dbcf30-5e87-4d9a-8001-5bff06252a81"
I0626 20:28:08.082]   Normal   Pulled     4m3s                  kubelet            Successfully pulled image "gcr.io/k8s-gce-1-5/gcp-persistent-disk-csi-driver:95dbcf30-5e87-4d9a-8001-5bff06252a81" in 11m6.6911088s
I0626 20:28:08.082]   Normal   Created    4m2s                  kubelet            Created container gce-pd-driver
I0626 20:28:08.082]   Normal   Started    3m35s                 kubelet            Started container gce-pd-driver
I0626 20:28:08.082]   Warning  Unhealthy  111s (x2 over 3m30s)  kubelet            Liveness probe failed: command "/csi-node-driver-registrar.exe --kubelet-registration-path=C:\\\\var\\\\lib\\\\kubelet\\\\plugins\\\\pd.csi.storage.gke.io\\\\csi.sock --mode=kubelet-registration-probe" timed out
I0626 20:28:08.082] PKGDIR is /go/src/sigs.k8s.io/gcp-compute-persistent-disk-csi-driver
I0626 20:28:08.082] installing kustomize
W0626 20:28:08.183] I0626 20:28:08.067218    6529 utils.go:16] Deleting driver
W0626 20:28:08.186] I0626 20:28:08.067236    6529 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=c21a6b31-f583-11ec-9e31-9224b4edca5e 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-2019/1541137043529142272/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=1655412664 BOSKOS_SERVICE_HOST=10.63.250.132 GOOGLE_APPLICATION_CREDENTIALS=/etc/service-account/service-account.json BUILD_NUMBER=1541137043529142272 NUM_WINDOWS_NODES=3 TEST_TMPDIR=/bazel-scratch/.cache/bazel DOCKER_IN_DOCKER_ENABLED=true HOME=/root ARTIFACTS=/workspace/_artifacts KUBERNETES_PORT_443_TCP=tcp://10.63.240.1:443 IMAGE=gcr.io/k8s-staging-test-infra/kubekins-e2e:v20220624-1a63fdd9f2-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=c21a6b31-f583-11ec-9e31-9224b4edca5e JOB_NAME=ci-gce-pd-csi-driver-latest-k8s-master-windows-2019 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=c21a6b31-f583-11ec-9e31-9224b4edca5e 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-2019","buildid":"1541137043529142272","prowjobid":"c21a6b31-f583-11ec-9e31-9224b4edca5e","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.18.3.linux-amd64.tar.gz WINDOWS_NODE_OS_DISTRIBUTION=win2019 BUILD_ID=1541137043529142272 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-gce-1-5 GCE_PD_CSI_STAGING_VERSION=95dbcf30-5e87-4d9a-8001-5bff06252a81 GCE_PD_CSI_STAGING_IMAGE=gcr.io/k8s-gce-1-5/gcp-persistent-disk-csi-driver GCE_PD_KUBECTL=/tmp/gcp-pd-driver-tmp4236136942/kubernetes/cluster/kubectl.sh MASTER_SIZE=n1-standard-4 KUBE_GCE_ZONE=us-central1-b GOPATH=/go GCE_PD_DRIVER_VERSION=stable-master]
W0626 20:28:08.187] I0626 20:28:08.067297    6529 utils.go:18] cmd args=[/go/src/sigs.k8s.io/gcp-compute-persistent-disk-csi-driver/deploy/kubernetes/delete-driver.sh]
I0626 20:28:08.987] {Version:kustomize/v3.9.4 GitCommit:e41d94ddef8cca7af2709c4104b41c4d43cd236c BuildDate:2021-02-09T19:22:10Z GoOs:linux GoArch:amd64}
... skipping 92 lines ...
W0626 20:44:01.324]   Associated tags:
W0626 20:44:01.325]  - 95dbcf30-5e87-4d9a-8001-5bff06252a81
W0626 20:44:01.326] Tags:
W0626 20:44:01.326] - gcr.io/k8s-gce-1-5/gcp-persistent-disk-csi-driver:95dbcf30-5e87-4d9a-8001-5bff06252a81
W0626 20:44:01.516] Deleted [gcr.io/k8s-gce-1-5/gcp-persistent-disk-csi-driver:95dbcf30-5e87-4d9a-8001-5bff06252a81].
W0626 20:44:01.899] Deleted [gcr.io/k8s-gce-1-5/gcp-persistent-disk-csi-driver@sha256:a26ec14e2a6a94eb185be0f66bf1b22bd52ddaf0b2b8de47e9bc3af5d38d5519].
W0626 20:44:03.905] F0626 20:44:03.905067    6529 main.go:196] Failed to run integration test: failed to install CSI Driver: Windows deployment failed to come up: exit status 255
W0626 20:44:03.917] Traceback (most recent call last):
W0626 20:44:03.919]   File "/workspace/./test-infra/jenkins/../scenarios/execute.py", line 50, in <module>
W0626 20:44:03.923]     main(ARGS.env, ARGS.cmd + ARGS.args)
W0626 20:44:03.923]   File "/workspace/./test-infra/jenkins/../scenarios/execute.py", line 41, in main
W0626 20:44:03.923]     check(*cmd)
W0626 20:44:03.923]   File "/workspace/./test-infra/jenkins/../scenarios/execute.py", line 30, in check
W0626 20:44:03.923]     subprocess.check_call(cmd)
W0626 20:44:03.924]   File "/usr/lib/python2.7/subprocess.py", line 190, in check_call
W0626 20:44:03.924]     raise CalledProcessError(retcode, cmd)
W0626 20:44:03.924] subprocess.CalledProcessError: Command '('test/run-windows-k8s-integration.sh',)' returned non-zero exit status 255
E0626 20:44:03.956] Command failed
I0626 20:44:03.957] process 428 exited with code 1 after 92.4m
E0626 20:44:03.958] FAIL: ci-gce-pd-csi-driver-latest-k8s-master-windows-2019
I0626 20:44:03.962] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0626 20:44:05.579] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0626 20:44:05.896] process 174149 exited with code 0 after 0.0m
I0626 20:44:05.897] Call:  gcloud config get-value account
I0626 20:44:07.696] process 174163 exited with code 0 after 0.0m
I0626 20:44:07.697] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
... skipping 20 lines ...