This job view page is being replaced by Spyglass soon. Check out the new job view.
ResultFAILURE
Tests 1 failed / 7 succeeded
Started2020-02-12 06:25
Elapsed11m3s
Revisionrelease-1.16
links{u'resultstore': {u'url': u'https://source.cloud.google.com/results/invocations/c7ac1d47-10fd-408d-978b-3a840e0968ca/targets/test'}}
resultstorehttps://source.cloud.google.com/results/invocations/c7ac1d47-10fd-408d-978b-3a840e0968ca/targets/test
uploadercrier

Test Failures


task-04-join 5m0s

timeout. task did not completed in less than 5m0s as expected
				from junit_runner.xml

Filter through log files | View test history on testgrid


Show 7 Passed Tests

Show 3 Skipped Tests

Error lines from build-log.txt

Docker in Docker enabled, initializing...
================================================================================
Starting Docker: docker.
Waiting for docker to be ready, sleeping for 1 seconds.
[Barnacle] 2020/02/12 06:28:05 Cleaning up Docker data root...
[Barnacle] 2020/02/12 06:28:05 Removing all containers.
[Barnacle] 2020/02/12 06:28:05 Failed to list containers: Error response from daemon: client version 1.41 is too new. Maximum supported API version is 1.40
[Barnacle] 2020/02/12 06:28:05 Removing recently created images.
[Barnacle] 2020/02/12 06:28:05 Failed to list images: Error response from daemon: client version 1.41 is too new. Maximum supported API version is 1.40
[Barnacle] 2020/02/12 06:28:05 Pruning dangling images.
[Barnacle] 2020/02/12 06:28:05 Failed to list images: Error response from daemon: client version 1.41 is too new. Maximum supported API version is 1.40
[Barnacle] 2020/02/12 06:28:05 Pruning volumes.
[Barnacle] 2020/02/12 06:28:05 Failed to prune volumes: Error response from daemon: client version 1.41 is too new. Maximum supported API version is 1.40
[Barnacle] 2020/02/12 06:28:05 Done cleaning up Docker data root.
Remaining docker images and volumes are:
REPOSITORY          TAG                 IMAGE ID            CREATED             SIZE
DRIVER              VOLUME NAME
Cleaning up binfmt_misc ...
================================================================================
... skipping 267 lines ...
Created symlink /etc/systemd/system/multi-user.target.wants/kubelet.service → /kind/systemd/kubelet.service.
Created symlink /etc/systemd/system/kubelet.service → /kind/systemd/kubelet.service.
time="06:29:05" level=debug msg="Running: [docker exec kind-build-ee823043-7b3e-41b3-a62d-11394b81bdb3 mkdir -p /etc/systemd/system/kubelet.service.d]"
time="06:29:05" level=info msg="Adding /etc/systemd/system/kubelet.service.d/10-kubeadm.conf to the image"
time="06:29:05" level=debug msg="Running: [docker exec kind-build-ee823043-7b3e-41b3-a62d-11394b81bdb3 cp /alter/bits/systemd/10-kubeadm.conf /etc/systemd/system/kubelet.service.d/10-kubeadm.conf]"
time="06:29:06" level=debug msg="Running: [docker exec kind-build-ee823043-7b3e-41b3-a62d-11394b81bdb3 chown -R root:root /etc/systemd/system/kubelet.service.d/10-kubeadm.conf]"
time="06:29:06" level=debug msg="Running: [docker exec kind-build-ee823043-7b3e-41b3-a62d-11394b81bdb3 /bin/sh -c echo \"KUBELET_EXTRA_ARGS=--fail-swap-on=false\" >> /etc/default/kubelet]"
time="06:29:06" level=debug msg="Running: [docker exec kind-build-ee823043-7b3e-41b3-a62d-11394b81bdb3 cp /alter/bits/kubeadm /usr/bin/kubeadm]"
time="06:29:07" level=debug msg="Running: [docker exec kind-build-ee823043-7b3e-41b3-a62d-11394b81bdb3 chown -R root:root /usr/bin/kubeadm]"
time="06:29:07" level=debug msg="Running: [docker exec kind-build-ee823043-7b3e-41b3-a62d-11394b81bdb3 /bin/sh -c which docker || true]"
time="06:29:07" level=info msg="Detected docker as container runtime"
time="06:29:07" level=info msg="Pre loading images ..."
time="06:29:07" level=debug msg="Running: [docker exec kind-build-ee823043-7b3e-41b3-a62d-11394b81bdb3 mkdir -p /kind/images]"
... skipping 181 lines ...
kinder-xony-control-plane-1:$ Preparing /kind/kubeadm.conf
time="06:29:52" level=debug msg="Running: /usr/bin/docker [docker inspect -f {{range .NetworkSettings.Networks}}{{.IPAddress}},{{.GlobalIPv6Address}}{{end}} kinder-xony-control-plane-1]"
time="06:29:52" level=debug msg="Running: [docker exec kinder-xony-control-plane-1 kubeadm version -o=short]"
time="06:29:53" level=debug msg="Preparing kubeadm config v1beta2 (kubeadm version 1.17.4-beta.0.1+aa9a28326e8075)"
time="06:29:53" level=debug msg="Preparing dockerPatch for kubeadm config v1beta2 (kubeadm version 1.17.4-beta.0.1+aa9a28326e8075)"
time="06:29:53" level=debug msg="Preparing automaticCopyCertsPatches for kubeadm config v1beta2 (kubeadm version 1.17.4-beta.0.1+aa9a28326e8075)"
time="06:29:53" level=debug msg="generated config:\napiServer:\n  certSANs:\n  - localhost\n  - 172.17.0.3\napiVersion: kubeadm.k8s.io/v1beta2\nclusterName: kinder-xony\ncontrolPlaneEndpoint: 172.17.0.7:6443\ncontrollerManager:\n  extraArgs:\n    enable-hostpath-provisioner: \"true\"\nkind: ClusterConfiguration\nkubernetesVersion: v1.16.8-beta.0.1+abdce0eac9e732\nnetworking:\n  podSubnet: 192.168.0.0/16\n  serviceSubnet: \"\"\nscheduler:\n  extraArgs: null\n---\napiVersion: kubeadm.k8s.io/v1beta2\nbootstrapTokens:\n- token: abcdef.0123456789abcdef\ncertificateKey: \"0123456789012345678901234567890123456789012345678901234567890123\"\nkind: InitConfiguration\nlocalAPIEndpoint:\n  advertiseAddress: 172.17.0.3\n  bindPort: 6443\nnodeRegistration:\n  criSocket: /var/run/dockershim.sock\n  kubeletExtraArgs:\n    fail-swap-on: \"false\"\n    node-ip: 172.17.0.3\n---\napiVersion: kubelet.config.k8s.io/v1beta1\nevictionHard:\n  imagefs.available: 0%\n  nodefs.available: 0%\n  nodefs.inodesFree: 0%\nimageGCHighThresholdPercent: 100\nkind: KubeletConfiguration\n---\napiVersion: kubeproxy.config.k8s.io/v1alpha1\nkind: KubeProxyConfiguration\n"
time="06:29:53" level=debug msg="Running: [docker cp /tmp/kinder-xony-control-plane-1-582240313 kinder-xony-control-plane-1:/kind/kubeadm.conf]"

