This job view page is being replaced by Spyglass soon. Check out the new job view.
ResultFAILURE
Tests 0 failed / 0 succeeded
Started2022-08-10 12:33
Elapsed1h28m
Revision
Buildera4567e57-18a8-11ed-a3cd-9a8e9eec334c
infra-commit1f80799c2
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 333 lines ...
W0810 12:36:43.478] I0810 12:36:43.477850    9842 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=58da5aec-78b1-4542-9bbf-2d2545d27524 GCE_PD_CSI_STAGING_IMAGE=gcr.io/e2e-gce-gci-ci-master/gcp-persistent-disk-csi-driver]
W0810 12:36:43.479] Makefile:48: gcp-pd-driver-windows only supports amd64.
I0810 12:36:43.579] make: Entering directory '/go/src/sigs.k8s.io/gcp-compute-persistent-disk-csi-driver'
I0810 12:36:43.580] # Ensure we use a builder that can leverage it (the default on linux will not)
I0810 12:36:43.580] DOCKER_CLI_EXPERIMENTAL=enabled docker buildx rm multiarch-multiplatform-builder
I0810 12:36:43.599] DOCKER_CLI_EXPERIMENTAL=enabled docker buildx create --use --name=multiarch-multiplatform-builder
W0810 12:36:43.700] error: no builder "multiarch-multiplatform-builder" found
W0810 12:36:43.700] make: [Makefile:134: init-buildx] Error 1 (ignored)
W0810 12:36:43.786] Unable to find image 'multiarch/qemu-user-static:latest' locally
I0810 12:36:43.886] multiarch-multiplatform-builder
I0810 12:36:43.887] DOCKER_CLI_EXPERIMENTAL=enabled docker run --rm --privileged multiarch/qemu-user-static --reset --credential yes --persistent yes
W0810 12:36:44.016] latest: Pulling from multiarch/qemu-user-static
W0810 12:36:44.017] 19d511225f94: Pulling fs layer
W0810 12:36:44.017] 6a33d6a40b9b: Pulling fs layer
... skipping 276 lines ...
W0810 12:37:10.523] #11 7.546 Setting up libtinfo6:amd64 (6.1+20181013-2+deb10u2) ...
W0810 12:37:10.523] #11 7.600 Selecting previously unselected package bash.
W0810 12:37:10.524] #11 7.600 (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.)
W0810 12:37:10.524] #11 7.610 Preparing to unpack .../archives/bash_5.0-4_amd64.deb ...
W0810 12:37:10.525] #11 7.621 Unpacking bash (5.0-4) ...
W0810 12:37:10.525] #11 7.915 Setting up bash (5.0-4) ...
W0810 12:37:10.525] #11 7.945 update-alternatives: error: alternative path /usr/share/man/man7/bash-builtins.7.gz doesn't exist

W0810 12:37:10.525] #11 8.028 Selecting previously unselected package libuuid1:amd64.
W0810 12:37:10.526] #11 8.028 (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.)
W0810 12:37:10.526] #11 8.036 Preparing to unpack .../libuuid1_2.33.1-0.1_amd64.deb ...
W0810 12:37:10.526] #11 8.041 Unpacking libuuid1:amd64 (2.33.1-0.1) ...
W0810 12:37:10.526] #11 8.096 Setting up libuuid1:amd64 (2.33.1-0.1) ...
W0810 12:37:10.527] #11 8.147 Selecting previously unselected package libblkid1:amd64.
... skipping 482 lines ...
W0810 12:38:54.763] #11 51.30 Setting up libtinfo6:arm64 (6.1+20181013-2+deb10u2) ...
W0810 12:38:55.215] #11 51.62 Selecting previously unselected package bash.
W0810 12:38:55.216] #11 51.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 ... 3897 files and directories currently installed.)
W0810 12:38:55.216] #11 51.65 Preparing to unpack .../archives/bash_5.0-4_arm64.deb ...
W0810 12:38:55.365] #11 51.77 Unpacking bash (5.0-4) ...
W0810 12:38:56.521] #11 53.06 Setting up bash (5.0-4) ...
W0810 12:38:56.822] #11 53.24 update-alternatives: error: alternative path /usr/share/man/man7/bash-builtins.7.gz doesn't exist

