This job view page is being replaced by Spyglass soon. Check out the new job view.
ResultFAILURE
Tests 0 failed / 0 succeeded
Started2020-10-26 18:04
Elapsed50m31s
Revision
Builderaddce723-17b5-11eb-b256-6ee25ea2e440
infra-commitf7d653694
reposigs.k8s.io/gcp-compute-persistent-disk-csi-driver
repo-commitff0b719f51348c8ea0d6f0d2807ee416bf5396aa
repos{u'sigs.k8s.io/gcp-compute-persistent-disk-csi-driver': u'master'}

No Test Failures!


Error lines from build-log.txt

... skipping 518 lines ...
I1026 18:08:27.631] gcloud docker -- push gcr.io/kubernetes-gci-scale/gcp-persistent-disk-csi-driver:2d8cc598-200d-48be-98d6-419c0573d01b
W1026 18:08:28.209] WARNING: `gcloud docker` will not be supported for Docker client versions above 18.03.
W1026 18:08:28.209] 
W1026 18:08:28.209] As an alternative, use `gcloud auth configure-docker` to configure `docker` to
W1026 18:08:28.209] use `gcloud` as a credential helper, then use `docker` as you would for non-GCR
W1026 18:08:28.210] registries, e.g. `docker pull gcr.io/project-id/my-image`. Add
W1026 18:08:28.210] `--verbosity=error` to silence this warning: `gcloud docker
W1026 18:08:28.210] --verbosity=error -- pull gcr.io/project-id/my-image`.
W1026 18:08:28.211] 
W1026 18:08:28.211] See: https://cloud.google.com/container-registry/docs/support/deprecation-notices#gcloud-docker
W1026 18:08:28.211] 
I1026 18:08:28.607] The push refers to repository [gcr.io/kubernetes-gci-scale/gcp-persistent-disk-csi-driver]
I1026 18:08:28.632] 7b3ac7822e37: Preparing
I1026 18:08:28.633] 6929d905cf63: Preparing
... skipping 217 lines ...
W1026 18:28:25.928] NODE_NAMES=e2e-test-prow-minion-group-4np6 e2e-test-prow-minion-group-lpw3 e2e-test-prow-minion-group-qwp4
W1026 18:28:25.928] Trying to find master named 'e2e-test-prow-master'
W1026 18:28:25.928] Looking for address 'e2e-test-prow-master-ip'
I1026 18:28:27.715] Waiting up to 300 seconds for cluster initialization.
I1026 18:28:27.716] 
I1026 18:28:27.716]   This will continually check to see if the API for kubernetes is reachable.
I1026 18:28:27.716]   This may time out if there was some uncaught error during start up.
I1026 18:28:27.716] 
W1026 18:28:27.816] Using master: e2e-test-prow-master (external IP: 35.225.238.43; internal IP: (not set))
I1026 18:29:48.040] ...................Kubernetes cluster created.
I1026 18:29:48.238] Cluster "kubernetes-gci-scale_e2e-test-prow" set.
I1026 18:29:48.502] User "kubernetes-gci-scale_e2e-test-prow" set.
I1026 18:29:48.689] Context "kubernetes-gci-scale_e2e-test-prow" created.
... skipping 25 lines ...
I1026 18:30:49.212] e2e-test-prow-minion-group-qwp4   Ready                      <none>   30s   v888.888.888-fake-testing-master.version
W1026 18:30:49.713] Warning: v1 ComponentStatus is deprecated in v1.19+
I1026 18:30:49.814] Validate output:
W1026 18:30:50.177] Warning: v1 ComponentStatus is deprecated in v1.19+
W1026 18:30:50.197] Done, listing cluster services:
W1026 18:30:50.197] 
I1026 18:30:50.298] NAME                 STATUS    MESSAGE             ERROR
I1026 18:30:50.299] etcd-1               Healthy   {"health":"true"}   
I1026 18:30:50.300] scheduler            Healthy   ok                  
I1026 18:30:50.301] controller-manager   Healthy   ok                  
I1026 18:30:50.301] etcd-0               Healthy   {"health":"true"}   
I1026 18:30:50.302] Cluster validation succeeded
I1026 18:30:50.658] Kubernetes control plane is running at https://35.225.238.43
... skipping 110 lines ...
W1026 18:31:20.267]   "details": {
W1026 18:31:20.267]     "name": "gce-pd-csi-driver",
W1026 18:31:20.267]     "kind": "namespaces"
W1026 18:31:20.267]   },
W1026 18:31:20.267]   "code": 404
W1026 18:31:20.267] }]
W1026 18:31:20.267] F1026 18:31:20.264295   84923 helpers.go:115] Error from server (NotFound): namespaces "gce-pd-csi-driver" not found
W1026 18:31:20.267] goroutine 1 [running]:
W1026 18:31:20.267] k8s.io/kubernetes/vendor/k8s.io/klog/v2.stacks(0xc00000e001, 0xc0008ca1a0, 0x75, 0xc6)
W1026 18:31:20.268] 	/go/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/vendor/k8s.io/klog/v2/klog.go:996 +0xb9
W1026 18:31:20.268] k8s.io/kubernetes/vendor/k8s.io/klog/v2.(*loggingT).output(0x2d1ece0, 0xc000000003, 0x0, 0x0, 0xc0003c1420, 0x2aff6ae, 0xa, 0x73, 0x40b200)
W1026 18:31:20.268] 	/go/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/vendor/k8s.io/klog/v2/klog.go:945 +0x191
W1026 18:31:20.268] k8s.io/kubernetes/vendor/k8s.io/klog/v2.(*loggingT).printDepth(0x2d1ece0, 0x3, 0x0, 0x0, 0x2, 0xc0005f9ad0, 0x1, 0x1)
W1026 18:31:20.269] 	/go/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/vendor/k8s.io/klog/v2/klog.go:718 +0x165
W1026 18:31:20.269] k8s.io/kubernetes/vendor/k8s.io/klog/v2.FatalDepth(...)
W1026 18:31:20.269] 	/go/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/vendor/k8s.io/klog/v2/klog.go:1442
W1026 18:31:20.269] k8s.io/kubernetes/vendor/k8s.io/kubectl/pkg/cmd/util.fatal(0xc00079a280, 0x46, 0x1)
W1026 18:31:20.269] 	/go/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/vendor/k8s.io/kubectl/pkg/cmd/util/helpers.go:93 +0x1f0
W1026 18:31:20.270] k8s.io/kubernetes/vendor/k8s.io/kubectl/pkg/cmd/util.checkErr(0x1e73800, 0xc0006bf380, 0x1d1cbc8)
W1026 18:31:20.270] 	/go/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/vendor/k8s.io/kubectl/pkg/cmd/util/helpers.go:188 +0x945
W1026 18:31:20.270] k8s.io/kubernetes/vendor/k8s.io/kubectl/pkg/cmd/util.CheckErr(...)
W1026 18:31:20.270] 	/go/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/vendor/k8s.io/kubectl/pkg/cmd/util/helpers.go:115
W1026 18:31:20.271] k8s.io/kubernetes/vendor/k8s.io/kubectl/pkg/cmd/get.NewCmdGet.func1(0xc00037d8c0, 0xc000486390, 0x2, 0x3)
... skipping 108 lines ...
W1026 18:31:20.751]   "details": {
W1026 18:31:20.751]     "name": "cloud-sa",
W1026 18:31:20.751]     "kind": "secrets"
W1026 18:31:20.751]   },
W1026 18:31:20.752]   "code": 404
W1026 18:31:20.752] }]
W1026 18:31:20.752] F1026 18:31:20.747352   85030 helpers.go:115] Error from server (NotFound): secrets "cloud-sa" not found
W1026 18:31:20.752] goroutine 1 [running]:
W1026 18:31:20.752] k8s.io/kubernetes/vendor/k8s.io/klog/v2.stacks(0xc0000d2001, 0xc000050840, 0x69, 0xba)
W1026 18:31:20.752] 	/go/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/vendor/k8s.io/klog/v2/klog.go:996 +0xb9
W1026 18:31:20.752] k8s.io/kubernetes/vendor/k8s.io/klog/v2.(*loggingT).output(0x2d1ece0, 0xc000000003, 0x0, 0x0, 0xc0007a0380, 0x2aff6ae, 0xa, 0x73, 0x40b200)
W1026 18:31:20.753] 	/go/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/vendor/k8s.io/klog/v2/klog.go:945 +0x191
W1026 18:31:20.753] k8s.io/kubernetes/vendor/k8s.io/klog/v2.(*loggingT).printDepth(0x2d1ece0, 0x3, 0x0, 0x0, 0x2, 0xc000133ad0, 0x1, 0x1)
W1026 18:31:20.753] 	/go/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/vendor/k8s.io/klog/v2/klog.go:718 +0x165
W1026 18:31:20.753] k8s.io/kubernetes/vendor/k8s.io/klog/v2.FatalDepth(...)
W1026 18:31:20.753] 	/go/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/vendor/k8s.io/klog/v2/klog.go:1442
W1026 18:31:20.754] k8s.io/kubernetes/vendor/k8s.io/kubectl/pkg/cmd/util.fatal(0xc00033f380, 0x3a, 0x1)
W1026 18:31:20.754] 	/go/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/vendor/k8s.io/kubectl/pkg/cmd/util/helpers.go:93 +0x1f0
W1026 18:31:20.754] k8s.io/kubernetes/vendor/k8s.io/kubectl/pkg/cmd/util.checkErr(0x1e73800, 0xc0001438c0, 0x1d1cbc8)
W1026 18:31:20.754] 	/go/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/vendor/k8s.io/kubectl/pkg/cmd/util/helpers.go:188 +0x945
W1026 18:31:20.754] k8s.io/kubernetes/vendor/k8s.io/kubectl/pkg/cmd/util.CheckErr(...)
W1026 18:31:20.755] 	/go/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/vendor/k8s.io/kubectl/pkg/cmd/util/helpers.go:115
W1026 18:31:20.755] k8s.io/kubernetes/vendor/k8s.io/kubectl/pkg/cmd/get.NewCmdGet.func1(0xc000499b80, 0xc00007eb90, 0x2, 0x5)
... skipping 99 lines ...
W1026 18:31:21.286]     "name": "cluster-admin-binding",
W1026 18:31:21.286]     "group": "rbac.authorization.k8s.io",
W1026 18:31:21.286]     "kind": "clusterrolebindings"
W1026 18:31:21.286]   },
W1026 18:31:21.286]   "code": 404
W1026 18:31:21.286] }]
W1026 18:31:21.287] F1026 18:31:21.282941   85136 helpers.go:115] Error from server (NotFound): clusterrolebindings.rbac.authorization.k8s.io "cluster-admin-binding" not found
W1026 18:31:21.287] goroutine 1 [running]:
W1026 18:31:21.287] k8s.io/kubernetes/vendor/k8s.io/klog/v2.stacks(0xc00000e001, 0xc0002f80f0, 0x9c, 0xed)
W1026 18:31:21.287] 	/go/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/vendor/k8s.io/klog/v2/klog.go:996 +0xb9
W1026 18:31:21.288] k8s.io/kubernetes/vendor/k8s.io/klog/v2.(*loggingT).output(0x2d1ece0, 0xc000000003, 0x0, 0x0, 0xc0003c3420, 0x2aff6ae, 0xa, 0x73, 0x40b200)
W1026 18:31:21.288] 	/go/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/vendor/k8s.io/klog/v2/klog.go:945 +0x191
W1026 18:31:21.288] k8s.io/kubernetes/vendor/k8s.io/klog/v2.(*loggingT).printDepth(0x2d1ece0, 0x3, 0x0, 0x0, 0x2, 0xc000b87ad0, 0x1, 0x1)
W1026 18:31:21.288] 	/go/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/vendor/k8s.io/klog/v2/klog.go:718 +0x165
W1026 18:31:21.288] k8s.io/kubernetes/vendor/k8s.io/klog/v2.FatalDepth(...)
W1026 18:31:21.289] 	/go/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/vendor/k8s.io/klog/v2/klog.go:1442
W1026 18:31:21.289] k8s.io/kubernetes/vendor/k8s.io/kubectl/pkg/cmd/util.fatal(0xc0006ecf50, 0x6d, 0x1)
W1026 18:31:21.289] 	/go/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/vendor/k8s.io/kubectl/pkg/cmd/util/helpers.go:93 +0x1f0
W1026 18:31:21.289] k8s.io/kubernetes/vendor/k8s.io/kubectl/pkg/cmd/util.checkErr(0x1e73800, 0xc0003491a0, 0x1d1cbc8)
W1026 18:31:21.289] 	/go/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/vendor/k8s.io/kubectl/pkg/cmd/util/helpers.go:188 +0x945
W1026 18:31:21.290] k8s.io/kubernetes/vendor/k8s.io/kubectl/pkg/cmd/util.CheckErr(...)
W1026 18:31:21.290] 	/go/src/k8s.io/kubernetes/_output/dockerized/go/src/k8s.io/kubernetes/vendor/k8s.io/kubectl/pkg/cmd/util/helpers.go:115
W1026 18:31:21.290] k8s.io/kubernetes/vendor/k8s.io/kubectl/pkg/cmd/get.NewCmdGet.func1(0xc00049b8c0, 0xc00033e7b0, 0x2, 0x3)
... skipping 1009 lines ...
W1026 18:31:23.816] 000006c0  69 6e 75 74 65 73 29 20  6f 72 20 61 20 63 6f 6e  |inutes) or a con|
W1026 18:31:23.817] 000006d0  66 69 67 75 72 61 74 69  6f 6e 20 63 68 61 6e 67  |figuration chang|
W1026 18:31:23.817] 000006e0  65 20 6f 6e 20 74 68 65  20 73 65 72 76 65 72 2c  |e on the server,|
W1026 18:31:23.817] 000006f0  20 74 68 65 20 73 65 72  76 65 72 20 77 69 6c 6c  | the server will|
W1026 18:31:23.817] 00000700  20 72 65 73 70 6f 6e 64  20 77 69 74 68 20 61 20  | respond with a |
W1026 18:31:23.818] 00000710  34 31 30 20 52 65 73 6f  75 72 63 65 45 78 70 69  |410 ResourceExpi|
W1026 18:31:23.818] 00000720  72 65 64 20 65 72 72 6f  72 20 74 6f 67 65 74 68  |red error togeth|
W1026 18:31:23.818] 00000730  65 72 20 77 69 74 68 20  61 20 63 6f 6e 74 69 6e  |er with a contin|
W1026 18:31:23.818] 00000740  75 65 20 74 6f 6b 65 6e  2e 20 49 66 20 74 68 65  |ue token. If the|
W1026 18:31:23.818] 00000750  20 63 6c 69 65 6e 74 20  6e 65 65 64 73 20 61 20  | client needs a |
W1026 18:31:23.818] 00000760  63 6f 6e 73 69 73 74 65  6e 74 20 6c 69 73 74 2c  |consistent list,|
W1026 18:31:23.819] 00000770  20 69 74 20 6d 75 73 74  20 72 65 73 74 61 72 74  | it must restart|
W1026 18:31:23.819] 00000780  20 74 68 65 69 72 20 6c  69 73 74 20 77 69 74 68  | their list with|
W1026 18:31:23.819] 00000790  6f 75 74 20 74 68 65 20  63 6f 6e 74 69 6e 75 65  |out the continue|
W1026 18:31:23.819] 000007a0  20 66 69 65 6c 64 2e 20  4f 74 68 65 72 77 69 73  | field. Otherwis|
W1026 18:31:23.819] 000007b0  65 2c 20 74 68 65 20 63  6c 69 65 6e 74 20 6d 61  |e, the client ma|
W1026 18:31:23.820] 000007c0  79 20 73 65 6e 64 20 61  6e 6f 74 68 65 72 20 6c  |y send another l|
W1026 18:31:23.820] 000007d0  69 73 74 20 72 65 71 75  65 73 74 20 77 69 74 68  |ist request with|
W1026 18:31:23.821] 000007e0  20 74 68 65 20 74 6f 6b  65 6e 20 72 65 63 65 69  | the token recei|
W1026 18:31:23.821] 000007f0  76 65 64 20 77 69 74 68  20 74 68 65 20 34 31 30  |ved with the 410|
W1026 18:31:23.821] 00000800  20 65 72 72 6f 72 2c 20  74 68 65 20 73 65 72 76  | error, the serv|
W1026 18:31:23.821] 00000810  65 72 20 77 69 6c 6c 20  72 65 73 70 6f [truncated 16589713 chars]
W1026 18:31:23.932] I1026 18:31:23.932022   85319 round_trippers.go:424] curl -k -v -XGET  -H "Accept: application/json" -H "User-Agent: kubectl/v888.888.888 (linux/amd64) kubernetes/somefak" -H "Authorization: Bearer <masked>" 'https://35.225.238.43/api/v1/namespaces/gce-pd-csi-driver/serviceaccounts/csi-gce-pd-controller-sa'
W1026 18:31:23.935] I1026 18:31:23.935418   85319 round_trippers.go:444] GET https://35.225.238.43/api/v1/namespaces/gce-pd-csi-driver/serviceaccounts/csi-gce-pd-controller-sa 404 Not Found in 3 milliseconds
W1026 18:31:23.936] I1026 18:31:23.935456   85319 round_trippers.go:450] Response Headers:
W1026 18:31:23.936] I1026 18:31:23.935464   85319 round_trippers.go:453]     Audit-Id: 67c98d87-c1fc-4311-bfa3-531c92927013
W1026 18:31:23.936] I1026 18:31:23.935469   85319 round_trippers.go:453]     Cache-Control: no-cache, private
... skipping 651 lines ...
W1026 18:31:24.944] I1026 18:31:24.942861   85319 round_trippers.go:453]     Content-Type: application/json
W1026 18:31:24.945] I1026 18:31:24.942904   85319 request.go:1097] Response Body: {"kind":"CSIDriver","apiVersion":"storage.k8s.io/v1beta1","metadata":{"name":"pd.csi.storage.gke.io","uid":"5354986b-758b-497f-b15e-fffcbd28c12f","resourceVersion":"993","creationTimestamp":"2020-10-26T18:31:24Z","annotations":{"kubectl.kubernetes.io/last-applied-configuration":"{\"apiVersion\":\"storage.k8s.io/v1beta1\",\"kind\":\"CSIDriver\",\"metadata\":{\"annotations\":{},\"name\":\"pd.csi.storage.gke.io\"},\"spec\":{\"attachRequired\":true,\"podInfoOnMount\":false}}\n"},"managedFields":[{"manager":"kubectl-client-side-apply","operation":"Update","apiVersion":"storage.k8s.io/v1beta1","time":"2020-10-26T18:31:24Z","fieldsType":"FieldsV1","fieldsV1":{"f:metadata":{"f:annotations":{".":{},"f:kubectl.kubernetes.io/last-applied-configuration":{}}},"f:spec":{"f:attachRequired":{},"f:podInfoOnMount":{},"f:volumeLifecycleModes":{}}}}]},"spec":{"attachRequired":true,"podInfoOnMount":false,"volumeLifecycleModes":["Persistent"]}}
W1026 18:31:24.946] I1026 18:31:24.943100   85319 apply.go:394] Running apply post-processor function
I1026 18:31:25.046] csidriver.storage.k8s.io/pd.csi.storage.gke.io created
I1026 18:31:25.046] Waiting for driver to start
I1026 18:31:25.047] [/go/src/sigs.k8s.io/gcp-compute-persistent-disk-csi-driver/deploy/kubernetes/wait-for-driver.sh]
W1026 18:31:55.457] error: timed out waiting for the condition on deployments/csi-gce-pd-controller
I1026 18:47:42.512] Timeout waiting for node daemonset csi-gce-pd-node
I1026 18:47:42.547] Deleting driver
I1026 18:47:42.548] [/go/src/sigs.k8s.io/gcp-compute-persistent-disk-csi-driver/deploy/kubernetes/delete-driver.sh]
I1026 18:47:42.551] PKGDIR is /go/src/sigs.k8s.io/gcp-compute-persistent-disk-csi-driver
I1026 18:47:42.558] installing kustomize
I1026 18:47:44.413] {Version:kustomize/v3.8.0 GitCommit:6a50372dd5686df22750b0c729adaf369fbf193c BuildDate:2020-07-05T14:08:42Z GoOs:linux GoArch:amd64}
... skipping 720 lines ...
W1026 18:55:03.607]   Associated tags:
W1026 18:55:03.607]  - 2d8cc598-200d-48be-98d6-419c0573d01b
W1026 18:55:03.607] Tags:
W1026 18:55:03.608] - gcr.io/kubernetes-gci-scale/gcp-persistent-disk-csi-driver:2d8cc598-200d-48be-98d6-419c0573d01b
W1026 18:55:03.775] Deleted [gcr.io/kubernetes-gci-scale/gcp-persistent-disk-csi-driver:2d8cc598-200d-48be-98d6-419c0573d01b].
W1026 18:55:04.317] Deleted [gcr.io/kubernetes-gci-scale/gcp-persistent-disk-csi-driver@sha256:9bb95ef21dabd74913c40ac3865060db9cb41bc3d35cf726638cfa7936fce463].
W1026 18:55:05.691] F1026 18:55:05.691024    2998 main.go:161] Failed to run integration test: failed to install CSI Driver: driver failed to come up: exit status 255
W1026 18:55:05.704] Traceback (most recent call last):
W1026 18:55:05.704]   File "/workspace/./test-infra/jenkins/../scenarios/execute.py", line 50, in <module>
W1026 18:55:05.705]     main(ARGS.env, ARGS.cmd + ARGS.args)
W1026 18:55:05.705]   File "/workspace/./test-infra/jenkins/../scenarios/execute.py", line 41, in main
W1026 18:55:05.705]     check(*cmd)
W1026 18:55:05.706]   File "/workspace/./test-infra/jenkins/../scenarios/execute.py", line 30, in check
W1026 18:55:05.706]     subprocess.check_call(cmd)
W1026 18:55:05.706]   File "/usr/lib/python2.7/subprocess.py", line 190, in check_call
W1026 18:55:05.706]     raise CalledProcessError(retcode, cmd)
W1026 18:55:05.707] subprocess.CalledProcessError: Command '('test/run-k8s-integration-migration.sh',)' returned non-zero exit status 255
E1026 18:55:05.723] Command failed
I1026 18:55:05.723] process 438 exited with code 1 after 50.2m
E1026 18:55:05.724] FAIL: ci-gcp-compute-persistent-disk-csi-driver-latest-k8s-master-migration
I1026 18:55:05.725] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W1026 18:55:06.597] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I1026 18:55:06.776] process 88706 exited with code 0 after 0.0m
I1026 18:55:06.777] Call:  gcloud config get-value account
I1026 18:55:07.676] process 88719 exited with code 0 after 0.0m
I1026 18:55:07.676] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
... skipping 20 lines ...