kinder-xony-lb:$ Updating load balancer configuration with 1 control plane backends
time="06:29:53" level=debug msg="Running: /usr/bin/docker [docker inspect -f {{range .NetworkSettings.Networks}}{{.IPAddress}},{{.GlobalIPv6Address}}{{end}} kinder-xony-control-plane-1]"
time="06:29:53" level=debug msg="Writing loadbalancer config on kinder-xony-lb..."
time="06:29:53" level=debug msg="Running: [docker cp /tmp/kinder-xony-lb-164526660 kinder-xony-lb:/usr/local/etc/haproxy/haproxy.cfg]"
... skipping 33 lines ...
I0212 06:29:55.239273     553 checks.go:376] validating the presence of executable ebtables
I0212 06:29:55.239335     553 checks.go:376] validating the presence of executable ethtool
I0212 06:29:55.239434     553 checks.go:376] validating the presence of executable socat
I0212 06:29:55.239483     553 checks.go:376] validating the presence of executable tc
I0212 06:29:55.239592     553 checks.go:376] validating the presence of executable touch
I0212 06:29:55.239670     553 checks.go:520] running all checks
	[WARNING SystemVerification]: failed to parse kernel config: unable to load kernel module: "configs", output: "modprobe: FATAL: Module configs not found in directory /lib/modules/4.15.0-1044-gke\n", err: exit status 1
I0212 06:29:55.344684     553 checks.go:406] checking whether the given node name is reachable using net.LookupHost
[preflight] The system verification failed. Printing the output from the verification:
KERNEL_VERSION: 4.15.0-1044-gke
DOCKER_VERSION: 18.09.4
DOCKER_GRAPH_DRIVER: overlay2
OS: Linux
CGROUPS_CPU: enabled
CGROUPS_CPUACCT: enabled
... skipping 341 lines ...
kinder-xony-control-plane-2:$ Preparing /kind/kubeadm.conf
time="06:31:11" level=debug msg="Running: /usr/bin/docker [docker inspect -f {{range .NetworkSettings.Networks}}{{.IPAddress}},{{.GlobalIPv6Address}}{{end}} kinder-xony-control-plane-2]"
time="06:31:11" level=debug msg="Running: [docker exec kinder-xony-control-plane-2 kubeadm version -o=short]"
time="06:31:11" level=debug msg="Preparing kubeadm config v1beta2 (kubeadm version 1.17.4-beta.0.1+aa9a28326e8075)"
time="06:31:11" level=debug msg="Preparing dockerPatch for kubeadm config v1beta2 (kubeadm version 1.17.4-beta.0.1+aa9a28326e8075)"
time="06:31:11" level=debug msg="Preparing automaticCopyCertsPatches for kubeadm config v1beta2 (kubeadm version 1.17.4-beta.0.1+aa9a28326e8075)"
time="06:31:11" level=debug msg="generated config:\napiVersion: kubeadm.k8s.io/v1beta2\ncontrolPlane:\n  certificateKey: \"0123456789012345678901234567890123456789012345678901234567890123\"\n  localAPIEndpoint:\n    advertiseAddress: 172.17.0.4\n    bindPort: 6443\ndiscovery:\n  bootstrapToken:\n    apiServerEndpoint: 172.17.0.7:6443\n    token: abcdef.0123456789abcdef\n    unsafeSkipCAVerification: true\nkind: JoinConfiguration\nnodeRegistration:\n  criSocket: /var/run/dockershim.sock\n  kubeletExtraArgs:\n    fail-swap-on: \"false\"\n    node-ip: 172.17.0.4\n"
time="06:31:11" level=debug msg="Running: [docker cp /tmp/kinder-xony-control-plane-2-243321188 kinder-xony-control-plane-2:/kind/kubeadm.conf]"
time="06:31:12" level=debug msg="Running: [docker exec kinder-xony-control-plane-2 kubeadm version -o=short]"