W0810 12:38:58.128] #11 54.67 Selecting previously unselected package libuuid1:arm64.
W0810 12:38:58.279] #11 54.67 (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.)
W0810 12:38:58.280] #11 54.69 Preparing to unpack .../libuuid1_2.33.1-0.1_arm64.deb ...
W0810 12:38:58.280] #11 54.71 Unpacking libuuid1:arm64 (2.33.1-0.1) ...
W0810 12:38:58.579] #11 55.02 Setting up libuuid1:arm64 (2.33.1-0.1) ...
W0810 12:38:58.834] #11 55.34 Selecting previously unselected package libblkid1:arm64.
... skipping 935 lines ...
W0810 13:27:40.155] NODE_NAMES=e2e-test-prow-minion-group-8zq5
W0810 13:27:40.155] Trying to find master named 'e2e-test-prow-master'
W0810 13:27:40.156] Looking for address 'e2e-test-prow-master-ip'
I0810 13:27:41.345] Waiting up to 300 seconds for cluster initialization.
I0810 13:27:41.346] 
I0810 13:27:41.346]   This will continually check to see if the API for kubernetes is reachable.
I0810 13:27:41.346]   This may time out if there was some uncaught error during start up.
I0810 13:27:41.346] 
I0810 13:28:03.239] ........Kubernetes cluster created.
W0810 13:28:03.340] Using master: e2e-test-prow-master (external IP: 34.172.233.230; internal IP: (not set))
I0810 13:28:03.441] Cluster "e2e-gce-gci-ci-master_e2e-test-prow" set.
I0810 13:28:03.543] User "e2e-gce-gci-ci-master_e2e-test-prow" set.
I0810 13:28:03.697] Context "e2e-gce-gci-ci-master_e2e-test-prow" created.
... skipping 48 lines ...
I0810 13:35:01.543] e2e-test-prow-minion-group-8zq5         Ready                      <none>   6m28s   v1.26.0-alpha.0.5+a38bb7ed811a18
I0810 13:35:01.543] e2e-test-prow-windows-node-group-2kk0   Ready                      <none>   36s     v1.26.0-alpha.0.5+a38bb7ed811a18
I0810 13:35:01.544] e2e-test-prow-windows-node-group-k86q   Ready                      <none>   40s     v1.26.0-alpha.0.5+a38bb7ed811a18
I0810 13:35:01.544] e2e-test-prow-windows-node-group-t1j2   Ready                      <none>   24s     v1.26.0-alpha.0.5+a38bb7ed811a18
W0810 13:35:01.708] Warning: v1 ComponentStatus is deprecated in v1.19+
I0810 13:35:01.808] Validate output:
I0810 13:35:01.881] NAME                 STATUS    MESSAGE                         ERROR
I0810 13:35:01.882] etcd-1               Healthy   {"health":"true","reason":""}   
I0810 13:35:01.882] etcd-0               Healthy   {"health":"true","reason":""}   
I0810 13:35:01.882] controller-manager   Healthy   ok                              
I0810 13:35:01.882] scheduler            Healthy   ok                              
I0810 13:35:01.886] Cluster validation succeeded
W0810 13:35:01.987] Warning: v1 ComponentStatus is deprecated in v1.19+
... skipping 98 lines ...
I0810 13:36:31.013] GCE_PD_SA_DIR is /tmp/gcp-pd-driver-tmp1552393000
I0810 13:36:31.013] PKGDIR is /go/src/sigs.k8s.io/gcp-compute-persistent-disk-csi-driver
I0810 13:36:31.013] installing kustomize
I0810 13:36:32.300] {Version:kustomize/v3.9.4 GitCommit:e41d94ddef8cca7af2709c4104b41c4d43cd236c BuildDate:2021-02-09T19:22:10Z GoOs:linux GoArch:amd64}
W0810 13:36:32.433] + [[ true != true ]]
W0810 13:36:32.433] + /tmp/gcp-pd-driver-tmp1170496602/kubernetes/cluster/kubectl.sh get namespace gce-pd-csi-driver -v=2
W0810 13:36:32.589] Error from server (NotFound): namespaces "gce-pd-csi-driver" not found
W0810 13:36:32.593] + /tmp/gcp-pd-driver-tmp1170496602/kubernetes/cluster/kubectl.sh create namespace gce-pd-csi-driver -v=2
I0810 13:36:32.743] namespace/gce-pd-csi-driver created
W0810 13:36:32.844] + [[ ! stable-master == *noauth* ]]
W0810 13:36:32.844] + /tmp/gcp-pd-driver-tmp1170496602/kubernetes/cluster/kubectl.sh get secret cloud-sa -v=2 -n gce-pd-csi-driver
W0810 13:36:32.898] Error from server (NotFound): secrets "cloud-sa" not found
W0810 13:36:32.902] + /tmp/gcp-pd-driver-tmp1170496602/kubernetes/cluster/kubectl.sh create secret generic cloud-sa -v=2 --from-file=/tmp/gcp-pd-driver-tmp1552393000/cloud-sa.json -n gce-pd-csi-driver
I0810 13:36:33.055] secret/cloud-sa created
W0810 13:36:33.155] + /tmp/gcp-pd-driver-tmp1170496602/kubernetes/cluster/kubectl.sh get clusterrolebinding -v=2 cluster-admin-binding
W0810 13:36:33.210] Error from server (NotFound): clusterrolebindings.rbac.authorization.k8s.io "cluster-admin-binding" not found
W0810 13:36:33.215] ++ gcloud config get-value account
W0810 13:36:33.967] + /tmp/gcp-pd-driver-tmp1170496602/kubernetes/cluster/kubectl.sh create clusterrolebinding cluster-admin-binding -v=2 --clusterrole cluster-admin --user pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0810 13:36:34.115] clusterrolebinding.rbac.authorization.k8s.io/cluster-admin-binding created
W0810 13:36:34.215] + /tmp/gcp-pd-driver-tmp1170496602/kubernetes/cluster/kubectl.sh version
W0810 13:36:34.270] 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.
W0810 13:36:34.275] + readonly tmp_spec=/tmp/gcp-compute-persistent-disk-csi-driver-specs-generated.yaml
... skipping 521 lines ...
I0810 13:36:35.509]       - args:
I0810 13:36:35.510]         - --v=5
I0810 13:36:35.510]         - --csi-address=/csi/csi.sock
I0810 13:36:35.510]         - --http-endpoint=:22013
I0810 13:36:35.510]         - --leader-election
I0810 13:36:35.510]         - --leader-election-namespace=$(PDCSI_NAMESPACE)
I0810 13:36:35.510]         - --handle-volume-inuse-error=false
I0810 13:36:35.510]         env:
I0810 13:36:35.510]         - name: PDCSI_NAMESPACE
I0810 13:36:35.511]           valueFrom:
I0810 13:36:35.511]             fieldRef:
I0810 13:36:35.511]               fieldPath: metadata.namespace
I0810 13:36:35.511]         image: k8s.gcr.io/sig-storage/csi-resizer:v1.4.0
... skipping 369 lines ...
I0810 13:52:10.711]     Args:
I0810 13:52:10.711]       --v=5
I0810 13:52:10.711]       --csi-address=/csi/csi.sock
I0810 13:52:10.711]       --http-endpoint=:22013
I0810 13:52:10.712]       --leader-election
I0810 13:52:10.712]       --leader-election-namespace=$(PDCSI_NAMESPACE)
I0810 13:52:10.712]       --handle-volume-inuse-error=false
I0810 13:52:10.712]     State:          Running
I0810 13:52:10.712]       Started:      Wed, 10 Aug 2022 13:36:42 +0000
I0810 13:52:10.712]     Ready:          True
I0810 13:52:10.713]     Restart Count:  0
I0810 13:52:10.713]     Liveness:       http-get http://:http-endpoint/healthz/leader-election delay=10s timeout=10s period=20s #success=1 #failure=1
I0810 13:52:10.713]     Environment:
... skipping 607 lines ...
I0810 13:52:10.796]   ----     ------     ----                 ----               -------
I0810 13:52:10.796]   Normal   Scheduled  15m                  default-scheduler  Successfully assigned gce-pd-csi-driver/csi-gce-pd-node-win-587bq to e2e-test-prow-windows-node-group-2kk0
I0810 13:52:10.796]   Normal   Pulling    15m                  kubelet            Pulling image "k8s.gcr.io/sig-storage/csi-node-driver-registrar:v2.5.0"
I0810 13:52:10.796]   Normal   Pulled     15m                  kubelet            Successfully pulled image "k8s.gcr.io/sig-storage/csi-node-driver-registrar:v2.5.0" in 16.3582565s
I0810 13:52:10.796]   Normal   Created    15m                  kubelet            Created container csi-driver-registrar
I0810 13:52:10.797]   Normal   Started    15m                  kubelet            Started container csi-driver-registrar
I0810 13:52:10.797]   Warning  Failed     7m50s                kubelet            Failed to pull image "gcr.io/e2e-gce-gci-ci-master/gcp-persistent-disk-csi-driver:58da5aec-78b1-4542-9bbf-2d2545d27524": rpc error: code = Unknown desc = failed to pull and unpack image "gcr.io/e2e-gce-gci-ci-master/gcp-persistent-disk-csi-driver:58da5aec-78b1-4542-9bbf-2d2545d27524": failed to extract layer sha256:ccc004b169ee6b7194527fa6d6b7426e2943474955f102a36dfa9570705b2d60: link \\?\C:\ProgramData\containerd\root\io.containerd.snapshotter.v1.windows\snapshots\40\Files\Windows\System32\wbem\en-US\WinMgmtR.dll.mui \\?\C:\ProgramData\containerd\root\io.containerd.snapshotter.v1.windows\snapshots\41\Files\Windows\WinSxS\amd64_microsoft-windows-wmi-core.resources_31bf3856ad364e35_10.0.17763.1_en-us_c58d78201fd22b28\WinMgmtR.dll.mui: Access is denied.: unknown
I0810 13:52:10.798]   Normal   BackOff    7m50s                kubelet            Back-off pulling image "gcr.io/e2e-gce-gci-ci-master/gcp-persistent-disk-csi-driver:58da5aec-78b1-4542-9bbf-2d2545d27524"
I0810 13:52:10.798]   Normal   Pulling    7m39s (x2 over 15m)  kubelet            Pulling image "gcr.io/e2e-gce-gci-ci-master/gcp-persistent-disk-csi-driver:58da5aec-78b1-4542-9bbf-2d2545d27524"
I0810 13:52:10.798] 
I0810 13:52:10.798] 
I0810 13:52:10.798] Name:                 csi-gce-pd-node-win-r8ldg
I0810 13:52:10.798] Namespace:            gce-pd-csi-driver
... skipping 227 lines ...
W0810 14:01:30.105]   Associated tags:
W0810 14:01:30.106]  - 58da5aec-78b1-4542-9bbf-2d2545d27524
W0810 14:01:30.106] Tags:
W0810 14:01:30.106] - gcr.io/e2e-gce-gci-ci-master/gcp-persistent-disk-csi-driver:58da5aec-78b1-4542-9bbf-2d2545d27524
W0810 14:01:30.305] Deleted [gcr.io/e2e-gce-gci-ci-master/gcp-persistent-disk-csi-driver:58da5aec-78b1-4542-9bbf-2d2545d27524].
W0810 14:01:30.637] Deleted [gcr.io/e2e-gce-gci-ci-master/gcp-persistent-disk-csi-driver@sha256:10f73bbb6792d687e1f720894f7a784a4b735d03b5c6cb843ba9fdab5a55d20e].
W0810 14:01:31.738] F0810 14:01:31.738164    9842 main.go:196] Failed to run integration test: failed to install CSI Driver: Windows deployment failed to come up: exit status 255
W0810 14:01:31.753] Traceback (most recent call last):
W0810 14:01:31.754]   File "/workspace/./test-infra/jenkins/../scenarios/execute.py", line 50, in <module>
W0810 14:01:31.764]     main(ARGS.env, ARGS.cmd + ARGS.args)
W0810 14:01:31.765]   File "/workspace/./test-infra/jenkins/../scenarios/execute.py", line 41, in main
W0810 14:01:31.765]     check(*cmd)
W0810 14:01:31.765]   File "/workspace/./test-infra/jenkins/../scenarios/execute.py", line 30, in check
W0810 14:01:31.765]     subprocess.check_call(cmd)
W0810 14:01:31.765]   File "/usr/lib/python2.7/subprocess.py", line 190, in check_call
W0810 14:01:31.768]     raise CalledProcessError(retcode, cmd)
W0810 14:01:31.772] subprocess.CalledProcessError: Command '('test/run-windows-k8s-integration.sh',)' returned non-zero exit status 255
E0810 14:01:31.793] Command failed
I0810 14:01:31.793] process 438 exited with code 1 after 87.8m
E0810 14:01:31.797] FAIL: ci-gce-pd-csi-driver-latest-k8s-master-windows-2019
I0810 14:01:31.801] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0810 14:01:32.548] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0810 14:01:32.724] process 182333 exited with code 0 after 0.0m
I0810 14:01:32.725] Call:  gcloud config get-value account
I0810 14:01:33.463] process 182347 exited with code 0 after 0.0m
I0810 14:01:33.464] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
... skipping 20 lines ...