kinder-xony-control-plane-2:$ kubeadm join --config=/kind/kubeadm.conf --v=6 --ignore-preflight-errors=Swap,SystemVerification,FileContent--proc-sys-net-bridge-bridge-nf-call-iptables
time="06:31:12" level=debug msg="Running: [docker exec kinder-xony-control-plane-2 kubeadm join --config=/kind/kubeadm.conf --v=6 --ignore-preflight-errors=Swap,SystemVerification,FileContent--proc-sys-net-bridge-bridge-nf-call-iptables]"
W0212 06:31:12.781827     631 join.go:346] [preflight] WARNING: JoinControlPane.controlPlane settings will be ignored when control-plane flag is not set.
... skipping 18 lines ...
I0212 06:31:13.047556     631 checks.go:376] validating the presence of executable ebtables
I0212 06:31:13.047595     631 checks.go:376] validating the presence of executable ethtool
I0212 06:31:13.047639     631 checks.go:376] validating the presence of executable socat
I0212 06:31:13.047671     631 checks.go:376] validating the presence of executable tc
I0212 06:31:13.047719     631 checks.go:376] validating the presence of executable touch
I0212 06:31:13.047957     631 checks.go:520] running all checks
	[WARNING SystemVerification]: failed to parse kernel config: unable to load kernel module: "configs", output: "modprobe: FATAL: Module configs not found in directory /lib/modules/4.15.0-1044-gke\n", err: exit status 1
I0212 06:31:13.176925     631 checks.go:406] checking whether the given node name is reachable using net.LookupHost
[preflight] The system verification failed. Printing the output from the verification:
KERNEL_VERSION: 4.15.0-1044-gke
DOCKER_VERSION: 18.09.4
DOCKER_GRAPH_DRIVER: overlay2
OS: Linux
CGROUPS_CPU: enabled
CGROUPS_CPUACCT: enabled
... skipping 121 lines ...
I0212 06:31:28.986379     631 local.go:136] Adding etcd member: https://172.17.0.4:2380
[etcd] Announced new etcd member joining to the existing etcd cluster
[etcd] Creating static Pod manifest for "etcd"
I0212 06:31:29.008022     631 local.go:142] Updated etcd member list: [{kinder-xony-control-plane-1 https://172.17.0.3:2380} {kinder-xony-control-plane-2 https://172.17.0.4:2380}]
[etcd] Waiting for the new etcd member to join the cluster. This can take up to 40s
I0212 06:31:29.010357     631 etcd.go:408] [etcd] attempting to see if all cluster endpoints ([https://172.17.0.3:2379 https://172.17.0.4:2379]) are available 1/8
{"level":"warn","ts":"2020-02-12T06:31:38.718Z","caller":"clientv3/retry_interceptor.go:61","msg":"retrying of unary invoker failed","target":"passthrough:///https://172.17.0.4:2379","attempt":0,"error":"rpc error: code = DeadlineExceeded desc = context deadline exceeded"}
I0212 06:31:38.719073     631 etcd.go:388] Failed to get etcd status for https://172.17.0.4:2379: context deadline exceeded
[upload-config] Storing the configuration used in ConfigMap "kubeadm-config" in the "kube-system" Namespace
I0212 06:31:45.461395     631 round_trippers.go:443] POST https://172.17.0.7:6443/api/v1/namespaces/kube-system/configmaps?timeout=10s 409 Conflict in 6677 milliseconds
I0212 06:31:45.470925     631 round_trippers.go:443] GET https://172.17.0.7:6443/api/v1/namespaces/kube-system/configmaps/kubeadm-config?timeout=10s 200 OK in 8 milliseconds
I0212 06:31:45.484381     631 round_trippers.go:443] PUT https://172.17.0.7:6443/api/v1/namespaces/kube-system/configmaps/kubeadm-config?timeout=10s 200 OK in 11 milliseconds
I0212 06:31:45.507637     631 round_trippers.go:443] POST https://172.17.0.7:6443/apis/rbac.authorization.k8s.io/v1/namespaces/kube-system/roles?timeout=10s 409 Conflict in 22 milliseconds
I0212 06:31:45.519341     631 round_trippers.go:443] PUT https://172.17.0.7:6443/apis/rbac.authorization.k8s.io/v1/namespaces/kube-system/roles/kubeadm:nodes-kubeadm-config?timeout=10s 200 OK in 11 milliseconds
... skipping 64 lines ...
kinder-xony-control-plane-3:$ Preparing /kind/kubeadm.conf
time="06:31:50" level=debug msg="Running: /usr/bin/docker [docker inspect -f {{range .NetworkSettings.Networks}}{{.IPAddress}},{{.GlobalIPv6Address}}{{end}} kinder-xony-control-plane-3]"
time="06:31:50" level=debug msg="Running: [docker exec kinder-xony-control-plane-3 kubeadm version -o=short]"
time="06:31:51" level=debug msg="Preparing kubeadm config v1beta2 (kubeadm version 1.17.4-beta.0.1+aa9a28326e8075)"
time="06:31:51" level=debug msg="Preparing dockerPatch for kubeadm config v1beta2 (kubeadm version 1.17.4-beta.0.1+aa9a28326e8075)"
time="06:31:51" level=debug msg="Preparing automaticCopyCertsPatches for kubeadm config v1beta2 (kubeadm version 1.17.4-beta.0.1+aa9a28326e8075)"
time="06:31:51" level=debug msg="generated config:\napiVersion: kubeadm.k8s.io/v1beta2\ncontrolPlane:\n  certificateKey: \"0123456789012345678901234567890123456789012345678901234567890123\"\n  localAPIEndpoint:\n    advertiseAddress: 172.17.0.5\n    bindPort: 6443\ndiscovery:\n  bootstrapToken:\n    apiServerEndpoint: 172.17.0.7:6443\n    token: abcdef.0123456789abcdef\n    unsafeSkipCAVerification: true\nkind: JoinConfiguration\nnodeRegistration:\n  criSocket: /var/run/dockershim.sock\n  kubeletExtraArgs:\n    fail-swap-on: \"false\"\n    node-ip: 172.17.0.5\n"
time="06:31:51" level=debug msg="Running: [docker cp /tmp/kinder-xony-control-plane-3-850757174 kinder-xony-control-plane-3:/kind/kubeadm.conf]"
time="06:31:51" level=debug msg="Running: [docker exec kinder-xony-control-plane-3 kubeadm version -o=short]"

kinder-xony-control-plane-3:$ kubeadm join --config=/kind/kubeadm.conf --v=6 --ignore-preflight-errors=Swap,SystemVerification,FileContent--proc-sys-net-bridge-bridge-nf-call-iptables
time="06:31:51" level=debug msg="Running: [docker exec kinder-xony-control-plane-3 kubeadm join --config=/kind/kubeadm.conf --v=6 --ignore-preflight-errors=Swap,SystemVerification,FileContent--proc-sys-net-bridge-bridge-nf-call-iptables]"
W0212 06:31:52.283485     678 join.go:346] [preflight] WARNING: JoinControlPane.controlPlane settings will be ignored when control-plane flag is not set.
... skipping 18 lines ...
I0212 06:31:52.549845     678 checks.go:376] validating the presence of executable ebtables
I0212 06:31:52.549887     678 checks.go:376] validating the presence of executable ethtool
I0212 06:31:52.549927     678 checks.go:376] validating the presence of executable socat
I0212 06:31:52.549969     678 checks.go:376] validating the presence of executable tc
I0212 06:31:52.550022     678 checks.go:376] validating the presence of executable touch
I0212 06:31:52.550076     678 checks.go:520] running all checks
[preflight] The system verification failed. Printing the output from the verification:
KERNEL_VERSION: 4.15.0-1044-gke
DOCKER_VERSION: 18.09.4
DOCKER_GRAPH_DRIVER: overlay2
OS: Linux
CGROUPS_CPU: enabled
CGROUPS_CPUACCT: enabled
CGROUPS_CPUSET: enabled
CGROUPS_DEVICES: enabled
CGROUPS_FREEZER: enabled
CGROUPS_MEMORY: enabled
	[WARNING SystemVerification]: failed to parse kernel config: unable to load kernel module: "configs", output: "modprobe: FATAL: Module configs not found in directory /lib/modules/4.15.0-1044-gke\n", err: exit status 1
I0212 06:31:52.666281     678 checks.go:406] checking whether the given node name is reachable using net.LookupHost
I0212 06:31:52.666589     678 checks.go:618] validating kubelet version
I0212 06:31:52.746590     678 checks.go:128] validating if the service is enabled and active
I0212 06:31:52.761637     678 checks.go:201] validating availability of port 10250
I0212 06:31:52.761812     678 checks.go:432] validating if the connectivity type is via proxy or direct
I0212 06:31:52.761869     678 join.go:441] [preflight] Discovering cluster-info
... skipping 151 lines ...
I0212 06:32:26.381582     678 local.go:136] Adding etcd member: https://172.17.0.5:2380
[etcd] Announced new etcd member joining to the existing etcd cluster
[etcd] Creating static Pod manifest for "etcd"
I0212 06:32:26.413416     678 local.go:142] Updated etcd member list: [{kinder-xony-control-plane-3 https://172.17.0.5:2380} {kinder-xony-control-plane-1 https://172.17.0.3:2380} {kinder-xony-control-plane-2 https://172.17.0.4:2380}]
[etcd] Waiting for the new etcd member to join the cluster. This can take up to 40s
I0212 06:32:26.414920     678 etcd.go:408] [etcd] attempting to see if all cluster endpoints ([https://172.17.0.3:2379 https://172.17.0.4:2379 https://172.17.0.5:2379]) are available 1/8
{"level":"warn","ts":"2020-02-12T06:32:28.963Z","caller":"clientv3/retry_interceptor.go:61","msg":"retrying of unary invoker failed","target":"passthrough:///https://172.17.0.5:2379","attempt":0,"error":"rpc error: code = DeadlineExceeded desc = context deadline exceeded"}
I0212 06:32:28.963445     678 etcd.go:388] Failed to get etcd status for https://172.17.0.5:2379: context deadline exceeded
[upload-config] Storing the configuration used in ConfigMap "kubeadm-config" in the "kube-system" Namespace
I0212 06:32:29.044095     678 round_trippers.go:443] POST https://172.17.0.7:6443/api/v1/namespaces/kube-system/configmaps?timeout=10s 409 Conflict in 11 milliseconds
I0212 06:32:29.047515     678 round_trippers.go:443] GET https://172.17.0.7:6443/api/v1/namespaces/kube-system/configmaps/kubeadm-config?timeout=10s 200 OK in 3 milliseconds
I0212 06:32:29.055135     678 round_trippers.go:443] PUT https://172.17.0.7:6443/api/v1/namespaces/kube-system/configmaps/kubeadm-config?timeout=10s 200 OK in 6 milliseconds
I0212 06:32:29.064893     678 round_trippers.go:443] POST https://172.17.0.7:6443/apis/rbac.authorization.k8s.io/v1/namespaces/kube-system/roles?timeout=10s 409 Conflict in 9 milliseconds
I0212 06:32:29.069555     678 round_trippers.go:443] PUT https://172.17.0.7:6443/apis/rbac.authorization.k8s.io/v1/namespaces/kube-system/roles/kubeadm:nodes-kubeadm-config?timeout=10s 200 OK in 4 milliseconds
... skipping 156 lines ...

kinder-xony-worker-1:$ Preparing /kind/kubeadm.conf
time="06:33:38" level=debug msg="Running: /usr/bin/docker [docker inspect -f {{range .NetworkSettings.Networks}}{{.IPAddress}},{{.GlobalIPv6Address}}{{end}} kinder-xony-worker-1]"
time="06:33:39" level=debug msg="Running: [docker exec kinder-xony-worker-1 kubeadm version -o=short]"
time="06:33:39" level=debug msg="Preparing kubeadm config v1beta2 (kubeadm version 1.17.4-beta.0.1+aa9a28326e8075)"
time="06:33:39" level=debug msg="Preparing dockerPatch for kubeadm config v1beta2 (kubeadm version 1.17.4-beta.0.1+aa9a28326e8075)"
time="06:33:39" level=debug msg="generated config:\napiVersion: kubeadm.k8s.io/v1beta2\ndiscovery:\n  bootstrapToken:\n    apiServerEndpoint: 172.17.0.7:6443\n    token: abcdef.0123456789abcdef\n    unsafeSkipCAVerification: true\nkind: JoinConfiguration\nnodeRegistration:\n  criSocket: /var/run/dockershim.sock\n  kubeletExtraArgs:\n    fail-swap-on: \"false\"\n    node-ip: 172.17.0.6\n"
time="06:33:39" level=debug msg="Running: [docker cp /tmp/kinder-xony-worker-1-260721368 kinder-xony-worker-1:/kind/kubeadm.conf]"

kinder-xony-worker-1:$ kubeadm join --config=/kind/kubeadm.conf --v=6 --ignore-preflight-errors=Swap,SystemVerification,FileContent--proc-sys-net-bridge-bridge-nf-call-iptables
time="06:33:39" level=debug msg="Running: [docker exec kinder-xony-worker-1 kubeadm join --config=/kind/kubeadm.conf --v=6 --ignore-preflight-errors=Swap,SystemVerification,FileContent--proc-sys-net-bridge-bridge-nf-call-iptables]"
W0212 06:33:40.154073     799 join.go:346] [preflight] WARNING: JoinControlPane.controlPlane settings will be ignored when control-plane flag is not set.
I0212 06:33:40.154128     799 join.go:371] [preflight] found NodeName empty; using OS hostname as NodeName
... skipping 17 lines ...
I0212 06:33:40.377161     799 checks.go:376] validating the presence of executable ebtables
I0212 06:33:40.377241     799 checks.go:376] validating the presence of executable ethtool
I0212 06:33:40.377302     799 checks.go:376] validating the presence of executable socat
I0212 06:33:40.377342     799 checks.go:376] validating the presence of executable tc
I0212 06:33:40.377382     799 checks.go:376] validating the presence of executable touch
I0212 06:33:40.377433     799 checks.go:520] running all checks
[preflight] The system verification failed. Printing the output from the verification:
KERNEL_VERSION: 4.15.0-1044-gke
DOCKER_VERSION: 18.09.4
DOCKER_GRAPH_DRIVER: overlay2
OS: Linux
CGROUPS_CPU: enabled
CGROUPS_CPUACCT: enabled
CGROUPS_CPUSET: enabled
CGROUPS_DEVICES: enabled
CGROUPS_FREEZER: enabled
CGROUPS_MEMORY: enabled
	[WARNING SystemVerification]: failed to parse kernel config: unable to load kernel module: "configs", output: "modprobe: FATAL: Module configs not found in directory /lib/modules/4.15.0-1044-gke\n", err: exit status 1
I0212 06:33:40.481975     799 checks.go:406] checking whether the given node name is reachable using net.LookupHost
I0212 06:33:40.482246     799 checks.go:618] validating kubelet version
I0212 06:33:40.574515     799 checks.go:128] validating if the service is enabled and active
I0212 06:33:40.590570     799 checks.go:201] validating availability of port 10250
I0212 06:33:40.590794     799 checks.go:286] validating the existence of file /etc/kubernetes/pki/ca.crt
I0212 06:33:40.590826     799 checks.go:432] validating if the connectivity type is via proxy or direct
... skipping 92 lines ...

kinder-xony-worker-2:$ Preparing /kind/kubeadm.conf
time="06:34:15" level=debug msg="Running: /usr/bin/docker [docker inspect -f {{range .NetworkSettings.Networks}}{{.IPAddress}},{{.GlobalIPv6Address}}{{end}} kinder-xony-worker-2]"
time="06:34:15" level=debug msg="Running: [docker exec kinder-xony-worker-2 kubeadm version -o=short]"
time="06:34:15" level=debug msg="Preparing kubeadm config v1beta2 (kubeadm version 1.17.4-beta.0.1+aa9a28326e8075)"
time="06:34:15" level=debug msg="Preparing dockerPatch for kubeadm config v1beta2 (kubeadm version 1.17.4-beta.0.1+aa9a28326e8075)"
time="06:34:15" level=debug msg="generated config:\napiVersion: kubeadm.k8s.io/v1beta2\ndiscovery:\n  bootstrapToken:\n    apiServerEndpoint: 172.17.0.7:6443\n    token: abcdef.0123456789abcdef\n    unsafeSkipCAVerification: true\nkind: JoinConfiguration\nnodeRegistration:\n  criSocket: /var/run/dockershim.sock\n  kubeletExtraArgs:\n    fail-swap-on: \"false\"\n    node-ip: 172.17.0.2\n"
time="06:34:15" level=debug msg="Running: [docker cp /tmp/kinder-xony-worker-2-242518615 kinder-xony-worker-2:/kind/kubeadm.conf]"

kinder-xony-worker-2:$ kubeadm join --config=/kind/kubeadm.conf --v=6 --ignore-preflight-errors=Swap,SystemVerification,FileContent--proc-sys-net-bridge-bridge-nf-call-iptables
time="06:34:16" level=debug msg="Running: [docker exec kinder-xony-worker-2 kubeadm join --config=/kind/kubeadm.conf --v=6 --ignore-preflight-errors=Swap,SystemVerification,FileContent--proc-sys-net-bridge-bridge-nf-call-iptables]"
W0212 06:34:16.450827     816 join.go:346] [preflight] WARNING: JoinControlPane.controlPlane settings will be ignored when control-plane flag is not set.
I0212 06:34:16.451192     816 join.go:371] [preflight] found NodeName empty; using OS hostname as NodeName
... skipping 17 lines ...
I0212 06:34:16.678320     816 checks.go:376] validating the presence of executable ebtables
I0212 06:34:16.678361     816 checks.go:376] validating the presence of executable ethtool
I0212 06:34:16.678415     816 checks.go:376] validating the presence of executable socat
I0212 06:34:16.678452     816 checks.go:376] validating the presence of executable tc
I0212 06:34:16.678493     816 checks.go:376] validating the presence of executable touch
I0212 06:34:16.678548     816 checks.go:520] running all checks
	[WARNING SystemVerification]: failed to parse kernel config: unable to load kernel module: "configs", output: "modprobe: FATAL: Module configs not found in directory /lib/modules/4.15.0-1044-gke\n", err: exit status 1
I0212 06:34:16.780859     816 checks.go:406] checking whether the given node name is reachable using net.LookupHost
[preflight] The system verification failed. Printing the output from the verification:
KERNEL_VERSION: 4.15.0-1044-gke
DOCKER_VERSION: 18.09.4
DOCKER_GRAPH_DRIVER: overlay2
OS: Linux
CGROUPS_CPU: enabled
CGROUPS_CPUACCT: enabled
... skipping 235 lines ...
I0212 06:36:13.973940   11890 local.go:106] [etcd] get the member id from peer: https://172.17.0.3:2380
I0212 06:36:13.991025   11890 local.go:112] [etcd] removing etcd member: https://172.17.0.3:2380, id: 12858828581462913056
I0212 06:36:14.025425   11890 local.go:117] [etcd] Updated etcd member list: [{kinder-xony-control-plane-3 https://172.17.0.5:2380} {kinder-xony-control-plane-2 https://172.17.0.4:2380}]
I0212 06:36:14.025479   11890 cleanupnode.go:57] [reset] Getting init system
[reset] Stopping the kubelet service
[reset] Unmounting mounted directories in "/var/lib/kubelet"
W0212 06:36:14.108145   11890 unmount_linux.go:42] [reset] Failed to unmount mounted directory in /var/lib/kubelet: /var/lib/kubelet
I0212 06:36:14.251986   11890 cleanupnode.go:79] [reset] Removing Kubernetes-managed containers
I0212 06:36:21.114917   11890 cleanupnode.go:87] [reset] Removing contents from the config and pki directories
[reset] Deleting contents of config directories: [/etc/kubernetes/manifests /etc/kubernetes/pki]
[reset] Deleting files: [/etc/kubernetes/admin.conf /etc/kubernetes/kubelet.conf /etc/kubernetes/bootstrap-kubelet.conf /etc/kubernetes/controller-manager.conf /etc/kubernetes/scheduler.conf]
[reset] Deleting contents of stateful directories: [/var/lib/etcd /var/lib/kubelet /var/lib/dockershim /var/run/kubernetes /var/lib/cni]
I0212 06:36:21.116168   11890 reset.go:218] [reset] Deleting content of /var/lib/etcd
... skipping 40 lines ...
I0212 06:36:24.549527    5580 local.go:106] [etcd] get the member id from peer: https://172.17.0.4:2380
I0212 06:36:24.562089    5580 local.go:112] [etcd] removing etcd member: https://172.17.0.4:2380, id: 14151438055259652401
[reset] Stopping the kubelet service
I0212 06:36:24.590288    5580 local.go:117] [etcd] Updated etcd member list: [{kinder-xony-control-plane-3 https://172.17.0.5:2380}]
I0212 06:36:24.590329    5580 cleanupnode.go:57] [reset] Getting init system
[reset] Unmounting mounted directories in "/var/lib/kubelet"
W0212 06:36:24.655487    5580 unmount_linux.go:42] [reset] Failed to unmount mounted directory in /var/lib/kubelet: /var/lib/kubelet
I0212 06:36:24.703959    5580 cleanupnode.go:79] [reset] Removing Kubernetes-managed containers
I0212 06:36:28.897733    5580 cleanupnode.go:87] [reset] Removing contents from the config and pki directories
[reset] Deleting contents of config directories: [/etc/kubernetes/manifests /etc/kubernetes/pki]
[reset] Deleting files: [/etc/kubernetes/admin.conf /etc/kubernetes/kubelet.conf /etc/kubernetes/bootstrap-kubelet.conf /etc/kubernetes/controller-manager.conf /etc/kubernetes/scheduler.conf]
[reset] Deleting contents of stateful directories: [/var/lib/etcd /var/lib/kubelet /var/lib/dockershim /var/run/kubernetes /var/lib/cni]
I0212 06:36:28.899302    5580 reset.go:218] [reset] Deleting content of /var/lib/etcd
... skipping 32 lines ...
I0212 06:36:32.295997    4121 uploadconfig.go:58] Removing APIEndpoint for Node "kinder-xony-control-plane-3"
I0212 06:36:32.299208    4121 round_trippers.go:443] PUT https://172.17.0.7:6443/api/v1/namespaces/kube-system/configmaps/kubeadm-config?timeout=10s 200 OK in 2 milliseconds
I0212 06:36:32.299342    4121 removeetcdmember.go:54] [reset] Checking for etcd config
I0212 06:36:32.299372    4121 local.go:97] [etcd] creating etcd client that connects to etcd pods
I0212 06:36:32.301527    4121 round_trippers.go:443] GET https://172.17.0.7:6443/api/v1/namespaces/kube-system/configmaps/kubeadm-config?timeout=10s 200 OK in 2 milliseconds
I0212 06:36:32.301755    4121 etcd.go:107] etcd endpoints read from pods: 
W0212 06:36:32.302216    4121 removeetcdmember.go:61] [reset] failed to remove etcd member: error syncing endpoints with etc: etcdclient: no available endpoints
.Please manually remove this etcd member using etcdctl
I0212 06:36:32.302253    4121 cleanupnode.go:57] [reset] Getting init system
[reset] Stopping the kubelet service
[reset] Unmounting mounted directories in "/var/lib/kubelet"
W0212 06:36:32.371739    4121 unmount_linux.go:42] [reset] Failed to unmount mounted directory in /var/lib/kubelet: /var/lib/kubelet
I0212 06:36:32.423849    4121 cleanupnode.go:79] [reset] Removing Kubernetes-managed containers
[reset] Deleting contents of config directories: [/etc/kubernetes/manifests /etc/kubernetes/pki]
I0212 06:36:36.851301    4121 cleanupnode.go:87] [reset] Removing contents from the config and pki directories
[reset] Deleting files: [/etc/kubernetes/admin.conf /etc/kubernetes/kubelet.conf /etc/kubernetes/bootstrap-kubelet.conf /etc/kubernetes/controller-manager.conf /etc/kubernetes/scheduler.conf]
[reset] Deleting contents of stateful directories: [/var/lib/etcd /var/lib/kubelet /var/lib/dockershim /var/run/kubernetes /var/lib/cni]
I0212 06:36:36.852647    4121 reset.go:218] [reset] Deleting content of /var/lib/etcd
... skipping 21 lines ...
W0212 06:36:37.168077    2372 removeetcdmember.go:79] [reset] No kubeadm config, using etcd pod spec to get data directory
I0212 06:36:37.168109    2372 cleanupnode.go:57] [reset] Getting init system
[preflight] Running pre-flight checks
[reset] No etcd config found. Assuming external etcd
[reset] Please, manually reset etcd to prevent further issues
[reset] Stopping the kubelet service
W0212 06:36:37.215975    2372 unmount_linux.go:42] [reset] Failed to unmount mounted directory in /var/lib/kubelet: /var/lib/kubelet
[reset] Unmounting mounted directories in "/var/lib/kubelet"
I0212 06:36:37.348084    2372 cleanupnode.go:79] [reset] Removing Kubernetes-managed containers
I0212 06:36:38.852440    2372 cleanupnode.go:87] [reset] Removing contents from the config and pki directories
I0212 06:36:38.852760    2372 reset.go:218] [reset] Deleting content of /var/lib/kubelet
[reset] Deleting contents of config directories: [/etc/kubernetes/manifests /etc/kubernetes/pki]
[reset] Deleting files: [/etc/kubernetes/admin.conf /etc/kubernetes/kubelet.conf /etc/kubernetes/bootstrap-kubelet.conf /etc/kubernetes/controller-manager.conf /etc/kubernetes/scheduler.conf]
... skipping 22 lines ...
I0212 06:36:39.220969    1844 cleanupnode.go:57] [reset] Getting init system
[preflight] Running pre-flight checks
[reset] No etcd config found. Assuming external etcd
[reset] Please, manually reset etcd to prevent further issues
[reset] Stopping the kubelet service
[reset] Unmounting mounted directories in "/var/lib/kubelet"
W0212 06:36:39.274873    1844 unmount_linux.go:42] [reset] Failed to unmount mounted directory in /var/lib/kubelet: /var/lib/kubelet
I0212 06:36:39.320016    1844 cleanupnode.go:79] [reset] Removing Kubernetes-managed containers
[reset] Deleting contents of config directories: [/etc/kubernetes/manifests /etc/kubernetes/pki]
[reset] Deleting files: [/etc/kubernetes/admin.conf /etc/kubernetes/kubelet.conf /etc/kubernetes/bootstrap-kubelet.conf /etc/kubernetes/controller-manager.conf /etc/kubernetes/scheduler.conf]
I0212 06:36:40.392392    1844 cleanupnode.go:87] [reset] Removing contents from the config and pki directories
[reset] Deleting contents of stateful directories: [/var/lib/kubelet /var/lib/dockershim /var/run/kubernetes /var/lib/cni]
I0212 06:36:40.392727    1844 reset.go:218] [reset] Deleting content of /var/lib/kubelet
... skipping 20 lines ...
Deleting cluster "kinder-xony" ...
time="06:36:40" level=debug msg="Running: /usr/bin/docker [docker ps -q -a --no-trunc --filter label=io.k8s.sigs.kind.cluster --format {{.Names}}\\t{{.Label \"io.k8s.sigs.kind.cluster\"}} --filter label=io.k8s.sigs.kind.cluster=kinder-xony]"
time="06:36:40" level=debug msg="Running: /usr/bin/docker [docker rm -f -v kinder-xony-lb kinder-xony-worker-2 kinder-xony-control-plane-2 kinder-xony-control-plane-1 kinder-xony-worker-1 kinder-xony-control-plane-3]"
 completed!

Ran 8 of 11 tasks in 0.000 seconds
FAIL! -- 7 tasks Passed | 1 Failed | 3 Skipped

see junit-runner.xml and task logs files for more details

Error: failed executing the workflow
+ EXIT_VALUE=1
+ set +o xtrace
Cleaning up after docker in docker.
================================================================================
[Barnacle] 2020/02/12 06:36:45 Cleaning up Docker data root...
[Barnacle] 2020/02/12 06:36:45 Removing all containers.
[Barnacle] 2020/02/12 06:36:45 Failed to list containers: Error response from daemon: client version 1.41 is too new. Maximum supported API version is 1.40
[Barnacle] 2020/02/12 06:36:45 Removing recently created images.
[Barnacle] 2020/02/12 06:36:45 Failed to list images: Error response from daemon: client version 1.41 is too new. Maximum supported API version is 1.40
[Barnacle] 2020/02/12 06:36:45 Pruning dangling images.
[Barnacle] 2020/02/12 06:36:45 Failed to list images: Error response from daemon: client version 1.41 is too new. Maximum supported API version is 1.40
[Barnacle] 2020/02/12 06:36:45 Pruning volumes.
[Barnacle] 2020/02/12 06:36:45 Failed to prune volumes: Error response from daemon: client version 1.41 is too new. Maximum supported API version is 1.40
[Barnacle] 2020/02/12 06:36:45 Done cleaning up Docker data root.
Remaining docker images and volumes are:
REPOSITORY          TAG                 IMAGE ID            CREATED             SIZE
kindest/node        test                202584d00790        7 minutes ago       1.37GB
kindest/haproxy     2.0.0-alpine        c5e55bb5c182        7 weeks ago         22.5MB
kindest/base        v20190403-1ebf15f   714d97b85e0a        10 months ago       511MB
... skipping 6 lines ...