=== RUN   TestOffline/group/crio

=== PAUSE TestOffline/group/crio

=== CONT  TestOffline/group/crio

--- FAIL: TestOffline/group/crio (49.59s)

aab_offline_test.go:53: (dbg) Run:  out/minikube-linux-amd64 start -p offline-crio-20200221T161023.921792028-5900 --alsologtostderr -v=1 --wait=true --container-runtime crio --vm-driver=docker 

aab_offline_test.go:53: (dbg) Non-zero exit: out/minikube-linux-amd64 start -p offline-crio-20200221T161023.921792028-5900 --alsologtostderr -v=1 --wait=true --container-runtime crio --vm-driver=docker : exit status 70 (48.321494627s)

-- stdout --

! [offline-crio-20200221T161023.921792028-5900] minikube v1.7.3 on Debian 9.12

- KUBECONFIG=/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/kubeconfig

- MINIKUBE_BIN=out/minikube-linux-amd64

- MINIKUBE_HOME=/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube

- MINIKUBE_LOCATION=6717

* Using the docker (experimental) driver based on user configuration

* Creating Kubernetes in docker container with (CPUs=2), Memory=2000MB (30163MB available) ...

* Found network options:

- HTTP_PROXY=172.16.1.1:1

-- /stdout --

** stderr ** 

I0221 16:10:23.968672    6328 notify.go:125] Checking for updates...

W0221 16:10:53.969061    6328 notify.go:56] Error getting json from minikube version url: error with http GET for endpoint https://storage.googleapis.com/minikube/releases.json: Get https://storage.googleapis.com/minikube/releases.json: proxyconnect tcp: dial tcp 172.16.1.1:1: i/o timeout

I0221 16:10:54.452495    6328 start.go:249] hostinfo: {"hostname":"kic-integration-slave8","uptime":3209,"bootTime":1582327045,"procs":198,"os":"linux","platform":"debian","platformFamily":"debian","platformVersion":"9.12","kernelVersion":"4.9.0-12-amd64","virtualizationSystem":"kvm","virtualizationRole":"host","hostid":"ae41e7f6-8b8e-4d40-b77d-1ebb5a2d5fdb"}

I0221 16:10:54.453573    6328 start.go:259] virtualization: kvm host

I0221 16:10:54.453885    6328 driver.go:211] Setting default libvirt URI to qemu:///system

I0221 16:10:57.457007    6328 start.go:296] selected driver: docker

I0221 16:10:57.457023    6328 start.go:472] validating driver "docker" against <nil>

I0221 16:10:57.457037    6328 start.go:478] status for docker: {Installed:true Healthy:false Error:signal: killed Fix:Docker is not running or is responding too slow. Try: restarting docker desktop. Doc:}

! 'docker' driver reported an issue: signal: killed

* Suggestion: Docker is not running or is responding too slow. Try: restarting docker desktop.

I0221 16:10:57.457158    6328 start.go:860] auto setting extra-config to "kubeadm.pod-network-cidr=10.244.0.0/16".

I0221 16:10:57.457594    6328 profile.go:100] Saving config to /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/profiles/offline-crio-20200221T161023.921792028-5900/config.json ...

I0221 16:10:57.457598    6328 cache.go:91] acquiring lock: {Name:mk44c9561e166e21785a4721df933828ea571af8 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}

I0221 16:10:57.457675    6328 cache.go:91] acquiring lock: {Name:mkcb7d2cafc6915c86bdae0c7a30271b767095b0 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}

I0221 16:10:57.457684    6328 cache.go:91] acquiring lock: {Name:mk5ac0830b02e897c33d1120aa18f80546481d7a Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}

I0221 16:10:57.457691    6328 lock.go:35] WriteFile acquiring /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/profiles/offline-crio-20200221T161023.921792028-5900/config.json: {Name:mk669c0fa12416cdbf1b4e188473aec8f881a698 Clock:{} Delay:500ms Timeout:1m0s Cancel:<nil>}

I0221 16:10:57.457749    6328 cache.go:91] acquiring lock: {Name:mka61e146096dd5a61ec8feae30a9ff97e270596 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}

I0221 16:10:57.457771    6328 cache.go:91] acquiring lock: {Name:mk3657c5277854a27db750e88cd99b544a4c7fdd Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}

I0221 16:10:57.458095    6328 cache.go:91] acquiring lock: {Name:mk0edb0ba952dc44ab773b7cbbf3b90fb552a0bf Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}

I0221 16:10:57.458274    6328 cache.go:99] /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/kubernetesui/metrics-scraper_v1.0.2 exists

I0221 16:10:57.458262    6328 cache.go:91] acquiring lock: {Name:mkdb0e6b8c9c1308a66fcc059b99f67d008724db Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}

I0221 16:10:57.458306    6328 cache.go:80] cache image "kubernetesui/metrics-scraper:v1.0.2" -> "/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/kubernetesui/metrics-scraper_v1.0.2" took 711.11µs

I0221 16:10:57.458327    6328 cache.go:65] save to tar file kubernetesui/metrics-scraper:v1.0.2 -> /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/kubernetesui/metrics-scraper_v1.0.2 succeeded

I0221 16:10:57.458360    6328 cache.go:99] /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/pause_3.1 exists

I0221 16:10:57.458367    6328 cache.go:99] /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/kubernetesui/dashboard_v2.0.0-beta8 exists

I0221 16:10:57.458394    6328 cache.go:80] cache image "k8s.gcr.io/pause:3.1" -> "/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/pause_3.1" took 714.698µs

I0221 16:10:57.458409    6328 cache.go:65] save to tar file k8s.gcr.io/pause:3.1 -> /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/pause_3.1 succeeded

I0221 16:10:57.458412    6328 cache.go:80] cache image "kubernetesui/dashboard:v2.0.0-beta8" -> "/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/kubernetesui/dashboard_v2.0.0-beta8" took 328.12µs

I0221 16:10:57.458437    6328 cache.go:99] /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/coredns_1.6.5 exists

I0221 16:10:57.458440    6328 cache.go:65] save to tar file kubernetesui/dashboard:v2.0.0-beta8 -> /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/kubernetesui/dashboard_v2.0.0-beta8 succeeded

I0221 16:10:57.458447    6328 cache.go:99] /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-apiserver_v1.17.3 exists

I0221 16:10:57.458454    6328 cache.go:91] acquiring lock: {Name:mk52e42b7368bd673c054e2ccc405e493a6ca9d7 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}

I0221 16:10:57.458467    6328 cache.go:80] cache image "k8s.gcr.io/kube-apiserver:v1.17.3" -> "/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-apiserver_v1.17.3" took 697.999µs

I0221 16:10:57.458451    6328 cache.go:80] cache image "k8s.gcr.io/coredns:1.6.5" -> "/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/coredns_1.6.5" took 836.277µs

I0221 16:10:57.458487    6328 cache.go:65] save to tar file k8s.gcr.io/coredns:1.6.5 -> /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/coredns_1.6.5 succeeded

I0221 16:10:57.458483    6328 cache.go:65] save to tar file k8s.gcr.io/kube-apiserver:v1.17.3 -> /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-apiserver_v1.17.3 succeeded

I0221 16:10:57.458525    6328 cache.go:99] /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/gcr.io/k8s-minikube/storage-provisioner_v1.8.1 exists

I0221 16:10:57.458508    6328 cache.go:91] acquiring lock: {Name:mk86cf48d663eb62ed4df8ddaf4f16b70290f235 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}

I0221 16:10:57.458544    6328 cache.go:80] cache image "gcr.io/k8s-minikube/storage-provisioner:v1.8.1" -> "/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/gcr.io/k8s-minikube/storage-provisioner_v1.8.1" took 805.55µs

I0221 16:10:57.458559    6328 cache.go:65] save to tar file gcr.io/k8s-minikube/storage-provisioner:v1.8.1 -> /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/gcr.io/k8s-minikube/storage-provisioner_v1.8.1 succeeded

I0221 16:10:57.458449    6328 cache.go:99] /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-proxy_v1.17.3 exists

I0221 16:10:57.458581    6328 cache.go:80] cache image "k8s.gcr.io/kube-proxy:v1.17.3" -> "/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-proxy_v1.17.3" took 845.397µs

I0221 16:10:57.458606    6328 cache.go:65] save to tar file k8s.gcr.io/kube-proxy:v1.17.3 -> /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-proxy_v1.17.3 succeeded

I0221 16:10:57.458629    6328 start.go:244] acquiring machines lock for offline-crio-20200221T161023.921792028-5900: {Name:mk88fe798e10191c7698c4f816989eadab63820d Clock:{} Delay:500ms Timeout:15m0s Cancel:<nil>}

I0221 16:10:57.458629    6328 cache.go:99] /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-scheduler_v1.17.3 exists

I0221 16:10:57.458641    6328 cache.go:91] acquiring lock: {Name:mk811d1e4da8db959175d8d0af21982c5a0582d1 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}

I0221 16:10:57.458671    6328 cache.go:99] /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/etcd_3.4.3-0 exists

I0221 16:10:57.458663    6328 cache.go:80] cache image "k8s.gcr.io/kube-scheduler:v1.17.3" -> "/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-scheduler_v1.17.3" took 161.211µs

I0221 16:10:57.458688    6328 cache.go:65] save to tar file k8s.gcr.io/kube-scheduler:v1.17.3 -> /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-scheduler_v1.17.3 succeeded

I0221 16:10:57.458688    6328 cache.go:80] cache image "k8s.gcr.io/etcd:3.4.3-0" -> "/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/etcd_3.4.3-0" took 941.11µs

I0221 16:10:57.458704    6328 cache.go:65] save to tar file k8s.gcr.io/etcd:3.4.3-0 -> /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/etcd_3.4.3-0 succeeded

I0221 16:10:57.458725    6328 cache.go:99] /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-controller-manager_v1.17.3 exists

I0221 16:10:57.458740    6328 cache.go:80] cache image "k8s.gcr.io/kube-controller-manager:v1.17.3" -> "/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-controller-manager_v1.17.3" took 111.352µs

I0221 16:10:57.458754    6328 cache.go:65] save to tar file k8s.gcr.io/kube-controller-manager:v1.17.3 -> /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-controller-manager_v1.17.3 succeeded

I0221 16:10:57.458771    6328 cache.go:72] Successfully saved all images to host disk.

I0221 16:11:07.844064    6328 start.go:248] acquired machines lock for "offline-crio-20200221T161023.921792028-5900" in 10.385412518s

I0221 16:11:07.844119    6328 start.go:81] Provisioning new machine with config: {Name:offline-crio-20200221T161023.921792028-5900 KeepContext:false EmbedCerts:false MinikubeISO:https://storage.googleapis.com/minikube/iso/minikube-v1.7.3.iso Memory:2000 CPUs:2 DiskSize:20000 Driver:docker HyperkitVpnKitSock: HyperkitVSockPorts:[] DockerEnv:[] InsecureRegistry:[] RegistryMirror:[] HostOnlyCIDR:192.168.99.1/24 HypervVirtualSwitch: HypervUseExternalSwitch:false HypervExternalAdapter: KVMNetwork:default KVMQemuURI:qemu:///system KVMGPU:false KVMHidden:false Downloader:{} DockerOpt:[] DisableDriverMounts:false NFSShare:[] NFSSharesRoot:/nfsshares UUID: NoVTXCheck:false DNSProxy:false HostDNSResolver:true HostOnlyNicType:virtio NatNicType:virtio KubernetesConfig:{KubernetesVersion:v1.17.3 ClusterName:offline-crio-20200221T161023.921792028-5900 APIServerName:minikubeCA APIServerNames:[] APIServerIPs:[] DNSDomain:cluster.local ContainerRuntime:crio CRISocket: NetworkPlugin:cni FeatureGates: ServiceCID

R:10.96.0.0/12 ImageRepository: ExtraOptions:[{Component:kubeadm Key:pod-network-cidr Value:10.244.0.0/16}] ShouldLoadCachedImages:true EnableDefaultCNI:true} Nodes:[{Name:offline-crio-20200221T161023.921792028-5900 IP: Port:8443 KubernetesVersion:v1.17.3 ControlPlane:true Worker:true}] Addons:map[]}

I0221 16:11:07.844214    6328 start.go:100] createHost starting for "offline-crio-20200221T161023.921792028-5900" (driver="docker")

I0221 16:11:07.845356    6328 start.go:136] libmachine.API.Create for "offline-crio-20200221T161023.921792028-5900" (driver="docker")

I0221 16:11:07.845468    6328 main.go:110] libmachine: Reading certificate data from /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/certs/ca.pem

I0221 16:11:07.845505    6328 main.go:110] libmachine: Decoding PEM data...

I0221 16:11:07.845531    6328 main.go:110] libmachine: Parsing certificate...

I0221 16:11:07.845757    6328 main.go:110] libmachine: Reading certificate data from /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/certs/cert.pem

I0221 16:11:07.845796    6328 main.go:110] libmachine: Decoding PEM data...

I0221 16:11:07.845814    6328 main.go:110] libmachine: Parsing certificate...

I0221 16:11:07.899840    6328 oci.go:105] Successfully created a docker volume offline-crio-20200221T161023.921792028-5900

I0221 16:11:08.623879    6328 kic.go:105] Creating ssh key for kic: /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/machines/offline-crio-20200221T161023.921792028-5900/id_rsa...

I0221 16:11:09.508779    6328 main.go:110] libmachine: provisioning hostname "offline-crio-20200221T161023.921792028-5900"

I0221 16:11:09.563412    6328 main.go:110] libmachine: Using SSH client type: native

I0221 16:11:09.563752    6328 main.go:110] libmachine: &{{{<nil> 0 [] [] []} docker [0x7b9a50] 0x7b9a20 <nil>  [] 0s} 127.0.0.1 32773 <nil> <nil>}

I0221 16:11:09.563786    6328 main.go:110] libmachine: About to run SSH command:

sudo hostname offline-crio-20200221T161023.921792028-5900 && echo "offline-crio-20200221T161023.921792028-5900" | sudo tee /etc/hostname

I0221 16:11:09.722205    6328 main.go:110] libmachine: SSH cmd err, output: <nil>: offline-crio-20200221T161023.921792028-5900

I0221 16:11:09.774579    6328 main.go:110] libmachine: Using SSH client type: native

I0221 16:11:09.774811    6328 main.go:110] libmachine: &{{{<nil> 0 [] [] []} docker [0x7b9a50] 0x7b9a20 <nil>  [] 0s} 127.0.0.1 32773 <nil> <nil>}

I0221 16:11:09.774854    6328 main.go:110] libmachine: About to run SSH command:

		if ! grep -xq '.*\soffline-crio-20200221T161023.921792028-5900' /etc/hosts; then

			if grep -xq '127.0.1.1\s.*' /etc/hosts; then

				sudo sed -i 's/^127.0.1.1\s.*/127.0.1.1 offline-crio-20200221T161023.921792028-5900/g' /etc/hosts;

			else 

				echo '127.0.1.1 offline-crio-20200221T161023.921792028-5900' | sudo tee -a /etc/hosts; 

			fi

		fi

I0221 16:11:09.923399    6328 main.go:110] libmachine: SSH cmd err, output: <nil>: 127.0.1.1 offline-crio-20200221T161023.921792028-5900

I0221 16:11:09.923537    6328 main.go:110] libmachine: set auth options {CertDir:/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube CaCertPath:/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/certs/ca.pem CaPrivateKeyPath:/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/certs/ca-key.pem CaCertRemotePath:/etc/docker/ca.pem ServerCertPath:/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/machines/server.pem ServerKeyPath:/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/machines/server-key.pem ClientKeyPath:/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/certs/key.pem ServerCertRemotePath:/etc/docker/server.pe

m ServerKeyRemotePath:/etc/docker/server-key.pem ClientCertPath:/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/certs/cert.pem ServerCertSANs:[] StorePath:/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube}

I0221 16:11:09.923554    6328 main.go:110] libmachine: setting up certificates

I0221 16:11:09.923567    6328 main.go:110] libmachine: configureAuth start

I0221 16:11:09.979985    6328 main.go:110] libmachine: copyHostCerts

I0221 16:11:09.980396    6328 main.go:110] libmachine: generating server cert: /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/machines/server.pem ca-key=/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/certs/ca.pem private-key=/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/certs/ca-key.pem org=jenkins.offline-crio-20200221T161023.921792028-5900 san=[172.17.0.3 localhost 127.0.0.1]

I0221 16:11:10.102875    6328 main.go:110] libmachine: copyRemoteCerts

I0221 16:11:10.199190    6328 ssh_runner.go:101] Run: sudo mkdir -p /etc/docker /etc/docker /etc/docker

I0221 16:11:10.254787    6328 ssh_runner.go:155] Checked if /etc/docker/server-key.pem exists, but got error: Process exited with status 1

I0221 16:11:10.255291    6328 ssh_runner.go:174] Transferring 1675 bytes to /etc/docker/server-key.pem

I0221 16:11:10.256028    6328 ssh_runner.go:193] server-key.pem: copied 1675 bytes

I0221 16:11:10.282227    6328 ssh_runner.go:155] Checked if /etc/docker/ca.pem exists, but got error: Process exited with status 1

I0221 16:11:10.282585    6328 ssh_runner.go:174] Transferring 1038 bytes to /etc/docker/ca.pem

I0221 16:11:10.283349    6328 ssh_runner.go:193] ca.pem: copied 1038 bytes

I0221 16:11:10.310624    6328 ssh_runner.go:155] Checked if /etc/docker/server.pem exists, but got error: Process exited with status 1

I0221 16:11:10.311018    6328 ssh_runner.go:174] Transferring 1168 bytes to /etc/docker/server.pem

I0221 16:11:10.311969    6328 ssh_runner.go:193] server.pem: copied 1168 bytes

I0221 16:11:10.332787    6328 main.go:110] libmachine: configureAuth took 409.155995ms

I0221 16:11:10.332821    6328 main.go:110] libmachine: setting minikube options for container-runtime

I0221 16:11:10.383975    6328 main.go:110] libmachine: Using SSH client type: native

I0221 16:11:10.384211    6328 main.go:110] libmachine: &{{{<nil> 0 [] [] []} docker [0x7b9a50] 0x7b9a20 <nil>  [] 0s} 127.0.0.1 32773 <nil> <nil>}

I0221 16:11:10.384234    6328 main.go:110] libmachine: About to run SSH command:

sudo mkdir -p /etc/sysconfig && printf %s "

CRIO_MINIKUBE_OPTIONS='--insecure-registry 10.96.0.0/12 '

" | sudo tee /etc/sysconfig/crio.minikube

I0221 16:11:10.529795    6328 main.go:110] libmachine: SSH cmd err, output: <nil>: 

CRIO_MINIKUBE_OPTIONS='--insecure-registry 10.96.0.0/12 '

I0221 16:11:10.529841    6328 start.go:141] libmachine.API.Create for "offline-crio-20200221T161023.921792028-5900" took 2.684484614s

I0221 16:11:10.529856    6328 start.go:182] post-start starting for "offline-crio-20200221T161023.921792028-5900" (driver="docker")

I0221 16:11:10.529863    6328 start.go:192] creating required directories: [/etc/kubernetes/addons /etc/kubernetes/manifests /var/tmp/minikube /var/lib/minikube /var/lib/minikube/certs /var/lib/minikube/images /var/lib/minikube/binaries /tmp/gvisor /usr/share/ca-certificates /etc/ssl/certs]

I0221 16:11:10.529890    6328 start.go:215] determining appropriate runner for "docker"

I0221 16:11:10.529898    6328 start.go:226] Returning KICRunner for "docker" driver

I0221 16:11:10.682943    6328 filesync.go:118] Scanning /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/addons for local assets ...

I0221 16:11:10.683036    6328 filesync.go:118] Scanning /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/files for local assets ...

I0221 16:11:10.683079    6328 start.go:185] post-start completed in 153.204057ms

I0221 16:11:10.683472    6328 start.go:103] createHost completed in 2.839244684s

I0221 16:11:10.683490    6328 start.go:72] releasing machines lock for "offline-crio-20200221T161023.921792028-5900", held for 2.839393034s

! You appear to be using a proxy, but your NO_PROXY environment does not include the minikube IP (172.17.0.3). Please see https://minikube.sigs.k8s.io/docs/reference/networking/proxy/ for more details

I0221 16:11:11.071047    6328 profile.go:100] Saving config to /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/profiles/offline-crio-20200221T161023.921792028-5900/config.json ...

W0221 16:11:12.241771    6328 exit.go:101] Failed to enable container runtime: generateCRIOConfig.: /bin/bash -c "sudo sed -e 's|^pause_image = .*$|pause_image = "k8s.gcr.io/pause:3.1"|' -i /etc/crio/crio.conf": exit status 2

stdout:

stderr:

sed: can't read /etc/crio/crio.conf: No such file or directory

* 

X Failed to enable container runtime: generateCRIOConfig.: /bin/bash -c "sudo sed -e 's|^pause_image = .*$|pause_image = "k8s.gcr.io/pause:3.1"|' -i /etc/crio/crio.conf": exit status 2

stdout:

stderr:

sed: can't read /etc/crio/crio.conf: No such file or directory

* 

* minikube is exiting due to an error. If the above message is not useful, open an issue:

- https://github.com/kubernetes/minikube/issues/new/choose

** /stderr **

aab_offline_test.go:56: [out/minikube-linux-amd64 start -p offline-crio-20200221T161023.921792028-5900 --alsologtostderr -v=1 --wait=true --container-runtime crio --vm-driver=docker ] failed: exit status 70

panic.go:563: *** TestOffline/group/crio FAILED at 2020-02-21 16:11:12.243816692 -0800 PST m=+62.785942193

helpers.go:188: (dbg) Run:  out/minikube-linux-amd64 status --format={{.Host}} -p offline-crio-20200221T161023.921792028-5900

helpers.go:188: (dbg) Non-zero exit: out/minikube-linux-amd64 status --format={{.Host}} -p offline-crio-20200221T161023.921792028-5900: exit status 6 (453.341217ms)

-- stdout --

Running

WARNING: Your kubectl is pointing to stale minikube-vm.

To fix the kubectl context, run `minikube update-context`

-- /stdout --

helpers.go:188: status error: exit status 6 (may be ok)

helpers.go:190: "offline-crio-20200221T161023.921792028-5900" host is not running, skipping log retrieval (state="Running\nWARNING: Your kubectl is pointing to stale minikube-vm.\nTo fix the kubectl context, run `minikube update-context`")

helpers.go:160: (dbg) Run:  out/minikube-linux-amd64 delete -p offline-crio-20200221T161023.921792028-5900

=== RUN   TestAddons/parallel/MetricsServer

=== PAUSE TestAddons/parallel/MetricsServer

=== CONT  TestAddons/parallel/MetricsServer

--- FAIL: TestAddons/parallel/MetricsServer (450.10s)

addons_test.go:221: metrics-server stabilized in 5.440065901s

addons_test.go:223: (dbg) TestAddons/parallel/MetricsServer: waiting 6m0s for pods matching "k8s-app=metrics-server" in namespace "kube-system" ...

helpers.go:279: "metrics-server-6754dbc9df-xl54r" [917f5c10-b79b-4fe2-83cf-bac1c789d9ba] Pending: PodScheduled:Unschedulable (0/1 nodes are available: 1 node(s) had taints that the pod didn't tolerate.)

helpers.go:279: "metrics-server-6754dbc9df-xl54r" [917f5c10-b79b-4fe2-83cf-bac1c789d9ba] Pending

helpers.go:279: "metrics-server-6754dbc9df-xl54r" [917f5c10-b79b-4fe2-83cf-bac1c789d9ba] Pending / Ready:ContainersNotReady (containers with unready status: [metrics-server]) / ContainersReady:ContainersNotReady (containers with unready status: [metrics-server])

helpers.go:279: "metrics-server-6754dbc9df-xl54r" [917f5c10-b79b-4fe2-83cf-bac1c789d9ba] Running

helpers.go:279: "metrics-server-6754dbc9df-xl54r" [917f5c10-b79b-4fe2-83cf-bac1c789d9ba] Running / Ready:ContainersNotReady (containers with unready status: [metrics-server]) / ContainersReady:ContainersNotReady (containers with unready status: [metrics-server])

helpers.go:279: "metrics-server-6754dbc9df-xl54r" [917f5c10-b79b-4fe2-83cf-bac1c789d9ba] Running

helpers.go:279: "metrics-server-6754dbc9df-xl54r" [917f5c10-b79b-4fe2-83cf-bac1c789d9ba] Running / Ready:ContainersNotReady (containers with unready status: [metrics-server]) / ContainersReady:ContainersNotReady (containers with unready status: [metrics-server])

addons_test.go:223: (dbg) TestAddons/parallel/MetricsServer: k8s-app=metrics-server healthy within 41.149135214s

addons_test.go:229: (dbg) Run:  kubectl --context addons-20200221T161731.586772848-5900 top pods -n kube-system

addons_test.go:229: (dbg) Non-zero exit: kubectl --context addons-20200221T161731.586772848-5900 top pods -n kube-system: exit status 1 (88.485583ms)

** stderr ** 

Error from server (ServiceUnavailable): the server is currently unable to handle the request (get pods.metrics.k8s.io)

** /stderr **

addons_test.go:229: (dbg) Run:  kubectl --context addons-20200221T161731.586772848-5900 top pods -n kube-system

addons_test.go:229: (dbg) Non-zero exit: kubectl --context addons-20200221T161731.586772848-5900 top pods -n kube-system: exit status 1 (85.227684ms)

** stderr ** 

Error from server (ServiceUnavailable): the server is currently unable to handle the request (get pods.metrics.k8s.io)

** /stderr **

addons_test.go:229: (dbg) Run:  kubectl --context addons-20200221T161731.586772848-5900 top pods -n kube-system

addons_test.go:229: (dbg) Non-zero exit: kubectl --context addons-20200221T161731.586772848-5900 top pods -n kube-system: exit status 1 (110.809624ms)

** stderr ** 

Error from server (ServiceUnavailable): the server is currently unable to handle the request (get pods.metrics.k8s.io)

** /stderr **

addons_test.go:229: (dbg) Run:  kubectl --context addons-20200221T161731.586772848-5900 top pods -n kube-system

addons_test.go:229: (dbg) Non-zero exit: kubectl --context addons-20200221T161731.586772848-5900 top pods -n kube-system: exit status 1 (82.671597ms)

** stderr ** 

Error from server (ServiceUnavailable): the server is currently unable to handle the request (get pods.metrics.k8s.io)

** /stderr **

addons_test.go:229: (dbg) Run:  kubectl --context addons-20200221T161731.586772848-5900 top pods -n kube-system

addons_test.go:229: (dbg) Non-zero exit: kubectl --context addons-20200221T161731.586772848-5900 top pods -n kube-system: exit status 1 (76.219392ms)

** stderr ** 

Error from server (ServiceUnavailable): the server is currently unable to handle the request (get pods.metrics.k8s.io)

** /stderr **

addons_test.go:229: (dbg) Run:  kubectl --context addons-20200221T161731.586772848-5900 top pods -n kube-system

addons_test.go:229: (dbg) Non-zero exit: kubectl --context addons-20200221T161731.586772848-5900 top pods -n kube-system: exit status 1 (76.268844ms)

** stderr ** 

Error from server (ServiceUnavailable): the server is currently unable to handle the request (get pods.metrics.k8s.io)

** /stderr **

addons_test.go:229: (dbg) Run:  kubectl --context addons-20200221T161731.586772848-5900 top pods -n kube-system

addons_test.go:229: (dbg) Non-zero exit: kubectl --context addons-20200221T161731.586772848-5900 top pods -n kube-system: exit status 1 (135.35184ms)

** stderr ** 

Error from server (ServiceUnavailable): the server is currently unable to handle the request (get pods.metrics.k8s.io)

** /stderr **

addons_test.go:229: (dbg) Run:  kubectl --context addons-20200221T161731.586772848-5900 top pods -n kube-system

addons_test.go:229: (dbg) Non-zero exit: kubectl --context addons-20200221T161731.586772848-5900 top pods -n kube-system: exit status 1 (77.11245ms)

** stderr ** 

Error from server (ServiceUnavailable): the server is currently unable to handle the request (get pods.metrics.k8s.io)

** /stderr **

addons_test.go:229: (dbg) Run:  kubectl --context addons-20200221T161731.586772848-5900 top pods -n kube-system

addons_test.go:229: (dbg) Non-zero exit: kubectl --context addons-20200221T161731.586772848-5900 top pods -n kube-system: exit status 1 (144.827674ms)

** stderr ** 

Error from server (ServiceUnavailable): the server is currently unable to handle the request (get pods.metrics.k8s.io)

** /stderr **

addons_test.go:229: (dbg) Run:  kubectl --context addons-20200221T161731.586772848-5900 top pods -n kube-system

addons_test.go:229: (dbg) Non-zero exit: kubectl --context addons-20200221T161731.586772848-5900 top pods -n kube-system: exit status 1 (80.921702ms)

** stderr ** 

Error from server (ServiceUnavailable): the server is currently unable to handle the request (get pods.metrics.k8s.io)

** /stderr **

addons_test.go:229: (dbg) Run:  kubectl --context addons-20200221T161731.586772848-5900 top pods -n kube-system

addons_test.go:229: (dbg) Non-zero exit: kubectl --context addons-20200221T161731.586772848-5900 top pods -n kube-system: exit status 1 (76.217814ms)

** stderr ** 

Error from server (ServiceUnavailable): the server is currently unable to handle the request (get pods.metrics.k8s.io)

** /stderr **

addons_test.go:244: exit status 1

addons_test.go:247: (dbg) Run:  out/minikube-linux-amd64 -p addons-20200221T161731.586772848-5900 addons disable metrics-server --alsologtostderr -v=1

addons_test.go:69: (dbg) Run:  out/minikube-linux-amd64 stop -p addons-20200221T161731.586772848-5900

addons_test.go:69: (dbg) Done: out/minikube-linux-amd64 stop -p addons-20200221T161731.586772848-5900: (7.493525797s)

addons_test.go:73: (dbg) Run:  out/minikube-linux-amd64 addons enable dashboard -p addons-20200221T161731.586772848-5900

addons_test.go:77: (dbg) Run:  out/minikube-linux-amd64 addons disable dashboard -p addons-20200221T161731.586772848-5900

addons_test.go:81: *** TestAddons FAILED at 2020-02-21 16:26:16.868385293 -0800 PST m=+967.410510748

helpers.go:188: (dbg) Run:  out/minikube-linux-amd64 status --format={{.Host}} -p addons-20200221T161731.586772848-5900

helpers.go:188: (dbg) Non-zero exit: out/minikube-linux-amd64 status --format={{.Host}} -p addons-20200221T161731.586772848-5900: exit status 7 (90.614282ms)

-- stdout --

Stopped

-- /stdout --

helpers.go:188: status error: exit status 7 (may be ok)

helpers.go:190: "addons-20200221T161731.586772848-5900" host is not running, skipping log retrieval (state="Stopped")

helpers.go:160: (dbg) Run:  out/minikube-linux-amd64 delete -p addons-20200221T161731.586772848-5900

helpers.go:160: (dbg) Done: out/minikube-linux-amd64 delete -p addons-20200221T161731.586772848-5900: (1.347033831s)

=== RUN   TestDockerFlags

=== PAUSE TestDockerFlags

=== CONT  TestDockerFlags

--- FAIL: TestDockerFlags (131.81s)

docker_test.go:40: (dbg) Run:  out/minikube-linux-amd64 start -p docker-flags-20200221T162731.120278192-5900 --cache-images=false --install-addons=false --wait=false --docker-env=FOO=BAR --docker-env=BAZ=BAT --docker-opt=debug --docker-opt=icc=true --alsologtostderr -v=5 --vm-driver=docker 

docker_test.go:40: (dbg) Done: out/minikube-linux-amd64 start -p docker-flags-20200221T162731.120278192-5900 --cache-images=false --install-addons=false --wait=false --docker-env=FOO=BAR --docker-env=BAZ=BAT --docker-opt=debug --docker-opt=icc=true --alsologtostderr -v=5 --vm-driver=docker : (2m1.576685194s)

docker_test.go:45: (dbg) Run:  out/minikube-linux-amd64 -p docker-flags-20200221T162731.120278192-5900 ssh "systemctl show docker --property=Environment --no-pager"

docker_test.go:45: (dbg) Non-zero exit: out/minikube-linux-amd64 -p docker-flags-20200221T162731.120278192-5900 ssh "systemctl show docker --property=Environment --no-pager": exit status 1 (340.927685ms)

-- stdout --

Failed to connect to bus: No such file or directory

-- /stdout --

** stderr ** 

ssh: Process exited with status 1

** /stderr **

docker_test.go:47: [out/minikube-linux-amd64 -p docker-flags-20200221T162731.120278192-5900 ssh systemctl show docker --property=Environment --no-pager] failed: exit status 1

docker_test.go:52: env var FOO=BAR missing: Failed to connect to bus: No such file or directory

.

docker_test.go:52: env var BAZ=BAT missing: Failed to connect to bus: No such file or directory

.

docker_test.go:56: (dbg) Run:  out/minikube-linux-amd64 -p docker-flags-20200221T162731.120278192-5900 ssh "systemctl show docker --property=ExecStart --no-pager"

docker_test.go:56: (dbg) Non-zero exit: out/minikube-linux-amd64 -p docker-flags-20200221T162731.120278192-5900 ssh "systemctl show docker --property=ExecStart --no-pager": exit status 1 (310.830182ms)

-- stdout --

Failed to connect to bus: No such file or directory

-- /stdout --

** stderr ** 

ssh: Process exited with status 1

** /stderr **

docker_test.go:58: [out/minikube-linux-amd64 -p docker-flags-20200221T162731.120278192-5900 ssh systemctl show docker --property=ExecStart --no-pager] failed: exit status 1

docker_test.go:62: out/minikube-linux-amd64 -p docker-flags-20200221T162731.120278192-5900 ssh "systemctl show docker --property=ExecStart --no-pager" = "Failed to connect to bus: No such file or directory\r\n", want *--debug*

panic.go:563: *** TestDockerFlags FAILED at 2020-02-21 16:29:33.349197032 -0800 PST m=+1163.891322516

helpers.go:188: (dbg) Run:  out/minikube-linux-amd64 status --format={{.Host}} -p docker-flags-20200221T162731.120278192-5900

helpers.go:194: <<< TestDockerFlags FAILED: start of post-mortem logs <<<

helpers.go:195: (dbg) Run:  out/minikube-linux-amd64 -p docker-flags-20200221T162731.120278192-5900 logs --problems

helpers.go:195: (dbg) Done: out/minikube-linux-amd64 -p docker-flags-20200221T162731.120278192-5900 logs --problems: (5.508826055s)

helpers.go:200: TestDockerFlags logs: 

helpers.go:202: (dbg) Run:  out/minikube-linux-amd64 status --format={{.APIServer}} -p docker-flags-20200221T162731.120278192-5900

helpers.go:208: (dbg) Run:  kubectl --context docker-flags-20200221T162731.120278192-5900 get po -A --show-labels

helpers.go:213: (dbg) kubectl --context docker-flags-20200221T162731.120278192-5900 get po -A --show-labels:

NAMESPACE     NAME                                                                  READY   STATUS    RESTARTS   AGE   LABELS

kube-system   coredns-6955765f44-7kqtk                                              1/1     Running   0          15s   k8s-app=kube-dns,pod-template-hash=6955765f44

kube-system   coredns-6955765f44-8sfjv                                              1/1     Running   0          15s   k8s-app=kube-dns,pod-template-hash=6955765f44

kube-system   etcd-docker-flags-20200221t162731.120278192-5900                      1/1     Running   0          29s   component=etcd,tier=control-plane

kube-system   kindnet-q7smz                                                         1/1     Running   0          15s   app=kindnet,controller-revision-hash=6f48886b45,k8s-app=kindnet,pod-template-generation=1,tier=node

kube-system   kube-apiserver-docker-flags-20200221t162731.120278192-5900            1/1     Running   0          29s   component=kube-apiserver,tier=control-plane

kube-system   kube-controller-manager-docker-flags-20200221t162731.120278192-5900   1/1     Running   0          29s   component=kube-controller-manager,tier=control-plane

kube-system   kube-proxy-pb9fv                                                      1/1     Running   0          15s   controller-revision-hash=5fc47fcbf5,k8s-app=kube-proxy,pod-template-generation=1

kube-system   kube-scheduler-docker-flags-20200221t162731.120278192-5900            1/1     Running   0          29s   component=kube-scheduler,tier=control-plane

helpers.go:215: (dbg) Run:  kubectl --context docker-flags-20200221T162731.120278192-5900 describe node

helpers.go:219: (dbg) kubectl --context docker-flags-20200221T162731.120278192-5900 describe node:

Name:               docker-flags-20200221t162731.120278192-5900

Roles:              master

Labels:             beta.kubernetes.io/arch=amd64

beta.kubernetes.io/os=linux

kubernetes.io/arch=amd64

kubernetes.io/hostname=docker-flags-20200221t162731.120278192-5900

kubernetes.io/os=linux

minikube.k8s.io/commit=4baa941e1b6173be3295a31d4bbce19c721db465

minikube.k8s.io/name=docker-flags-20200221T162731.120278192-5900

minikube.k8s.io/updated_at=2020_02_21T16_29_11_0700

minikube.k8s.io/version=v1.7.3

node-role.kubernetes.io/master=

Annotations:        kubeadm.alpha.kubernetes.io/cri-socket: /var/run/dockershim.sock

node.alpha.kubernetes.io/ttl: 0

volumes.kubernetes.io/controller-managed-attach-detach: true

CreationTimestamp:  Fri, 21 Feb 2020 16:29:06 -0800

Taints:             <none>

Unschedulable:      false

Lease:

HolderIdentity:  docker-flags-20200221t162731.120278192-5900

AcquireTime:     <unset>

RenewTime:       Fri, 21 Feb 2020 16:29:30 -0800

Conditions:

Type             Status  LastHeartbeatTime                 LastTransitionTime                Reason                       Message

----             ------  -----------------                 ------------------                ------                       -------

MemoryPressure   False   Fri, 21 Feb 2020 16:29:21 -0800   Fri, 21 Feb 2020 16:29:04 -0800   KubeletHasSufficientMemory   kubelet has sufficient memory available

DiskPressure     False   Fri, 21 Feb 2020 16:29:21 -0800   Fri, 21 Feb 2020 16:29:04 -0800   KubeletHasNoDiskPressure     kubelet has no disk pressure

PIDPressure      False   Fri, 21 Feb 2020 16:29:21 -0800   Fri, 21 Feb 2020 16:29:04 -0800   KubeletHasSufficientPID      kubelet has sufficient PID available

Ready            True    Fri, 21 Feb 2020 16:29:21 -0800   Fri, 21 Feb 2020 16:29:21 -0800   KubeletReady                 kubelet is posting ready status

Addresses:

InternalIP:  172.17.0.3

Hostname:    docker-flags-20200221t162731.120278192-5900

Capacity:

cpu:                8

ephemeral-storage:  515928484Ki

hugepages-1Gi:      0

hugepages-2Mi:      0

memory:             30887012Ki

pods:               110

Allocatable:

cpu:                8

ephemeral-storage:  475479690068

hugepages-1Gi:      0

hugepages-2Mi:      0

memory:             30784612Ki

pods:               110

System Info:

Machine ID:                 64ab8dd94552469489c2b55e797cdb08

System UUID:                2bb3b5ae-6094-493f-89d7-db30487659ce

Boot ID:                    c3ffdf3d-9c8e-486e-8376-faccf0fe3cdb

Kernel Version:             4.9.0-12-amd64

OS Image:                   Ubuntu 19.10

Operating System:           linux

Architecture:               amd64

Container Runtime Version:  docker://19.3.2

Kubelet Version:            v1.17.3

Kube-Proxy Version:         v1.17.3

PodCIDR:                      10.244.0.0/24

PodCIDRs:                     10.244.0.0/24

Non-terminated Pods:          (8 in total)

Namespace                   Name                                                                   CPU Requests  CPU Limits  Memory Requests  Memory Limits  AGE

---------                   ----                                                                   ------------  ----------  ---------------  -------------  ---

kube-system                 coredns-6955765f44-7kqtk                                               100m (1%)     0 (0%)      70Mi (0%)        170Mi (0%)     15s

kube-system                 coredns-6955765f44-8sfjv                                               100m (1%)     0 (0%)      70Mi (0%)        170Mi (0%)     15s

kube-system                 etcd-docker-flags-20200221t162731.120278192-5900                       0 (0%)        0 (0%)      0 (0%)           0 (0%)         29s

kube-system                 kindnet-q7smz                                                          100m (1%)     100m (1%)   50Mi (0%)        50Mi (0%)      15s

kube-system                 kube-apiserver-docker-flags-20200221t162731.120278192-5900             250m (3%)     0 (0%)      0 (0%)           0 (0%)         29s

kube-system                 kube-controller-manager-docker-flags-20200221t162731.120278192-5900    200m (2%)     0 (0%)      0 (0%)           0 (0%)         29s

kube-system                 kube-proxy-pb9fv                                                       0 (0%)        0 (0%)      0 (0%)           0 (0%)         15s

kube-system                 kube-scheduler-docker-flags-20200221t162731.120278192-5900             100m (1%)     0 (0%)      0 (0%)           0 (0%)         29s

Allocated resources:

(Total limits may be over 100 percent, i.e., overcommitted.)

Resource           Requests    Limits

--------           --------    ------

cpu                850m (10%)  100m (1%)

memory             190Mi (0%)  390Mi (1%)

ephemeral-storage  0 (0%)      0 (0%)

Events:

Type    Reason                   Age                From                                                     Message

----    ------                   ----               ----                                                     -------

Normal  NodeHasSufficientMemory  58s (x6 over 59s)  kubelet, docker-flags-20200221t162731.120278192-5900     Node docker-flags-20200221t162731.120278192-5900 status is now: NodeHasSufficientMemory

Normal  NodeHasNoDiskPressure    58s (x6 over 59s)  kubelet, docker-flags-20200221t162731.120278192-5900     Node docker-flags-20200221t162731.120278192-5900 status is now: NodeHasNoDiskPressure

Normal  NodeHasSufficientPID     58s (x6 over 59s)  kubelet, docker-flags-20200221t162731.120278192-5900     Node docker-flags-20200221t162731.120278192-5900 status is now: NodeHasSufficientPID

Normal  Starting                 31s                kubelet, docker-flags-20200221t162731.120278192-5900     Starting kubelet.

Normal  NodeHasSufficientMemory  30s                kubelet, docker-flags-20200221t162731.120278192-5900     Node docker-flags-20200221t162731.120278192-5900 status is now: NodeHasSufficientMemory

Normal  NodeHasNoDiskPressure    30s                kubelet, docker-flags-20200221t162731.120278192-5900     Node docker-flags-20200221t162731.120278192-5900 status is now: NodeHasNoDiskPressure

Normal  NodeHasSufficientPID     30s                kubelet, docker-flags-20200221t162731.120278192-5900     Node docker-flags-20200221t162731.120278192-5900 status is now: NodeHasSufficientPID

Normal  NodeAllocatableEnforced  30s                kubelet, docker-flags-20200221t162731.120278192-5900     Updated Node Allocatable limit across pods

Normal  NodeReady                20s                kubelet, docker-flags-20200221t162731.120278192-5900     Node docker-flags-20200221t162731.120278192-5900 status is now: NodeReady

Normal  Starting                 14s                kube-proxy, docker-flags-20200221t162731.120278192-5900  Starting kube-proxy.

helpers.go:221: <<< TestDockerFlags FAILED: end of post-mortem logs <<<

helpers.go:160: (dbg) Run:  out/minikube-linux-amd64 delete -p docker-flags-20200221T162731.120278192-5900

helpers.go:160: (dbg) Done: out/minikube-linux-amd64 delete -p docker-flags-20200221T162731.120278192-5900: (1.437728464s)

=== RUN   TestVersionUpgrade

=== PAUSE TestVersionUpgrade

=== CONT  TestVersionUpgrade

--- FAIL: TestVersionUpgrade (281.36s)

version_upgrade_test.go:71: (dbg) Run:  /tmp/minikube-release.257003721.exe start -p vupgrade-20200221T162731.120338915-5900 --kubernetes-version=v1.11.10 --alsologtostderr -v=1 --vm-driver=docker 

version_upgrade_test.go:71: (dbg) Done: /tmp/minikube-release.257003721.exe start -p vupgrade-20200221T162731.120338915-5900 --kubernetes-version=v1.11.10 --alsologtostderr -v=1 --vm-driver=docker : (3m0.338594023s)

version_upgrade_test.go:80: (dbg) Run:  /tmp/minikube-release.257003721.exe stop -p vupgrade-20200221T162731.120338915-5900

version_upgrade_test.go:80: (dbg) Done: /tmp/minikube-release.257003721.exe stop -p vupgrade-20200221T162731.120338915-5900: (10.959377275s)

version_upgrade_test.go:85: (dbg) Run:  /tmp/minikube-release.257003721.exe -p vupgrade-20200221T162731.120338915-5900 status --format={{.Host}}

version_upgrade_test.go:85: (dbg) Non-zero exit: /tmp/minikube-release.257003721.exe -p vupgrade-20200221T162731.120338915-5900 status --format={{.Host}}: exit status 7 (122.262627ms)

-- stdout --

Stopped

-- /stdout --

version_upgrade_test.go:87: status error: exit status 7 (may be ok)

version_upgrade_test.go:95: (dbg) Run:  out/minikube-linux-amd64 start -p vupgrade-20200221T162731.120338915-5900 --kubernetes-version=v1.17.3 --alsologtostderr -v=1 --vm-driver=docker 

version_upgrade_test.go:95: (dbg) Non-zero exit: out/minikube-linux-amd64 start -p vupgrade-20200221T162731.120338915-5900 --kubernetes-version=v1.17.3 --alsologtostderr -v=1 --vm-driver=docker : exit status 70 (1m11.22616596s)

-- stdout --

* [vupgrade-20200221T162731.120338915-5900] minikube v1.7.3 on Debian 9.12

- KUBECONFIG=/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/kubeconfig

- MINIKUBE_BIN=out/minikube-linux-amd64

- MINIKUBE_HOME=/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube

- MINIKUBE_LOCATION=6717

* Using the docker (experimental) driver based on user configuration

* Reconfiguring existing host ...

* Starting existing docker VM for "vupgrade-20200221T162731.120338915-5900" ...

* Preparing Kubernetes v1.17.3 on Docker 19.03.2 ...

- kubeadm.pod-network-cidr=10.244.0.0/16

* Launching Kubernetes ... 

* Problems detected in kube-controller-manager [9884c0bd9187]:

- failed to create listener: failed to listen on 0.0.0.0:10252: listen tcp 0.0.0.0:10252: bind: address already in use

* Problems detected in kube-apiserver [25e9ca5c89a1]:

- Error: failed to create listener: failed to listen on 0.0.0.0:8443: listen tcp 0.0.0.0:8443: bind: address already in use

* Problems detected in kube-scheduler [88c645f7f1e5]:

- failed to create listener: failed to listen on 0.0.0.0:10251: listen tcp 0.0.0.0:10251: bind: address already in use

-- /stdout --

** stderr ** 

I0221 16:30:43.624148   20195 notify.go:125] Checking for updates...

I0221 16:30:43.774777   20195 start.go:249] hostinfo: {"hostname":"kic-integration-slave8","uptime":4398,"bootTime":1582327045,"procs":242,"os":"linux","platform":"debian","platformFamily":"debian","platformVersion":"9.12","kernelVersion":"4.9.0-12-amd64","virtualizationSystem":"kvm","virtualizationRole":"host","hostid":"ae41e7f6-8b8e-4d40-b77d-1ebb5a2d5fdb"}

I0221 16:30:43.775618   20195 start.go:259] virtualization: kvm host

I0221 16:30:43.776246   20195 driver.go:211] Setting default libvirt URI to qemu:///system

I0221 16:30:43.900198   20195 start.go:296] selected driver: docker

I0221 16:30:43.900213   20195 start.go:472] validating driver "docker" against &{Name:vupgrade-20200221T162731.120338915-5900 KeepContext:false EmbedCerts:false MinikubeISO:https://storage.googleapis.com/minikube/iso/minikube-v1.7.3.iso Memory:2000 CPUs:2 DiskSize:20000 Driver:docker HyperkitVpnKitSock: HyperkitVSockPorts:[] DockerEnv:[] InsecureRegistry:[] RegistryMirror:[] HostOnlyCIDR:192.168.99.1/24 HypervVirtualSwitch: HypervUseExternalSwitch:false HypervExternalAdapter: KVMNetwork:default KVMQemuURI:qemu:///system KVMGPU:false KVMHidden:false Downloader:<nil> DockerOpt:[] DisableDriverMounts:false NFSShare:[] NFSSharesRoot:/nfsshares UUID: NoVTXCheck:false DNSProxy:false HostDNSResolver:true HostOnlyNicType:virtio NatNicType:virtio KubernetesConfig:{KubernetesVersion:v1.11.10 ClusterName:vupgrade-20200221T162731.120338915-5900 APIServerName:minikubeCA APIServerNames:[] APIServerIPs:[] DNSDomain:cluster.local ContainerRuntime:docker CRISocket: NetworkPlugin: FeatureGates: ServiceCIDR:10.96.0.0/12

ImageRepository: ExtraOptions:[{Component:kubeadm Key:pod-network-cidr Value:10.244.0.0/16}] ShouldLoadCachedImages:true EnableDefaultCNI:false} Nodes:[{Name:vupgrade-20200221T162731.120338915-5900 IP:172.17.0.6 Port:8443 KubernetesVersion:v1.11.10 ControlPlane:true Worker:true}] Addons:map[default-storageclass:true storage-provisioner:true]}

I0221 16:30:43.900295   20195 start.go:478] status for docker: {Installed:true Healthy:true Error:<nil> Fix: Doc:}

I0221 16:30:43.900910   20195 start.go:860] auto setting extra-config to "kubeadm.pod-network-cidr=10.244.0.0/16".

I0221 16:30:43.901174   20195 profile.go:100] Saving config to /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/profiles/vupgrade-20200221T162731.120338915-5900/config.json ...

I0221 16:30:43.901440   20195 start.go:244] acquiring machines lock for vupgrade-20200221T162731.120338915-5900: {Name:mk88fe798e10191c7698c4f816989eadab63820d Clock:{} Delay:500ms Timeout:15m0s Cancel:<nil>}

I0221 16:30:43.901442   20195 cache.go:91] acquiring lock: {Name:mkdb0e6b8c9c1308a66fcc059b99f67d008724db Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}

I0221 16:30:43.901494   20195 cache.go:91] acquiring lock: {Name:mka61e146096dd5a61ec8feae30a9ff97e270596 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}

I0221 16:30:43.901535   20195 cache.go:91] acquiring lock: {Name:mk86cf48d663eb62ed4df8ddaf4f16b70290f235 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}

I0221 16:30:43.901572   20195 cache.go:91] acquiring lock: {Name:mk3657c5277854a27db750e88cd99b544a4c7fdd Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}

I0221 16:30:43.901623   20195 start.go:248] acquired machines lock for "vupgrade-20200221T162731.120338915-5900" in 149.089µs

I0221 16:30:43.901620   20195 cache.go:91] acquiring lock: {Name:mk811d1e4da8db959175d8d0af21982c5a0582d1 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}

I0221 16:30:43.901651   20195 start.go:84] Skipping create...Using existing machine configuration

I0221 16:30:43.901669   20195 cache.go:99] /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/etcd_3.4.3-0 exists

I0221 16:30:43.901679   20195 cache.go:99] /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-scheduler_v1.17.3 exists

I0221 16:30:43.901695   20195 cache.go:80] cache image "k8s.gcr.io/etcd:3.4.3-0" -> "/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/etcd_3.4.3-0" took 201.18µs

I0221 16:30:43.901706   20195 cache.go:80] cache image "k8s.gcr.io/kube-scheduler:v1.17.3" -> "/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-scheduler_v1.17.3" took 173.805µs

I0221 16:30:43.901710   20195 cache.go:99] /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-apiserver_v1.17.3 exists

I0221 16:30:43.901493   20195 cache.go:91] acquiring lock: {Name:mk5ac0830b02e897c33d1120aa18f80546481d7a Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}

I0221 16:30:43.901739   20195 cache.go:91] acquiring lock: {Name:mkcb7d2cafc6915c86bdae0c7a30271b767095b0 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}

I0221 16:30:43.901829   20195 cache.go:99] /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/coredns_1.6.5 exists

I0221 16:30:43.901847   20195 cache.go:80] cache image "k8s.gcr.io/coredns:1.6.5" -> "/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/coredns_1.6.5" took 397.115µs

I0221 16:30:43.901885   20195 cache.go:99] /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/pause_3.1 exists

I0221 16:30:43.901916   20195 cache.go:80] cache image "k8s.gcr.io/pause:3.1" -> "/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/pause_3.1" took 179.453µs

I0221 16:30:43.901929   20195 cache.go:65] save to tar file k8s.gcr.io/pause:3.1 -> /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/pause_3.1 succeeded

I0221 16:30:43.901683   20195 fix.go:61] fixHost starting: vupgrade-20200221T162731.120338915-5900

I0221 16:30:43.901892   20195 cache.go:65] save to tar file k8s.gcr.io/coredns:1.6.5 -> /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/coredns_1.6.5 succeeded

I0221 16:30:43.901742   20195 cache.go:80] cache image "k8s.gcr.io/kube-apiserver:v1.17.3" -> "/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-apiserver_v1.17.3" took 174.441µs

I0221 16:30:43.902131   20195 cache.go:65] save to tar file k8s.gcr.io/kube-apiserver:v1.17.3 -> /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-apiserver_v1.17.3 succeeded

I0221 16:30:43.901439   20195 cache.go:91] acquiring lock: {Name:mk44c9561e166e21785a4721df933828ea571af8 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}

I0221 16:30:43.902223   20195 cache.go:99] /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/kubernetesui/metrics-scraper_v1.0.2 exists

I0221 16:30:43.902259   20195 cache.go:80] cache image "kubernetesui/metrics-scraper:v1.0.2" -> "/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/kubernetesui/metrics-scraper_v1.0.2" took 826.604µs

I0221 16:30:43.902272   20195 cache.go:65] save to tar file kubernetesui/metrics-scraper:v1.0.2 -> /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/kubernetesui/metrics-scraper_v1.0.2 succeeded

I0221 16:30:43.901713   20195 cache.go:99] /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-proxy_v1.17.3 exists

I0221 16:30:43.902294   20195 cache.go:80] cache image "k8s.gcr.io/kube-proxy:v1.17.3" -> "/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-proxy_v1.17.3" took 859.985µs

I0221 16:30:43.902311   20195 cache.go:65] save to tar file k8s.gcr.io/kube-proxy:v1.17.3 -> /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-proxy_v1.17.3 succeeded

I0221 16:30:43.901708   20195 cache.go:91] acquiring lock: {Name:mk52e42b7368bd673c054e2ccc405e493a6ca9d7 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}

I0221 16:30:43.902375   20195 cache.go:99] /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/gcr.io/k8s-minikube/storage-provisioner_v1.8.1 exists

I0221 16:30:43.902399   20195 cache.go:80] cache image "gcr.io/k8s-minikube/storage-provisioner:v1.8.1" -> "/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/gcr.io/k8s-minikube/storage-provisioner_v1.8.1" took 720.772µs

I0221 16:30:43.902415   20195 cache.go:65] save to tar file gcr.io/k8s-minikube/storage-provisioner:v1.8.1 -> /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/gcr.io/k8s-minikube/storage-provisioner_v1.8.1 succeeded

I0221 16:30:43.901712   20195 cache.go:99] /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-controller-manager_v1.17.3 exists

I0221 16:30:43.902444   20195 cache.go:80] cache image "k8s.gcr.io/kube-controller-manager:v1.17.3" -> "/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-controller-manager_v1.17.3" took 856.005µs

I0221 16:30:43.902458   20195 cache.go:65] save to tar file k8s.gcr.io/kube-controller-manager:v1.17.3 -> /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-controller-manager_v1.17.3 succeeded

I0221 16:30:43.901724   20195 cache.go:65] save to tar file k8s.gcr.io/kube-scheduler:v1.17.3 -> /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-scheduler_v1.17.3 succeeded

I0221 16:30:43.901721   20195 cache.go:65] save to tar file k8s.gcr.io/etcd:3.4.3-0 -> /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/etcd_3.4.3-0 succeeded

I0221 16:30:43.901742   20195 cache.go:91] acquiring lock: {Name:mk0edb0ba952dc44ab773b7cbbf3b90fb552a0bf Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}

I0221 16:30:43.902596   20195 cache.go:99] /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/kubernetesui/dashboard_v2.0.0-beta8 exists

I0221 16:30:43.902619   20195 cache.go:80] cache image "kubernetesui/dashboard:v2.0.0-beta8" -> "/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/kubernetesui/dashboard_v2.0.0-beta8" took 882.398µs

I0221 16:30:43.902629   20195 cache.go:65] save to tar file kubernetesui/dashboard:v2.0.0-beta8 -> /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/kubernetesui/dashboard_v2.0.0-beta8 succeeded

I0221 16:30:43.902643   20195 cache.go:72] Successfully saved all images to host disk.

I0221 16:30:44.519654   20195 start.go:182] post-start starting for "vupgrade-20200221T162731.120338915-5900" (driver="docker")

I0221 16:30:44.519689   20195 start.go:192] creating required directories: [/etc/kubernetes/addons /etc/kubernetes/manifests /var/tmp/minikube /var/lib/minikube /var/lib/minikube/certs /var/lib/minikube/images /var/lib/minikube/binaries /tmp/gvisor /usr/share/ca-certificates /etc/ssl/certs]

I0221 16:30:44.519712   20195 start.go:215] determining appropriate runner for "docker"

I0221 16:30:44.519735   20195 start.go:226] Returning KICRunner for "docker" driver

I0221 16:30:44.943842   20195 filesync.go:118] Scanning /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/addons for local assets ...

I0221 16:30:44.943947   20195 filesync.go:118] Scanning /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/files for local assets ...

I0221 16:30:44.944108   20195 start.go:185] post-start completed in 424.413299ms

I0221 16:30:44.944130   20195 fix.go:141] Configuring auth for driver docker ...

I0221 16:30:44.944180   20195 main.go:110] libmachine: Waiting for SSH to be available...

I0221 16:30:44.944204   20195 main.go:110] libmachine: Getting to WaitForSSH function...

I0221 16:30:45.019625   20195 main.go:110] libmachine: Using SSH client type: native

I0221 16:30:45.019914   20195 main.go:110] libmachine: &{{{<nil> 0 [] [] []} docker [0x7b9a50] 0x7b9a20 <nil>  [] 0s} 127.0.0.1 32806 <nil> <nil>}

I0221 16:30:45.019936   20195 main.go:110] libmachine: About to run SSH command:

exit 0

I0221 16:30:45.020902   20195 main.go:110] libmachine: Error dialing TCP: ssh: handshake failed: read tcp 127.0.0.1:56230->127.0.0.1:32806: read: connection reset by peer

I0221 16:30:48.185986   20195 main.go:110] libmachine: SSH cmd err, output: <nil>: 

I0221 16:30:48.186050   20195 main.go:110] libmachine: Detecting the provisioner...

I0221 16:30:48.247456   20195 main.go:110] libmachine: Using SSH client type: native

I0221 16:30:48.247690   20195 main.go:110] libmachine: &{{{<nil> 0 [] [] []} docker [0x7b9a50] 0x7b9a20 <nil>  [] 0s} 127.0.0.1 32806 <nil> <nil>}

I0221 16:30:48.247706   20195 main.go:110] libmachine: About to run SSH command:

cat /etc/os-release

I0221 16:30:48.370607   20195 main.go:110] libmachine: SSH cmd err, output: <nil>: NAME="Ubuntu"

VERSION="19.10 (Eoan Ermine)"

ID=ubuntu

ID_LIKE=debian

PRETTY_NAME="Ubuntu 19.10"

VERSION_ID="19.10"

HOME_URL="https://www.ubuntu.com/"

SUPPORT_URL="https://help.ubuntu.com/"

BUG_REPORT_URL="https://bugs.launchpad.net/ubuntu/"

PRIVACY_POLICY_URL="https://www.ubuntu.com/legal/terms-and-policies/privacy-policy"

VERSION_CODENAME=eoan

UBUNTU_CODENAME=eoan

I0221 16:30:48.370683   20195 main.go:110] libmachine: Couldn't set key PRIVACY_POLICY_URL, no corresponding struct field found

I0221 16:30:48.370698   20195 main.go:110] libmachine: Couldn't set key VERSION_CODENAME, no corresponding struct field found

I0221 16:30:48.370708   20195 main.go:110] libmachine: Couldn't set key UBUNTU_CODENAME, no corresponding struct field found

I0221 16:30:48.370729   20195 main.go:110] libmachine: found compatible host: ubuntu

I0221 16:30:48.370744   20195 main.go:110] libmachine: No storagedriver specified, using overlay2

I0221 16:30:48.370749   20195 main.go:110] libmachine: setting hostname

I0221 16:30:48.433291   20195 main.go:110] libmachine: Using SSH client type: native

I0221 16:30:48.433515   20195 main.go:110] libmachine: &{{{<nil> 0 [] [] []} docker [0x7b9a50] 0x7b9a20 <nil>  [] 0s} 127.0.0.1 32806 <nil> <nil>}

I0221 16:30:48.433537   20195 main.go:110] libmachine: About to run SSH command:

sudo hostname vupgrade-20200221T162731.120338915-5900 && echo "vupgrade-20200221T162731.120338915-5900" | sudo tee /etc/hostname

I0221 16:30:48.569309   20195 main.go:110] libmachine: SSH cmd err, output: <nil>: vupgrade-20200221T162731.120338915-5900

I0221 16:30:48.629837   20195 main.go:110] libmachine: Using SSH client type: native

I0221 16:30:48.630068   20195 main.go:110] libmachine: &{{{<nil> 0 [] [] []} docker [0x7b9a50] 0x7b9a20 <nil>  [] 0s} 127.0.0.1 32806 <nil> <nil>}

I0221 16:30:48.630208   20195 main.go:110] libmachine: About to run SSH command:

		if ! grep -xq '.*\svupgrade-20200221T162731.120338915-5900' /etc/hosts; then

			if grep -xq '127.0.1.1\s.*' /etc/hosts; then

				sudo sed -i 's/^127.0.1.1\s.*/127.0.1.1 vupgrade-20200221T162731.120338915-5900/g' /etc/hosts;

			else 

				echo '127.0.1.1 vupgrade-20200221T162731.120338915-5900' | sudo tee -a /etc/hosts; 

			fi

		fi

I0221 16:30:48.760928   20195 main.go:110] libmachine: SSH cmd err, output: <nil>: 127.0.1.1 vupgrade-20200221T162731.120338915-5900

I0221 16:30:48.760963   20195 main.go:110] libmachine: installing base packages

I0221 16:30:48.823380   20195 main.go:110] libmachine: Using SSH client type: native

I0221 16:30:48.823622   20195 main.go:110] libmachine: &{{{<nil> 0 [] [] []} docker [0x7b9a50] 0x7b9a20 <nil>  [] 0s} 127.0.0.1 32806 <nil> <nil>}

I0221 16:30:48.823640   20195 main.go:110] libmachine: About to run SSH command:

sudo apt-get update

I0221 16:30:52.985869   20195 main.go:110] libmachine: SSH cmd err, output: <nil>: Get:1 http://security.ubuntu.com/ubuntu eoan-security InRelease [97.5 kB]

Get:2 http://archive.ubuntu.com/ubuntu eoan InRelease [255 kB]

Get:3 http://archive.ubuntu.com/ubuntu eoan-updates InRelease [97.5 kB]

Get:4 http://archive.ubuntu.com/ubuntu eoan-backports InRelease [88.8 kB]

Get:5 http://security.ubuntu.com/ubuntu eoan-security/multiverse amd64 Packages [1079 B]

Get:6 http://security.ubuntu.com/ubuntu eoan-security/universe amd64 Packages [83.5 kB]

Get:7 http://archive.ubuntu.com/ubuntu eoan/main amd64 Packages [1277 kB]

Get:8 http://security.ubuntu.com/ubuntu eoan-security/restricted amd64 Packages [13.4 kB]

Get:9 http://security.ubuntu.com/ubuntu eoan-security/main amd64 Packages [189 kB]

Get:10 http://archive.ubuntu.com/ubuntu eoan/multiverse amd64 Packages [188 kB]

Get:11 http://archive.ubuntu.com/ubuntu eoan/universe amd64 Packages [11.6 MB]

Get:12 http://archive.ubuntu.com/ubuntu eoan/restricted amd64 Packages [22.7 kB]

Get:13 http://archive.ubuntu.com/ubuntu eoan-updates/universe amd64 Packages [131 kB]

Get:14 http://archive.ubuntu.com/ubuntu eoan-updates/multiverse amd64 Packages [1079 B]

Get:15 http://archive.ubuntu.com/ubuntu eoan-updates/main amd64 Packages [285 kB]

Get:16 http://archive.ubuntu.com/ubuntu eoan-updates/restricted amd64 Packages [13.4 kB]

Get:17 http://archive.ubuntu.com/ubuntu eoan-backports/universe amd64 Packages [3078 B]

Fetched 14.4 MB in 2s (5758 kB/s)

Reading package lists...

I0221 16:30:52.985905   20195 main.go:110] libmachine: package: action=install name=curl

I0221 16:30:53.045908   20195 main.go:110] libmachine: Using SSH client type: native

I0221 16:30:53.046138   20195 main.go:110] libmachine: &{{{<nil> 0 [] [] []} docker [0x7b9a50] 0x7b9a20 <nil>  [] 0s} 127.0.0.1 32806 <nil> <nil>}

I0221 16:30:53.046158   20195 main.go:110] libmachine: About to run SSH command:

DEBIAN_FRONTEND=noninteractive sudo -E apt-get install -y  curl

I0221 16:30:54.746663   20195 main.go:110] libmachine: SSH cmd err, output: <nil>: Reading package lists...

Building dependency tree...

Reading state information...

curl is already the newest version (7.65.3-1ubuntu3).

0 upgraded, 0 newly installed, 0 to remove and 28 not upgraded.

I0221 16:30:54.746703   20195 main.go:110] libmachine: Installing Docker...

I0221 16:30:54.807571   20195 main.go:110] libmachine: Using SSH client type: native

I0221 16:30:54.807794   20195 main.go:110] libmachine: &{{{<nil> 0 [] [] []} docker [0x7b9a50] 0x7b9a20 <nil>  [] 0s} 127.0.0.1 32806 <nil> <nil>}

I0221 16:30:54.807812   20195 main.go:110] libmachine: About to run SSH command:

if ! type docker; then curl -sSL https://get.docker.com | sh -; fi

I0221 16:30:54.930374   20195 main.go:110] libmachine: SSH cmd err, output: <nil>: docker is /usr/bin/docker

I0221 16:30:54.930413   20195 main.go:110] libmachine: waiting for docker daemon

I0221 16:30:54.930425   20195 main.go:110] libmachine: checking docker daemon

I0221 16:30:54.992350   20195 main.go:110] libmachine: Using SSH client type: native

I0221 16:30:54.992562   20195 main.go:110] libmachine: &{{{<nil> 0 [] [] []} docker [0x7b9a50] 0x7b9a20 <nil>  [] 0s} 127.0.0.1 32806 <nil> <nil>}

I0221 16:30:54.992578   20195 main.go:110] libmachine: About to run SSH command:

sudo docker version

I0221 16:30:55.186965   20195 main.go:110] libmachine: SSH cmd err, output: <nil>: Client:

Version:           19.03.2

API version:       1.40

Go version:        go1.12.9

Git commit:        6a30dfca03

Built:             Mon Sep 16 03:56:22 2019

OS/Arch:           linux/amd64

Experimental:      false

Server:

Engine:

Version:          19.03.2

API version:      1.40 (minimum version 1.12)

Go version:       go1.12.9

Git commit:       6a30dfca03

Built:            Wed Sep 11 22:45:55 2019

OS/Arch:          linux/amd64

Experimental:     false

containerd:

Version:          v1.3.2

GitCommit:        ff48f57fc83a8c44cf4ad5d672424a98ba37ded6

runc:

Version:          1.0.0-rc9

GitCommit:        

docker-init:

Version:          0.18.0

GitCommit:        

I0221 16:30:55.187007   20195 main.go:110] libmachine: configuring auth

I0221 16:30:55.248825   20195 main.go:110] libmachine: Copying certs to the local machine directory...

I0221 16:30:55.249232   20195 main.go:110] libmachine: generating server cert: /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/machines/server.pem ca-key=/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/certs/ca.pem private-key=/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/certs/ca-key.pem org=jenkins.vupgrade-20200221T162731.120338915-5900 san=[172.17.0.2 localhost]

I0221 16:30:55.757251   20195 main.go:110] libmachine: Using SSH client type: native

I0221 16:30:55.757485   20195 main.go:110] libmachine: &{{{<nil> 0 [] [] []} docker [0x7b9a50] 0x7b9a20 <nil>  [] 0s} 127.0.0.1 32806 <nil> <nil>}

I0221 16:30:55.757509   20195 main.go:110] libmachine: About to run SSH command:

sudo systemctl -f stop docker

I0221 16:30:56.899037   20195 main.go:110] libmachine: SSH cmd err, output: <nil>: 

I0221 16:30:56.961436   20195 main.go:110] libmachine: Using SSH client type: native

I0221 16:30:56.961648   20195 main.go:110] libmachine: &{{{<nil> 0 [] [] []} docker [0x7b9a50] 0x7b9a20 <nil>  [] 0s} 127.0.0.1 32806 <nil> <nil>}

I0221 16:30:56.961667   20195 main.go:110] libmachine: About to run SSH command:

if [ ! -z "$(ip link show docker0)" ]; then sudo ip link delete docker0; fi

I0221 16:30:57.280381   20195 main.go:110] libmachine: SSH cmd err, output: <nil>: 

I0221 16:30:57.280493   20195 main.go:110] libmachine: Copying certs to the remote machine...

I0221 16:30:57.342248   20195 main.go:110] libmachine: Using SSH client type: native

I0221 16:30:57.342468   20195 main.go:110] libmachine: &{{{<nil> 0 [] [] []} docker [0x7b9a50] 0x7b9a20 <nil>  [] 0s} 127.0.0.1 32806 <nil> <nil>}

I0221 16:30:57.342537   20195 main.go:110] libmachine: About to run SSH command:

printf '%s' '-----BEGIN CERTIFICATE-----

MIIC0jCCAbqgAwIBAgIRAJfgafQtSaGNgGUwnglTdvgwDQYJKoZIhvcNAQELBQAw

EjEQMA4GA1UEChMHamVua2luczAeFw0yMDAyMjIwMDA1MDBaFw0yMzAyMDYwMDA1

MDBaMBIxEDAOBgNVBAoTB2plbmtpbnMwggEiMA0GCSqGSIb3DQEBAQUAA4IBDwAw

ggEKAoIBAQCxfk/xTEgJl4nL+8njdhCtxSzW5vz1zKFCoHS34O8ClSVdD5ZVPhgo

aY0uVxD6P50jM2svc4PrH3kSkSJZ/FNifC7J9NNWNySX2yeTPzIysLyYbgnWIsG0

Y889R8u/IcrBd7EU95oBt0GsnAYHSlwc74Ves7kH6YLbvWPFRMhgVkgG0u2Gkw22

ITZ/QCpEotZ/YyWx37sGhIn6N5fqbEd8wPrZWs5VcDac0PdMXFNYK0Je+F/OfkHu

pmwE3r9dmkwv5WfK5irbDBfPhy3qvN1mxWvpIfD/qur2UBXol+oicCMww2329ffI

vfoxdr2cWmmghqZ4uFbeZW+bQKogxwQHAgMBAAGjIzAhMA4GA1UdDwEB/wQEAwIC

rDAPBgNVHRMBAf8EBTADAQH/MA0GCSqGSIb3DQEBCwUAA4IBAQACLENeRaQIPPzX

v3d2rTT/2K2vUZ3mkoeRgRUSaA99gsMr23yyKNtJpP0aTIRpzpWO5ACKdjVU/NjM

y7LiuIMe+0pJJIXHJCX+r9Kv2bRMhVYUYPDupaHvA+nislpqWphv5lviIesU96cn

/9Jp+Jy07s8PudIfTT3+pBbqwGGN4S86chjsIY6idzMmCyrshmpzI3AMb6xvo9qO

dTS/3aWR3MCqOJCCCtGPjPObDXdIBgdcYQUSYdHBETxgkoXBVe6hrBjku0y14f2C

bpDngLpM4pZwlBZ0T5QudXFlLpCXilnl1Z2HEWd0Tkp++77Z9E1gxhJMEsUe/GgI

+wQhOG1+

-----END CERTIFICATE-----

' | sudo tee /etc/docker/ca.pem

I0221 16:30:57.474676   20195 main.go:110] libmachine: SSH cmd err, output: <nil>: -----BEGIN CERTIFICATE-----

MIIC0jCCAbqgAwIBAgIRAJfgafQtSaGNgGUwnglTdvgwDQYJKoZIhvcNAQELBQAw

EjEQMA4GA1UEChMHamVua2luczAeFw0yMDAyMjIwMDA1MDBaFw0yMzAyMDYwMDA1

MDBaMBIxEDAOBgNVBAoTB2plbmtpbnMwggEiMA0GCSqGSIb3DQEBAQUAA4IBDwAw

ggEKAoIBAQCxfk/xTEgJl4nL+8njdhCtxSzW5vz1zKFCoHS34O8ClSVdD5ZVPhgo

aY0uVxD6P50jM2svc4PrH3kSkSJZ/FNifC7J9NNWNySX2yeTPzIysLyYbgnWIsG0

Y889R8u/IcrBd7EU95oBt0GsnAYHSlwc74Ves7kH6YLbvWPFRMhgVkgG0u2Gkw22

ITZ/QCpEotZ/YyWx37sGhIn6N5fqbEd8wPrZWs5VcDac0PdMXFNYK0Je+F/OfkHu

pmwE3r9dmkwv5WfK5irbDBfPhy3qvN1mxWvpIfD/qur2UBXol+oicCMww2329ffI

vfoxdr2cWmmghqZ4uFbeZW+bQKogxwQHAgMBAAGjIzAhMA4GA1UdDwEB/wQEAwIC

rDAPBgNVHRMBAf8EBTADAQH/MA0GCSqGSIb3DQEBCwUAA4IBAQACLENeRaQIPPzX

v3d2rTT/2K2vUZ3mkoeRgRUSaA99gsMr23yyKNtJpP0aTIRpzpWO5ACKdjVU/NjM

y7LiuIMe+0pJJIXHJCX+r9Kv2bRMhVYUYPDupaHvA+nislpqWphv5lviIesU96cn

/9Jp+Jy07s8PudIfTT3+pBbqwGGN4S86chjsIY6idzMmCyrshmpzI3AMb6xvo9qO

dTS/3aWR3MCqOJCCCtGPjPObDXdIBgdcYQUSYdHBETxgkoXBVe6hrBjku0y14f2C

bpDngLpM4pZwlBZ0T5QudXFlLpCXilnl1Z2HEWd0Tkp++77Z9E1gxhJMEsUe/GgI

+wQhOG1+

-----END CERTIFICATE-----

I0221 16:30:57.534740   20195 main.go:110] libmachine: Using SSH client type: native

I0221 16:30:57.534980   20195 main.go:110] libmachine: &{{{<nil> 0 [] [] []} docker [0x7b9a50] 0x7b9a20 <nil>  [] 0s} 127.0.0.1 32806 <nil> <nil>}

I0221 16:30:57.535086   20195 main.go:110] libmachine: About to run SSH command:

printf '%s' '-----BEGIN CERTIFICATE-----

MIIDKDCCAhCgAwIBAgIRAPJo5Oki6HkZMvcVSYhqYsMwDQYJKoZIhvcNAQELBQAw

EjEQMA4GA1UEChMHamVua2luczAeFw0yMDAyMjIwMDI1MDBaFw0yMzAyMDYwMDI1

MDBaMDoxODA2BgNVBAoTL2plbmtpbnMudnVwZ3JhZGUtMjAyMDAyMjFUMTYyNzMx

LjEyMDMzODkxNS01OTAwMIIBIjANBgkqhkiG9w0BAQEFAAOCAQ8AMIIBCgKCAQEA

1gcU3k62SqlcmU9r182z3T6Gmr6Ed68RHJKWFm6XEnAUaWzYYLmTt31YchXazG/t

FbseNsN2Lrr0WwvXaEse82r7nx9tlVhrs8N5dvjOAlTbfnrvj9NZW7Z5Xys52IZI

iq0N6lWNGZrQsnJpXdqVCKMhavQsWNeQIpocvXLPz4sKd18gHnWOmcmo/exqrISl

rEw5tuzicyGJCwO2AJ+n8Ydc2OVzWmAKB+xrU2/16Lant0SWvUKSO0tbBVBfkpGh

Hr1Uk1DTdpAUDxeXfesk7tfudn5egAEmAU2zCZ8cnVlOqf55gCUYz6dVsSyaDhp6

Efw0gktSykyEoXufTQKrwQIDAQABo1EwTzAOBgNVHQ8BAf8EBAMCA6gwEwYDVR0l

BAwwCgYIKwYBBQUHAwEwDAYDVR0TAQH/BAIwADAaBgNVHREEEzARgglsb2NhbGhv

c3SHBKwRAAIwDQYJKoZIhvcNAQELBQADggEBAAJBsFcZj7SEVaui98ViST5HKtAR

c7lfx7C6rUtoDFdKaj8pvR6w0Bwgn0twU1BrfYOCagovqkFtOzjfVZ/NaCAMF0jL

DPZLDhoaBX9rHmZdykx1euS4amuOHl+jd77fuPrc45MVsri54I/97I0tlyh0EA5A

tOuIhxxo4m0P+sr4KJO4zCiwjOwMJRdnosd7sedKqXRbSJmKzgk4xwysPtNlLoAZ

NujPKTTUVtJYmwfQYZ7hZMlDZR17dlflwJf7xLYG9NFCLBdFwgx5TDloewwIlJut

rVlt6OqSJDBhHbPJaHVr7pqULvq5HHPm6btXpdpm2G4gQj/xZXLHZqDh7Qc=

-----END CERTIFICATE-----

' | sudo tee /etc/docker/server.pem

I0221 16:30:57.666953   20195 main.go:110] libmachine: SSH cmd err, output: <nil>: -----BEGIN CERTIFICATE-----

MIIDKDCCAhCgAwIBAgIRAPJo5Oki6HkZMvcVSYhqYsMwDQYJKoZIhvcNAQELBQAw

EjEQMA4GA1UEChMHamVua2luczAeFw0yMDAyMjIwMDI1MDBaFw0yMzAyMDYwMDI1

MDBaMDoxODA2BgNVBAoTL2plbmtpbnMudnVwZ3JhZGUtMjAyMDAyMjFUMTYyNzMx

LjEyMDMzODkxNS01OTAwMIIBIjANBgkqhkiG9w0BAQEFAAOCAQ8AMIIBCgKCAQEA

1gcU3k62SqlcmU9r182z3T6Gmr6Ed68RHJKWFm6XEnAUaWzYYLmTt31YchXazG/t

FbseNsN2Lrr0WwvXaEse82r7nx9tlVhrs8N5dvjOAlTbfnrvj9NZW7Z5Xys52IZI

iq0N6lWNGZrQsnJpXdqVCKMhavQsWNeQIpocvXLPz4sKd18gHnWOmcmo/exqrISl

rEw5tuzicyGJCwO2AJ+n8Ydc2OVzWmAKB+xrU2/16Lant0SWvUKSO0tbBVBfkpGh

Hr1Uk1DTdpAUDxeXfesk7tfudn5egAEmAU2zCZ8cnVlOqf55gCUYz6dVsSyaDhp6

Efw0gktSykyEoXufTQKrwQIDAQABo1EwTzAOBgNVHQ8BAf8EBAMCA6gwEwYDVR0l

BAwwCgYIKwYBBQUHAwEwDAYDVR0TAQH/BAIwADAaBgNVHREEEzARgglsb2NhbGhv

c3SHBKwRAAIwDQYJKoZIhvcNAQELBQADggEBAAJBsFcZj7SEVaui98ViST5HKtAR

c7lfx7C6rUtoDFdKaj8pvR6w0Bwgn0twU1BrfYOCagovqkFtOzjfVZ/NaCAMF0jL

DPZLDhoaBX9rHmZdykx1euS4amuOHl+jd77fuPrc45MVsri54I/97I0tlyh0EA5A

tOuIhxxo4m0P+sr4KJO4zCiwjOwMJRdnosd7sedKqXRbSJmKzgk4xwysPtNlLoAZ

NujPKTTUVtJYmwfQYZ7hZMlDZR17dlflwJf7xLYG9NFCLBdFwgx5TDloewwIlJut

rVlt6OqSJDBhHbPJaHVr7pqULvq5HHPm6btXpdpm2G4gQj/xZXLHZqDh7Qc=

-----END CERTIFICATE-----

I0221 16:30:57.726413   20195 main.go:110] libmachine: Using SSH client type: native

I0221 16:30:57.726665   20195 main.go:110] libmachine: &{{{<nil> 0 [] [] []} docker [0x7b9a50] 0x7b9a20 <nil>  [] 0s} 127.0.0.1 32806 <nil> <nil>}

I0221 16:30:57.726788   20195 main.go:110] libmachine: About to run SSH command:

printf '%s' '-----BEGIN RSA PRIVATE KEY-----

MIIEogIBAAKCAQEA1gcU3k62SqlcmU9r182z3T6Gmr6Ed68RHJKWFm6XEnAUaWzY

YLmTt31YchXazG/tFbseNsN2Lrr0WwvXaEse82r7nx9tlVhrs8N5dvjOAlTbfnrv

j9NZW7Z5Xys52IZIiq0N6lWNGZrQsnJpXdqVCKMhavQsWNeQIpocvXLPz4sKd18g

HnWOmcmo/exqrISlrEw5tuzicyGJCwO2AJ+n8Ydc2OVzWmAKB+xrU2/16Lant0SW

vUKSO0tbBVBfkpGhHr1Uk1DTdpAUDxeXfesk7tfudn5egAEmAU2zCZ8cnVlOqf55

gCUYz6dVsSyaDhp6Efw0gktSykyEoXufTQKrwQIDAQABAoIBACNdZjBZlzt9AqT+

f5ZYEglTxJAbPO49yjkLa6tnOKU+SdElwBczctoV5yBqxg2TzPwTQCnSYFvWXnwQ

19YO251jJxKi8cuEob9BZHepIvk1plMe4yjDxncmDqYQEW3aum/Xqn33BuqdLzDd

QNXWQVv9AI+Yqx8+9z0QdAFF0Fq9lCJyvZgegw0JOkE1r6p/iVQ/TmgOTxOiC94q

WxyRuZBiOynGnPhvauTbPFWG57IZYOFkKEr07V6K9PxtPVvO9FzevliYILX3mwXR

oQMIG4+/jootU5s/vFchIbFd9E1MBl+Z/8bZgS7NHSB5jAJnOU4/6hiES+FgziYr

zY8xNwECgYEA/+E55crk/2zhXymZjhCc+TtMfC7cztuZFQ11hf0J4hvAK/hMC8Ty

Pl2J5m5bMWTy87GA+qC1c92QF8pv7CKDNZSD99f7AFw4w41azEj9Ir6QUM06UxxV

tLCWCOH4vxzLb2wyT8Bu40w1idfGx3faYpH+bThwmw4vratNSKby3vECgYEA1iDS

akWpZrC+CVQZueynuxp8AGawhQTjyX38yyqkf1xp/PykTwtEKEgP5FwUksB+lGW4

CJgE2UEwpcDdPa2/+k6yClx6vlIl7idGShF3cFTxZKWzBE6rSW/7eBK2hPOmlXgV

41QGHLs0bY7eKd4ojZJaxV0KfDdnY3TAfRyHOdECgYAW0CrMTQmbqEZzqI7TNrH4

GoxYKglvu+5rDRckSgoeiaDZirqk9fsvCkHoNICW58wtY+7+6WMkIGXfaSIPaIhQ

N5yIdU4gmxhIfwrQWdWPynOtcI65qDYP9Qp7YkI+L8AHgBsAN0TrqPjBAGbtk8b5

sNCBRl3rxRkFH9e1GYVf0QKBgA4HnIHGCrFlxy3JSt45uUuzEojcMZill18uWA/f

vWNy5Kbkzsc3D8Ir5o6p0ddDsYd7mrFFdJvff5Z8qoJODhQSb+vp30j1DPMrs5lK

x66egip8CNyxYtuu8KUPZNIVPMbyVUzNxpC/W1IKWFgZ7EJKYpQn4nX9E1Ma5TnN

UrbhAoGAZXRoazMpMiTvxPPXiM8G55qIkvi/QTJ+jcqp2hze/RhlOUdDRkPz2gwQ

QRU6ahPBA49pNUl27YDIfxSofZYMDPGx+A/P//U3qkhMWzPqCXX4JDZUNGXMQ28P

dizceDfUpFe3cCaqPwqMAIO8JtjmCHWOI5re6quHOKxuF+1KE5c=

-----END RSA PRIVATE KEY-----

' | sudo tee /etc/docker/server-key.pem

I0221 16:30:57.854759   20195 main.go:110] libmachine: SSH cmd err, output: <nil>: -----BEGIN RSA PRIVATE KEY-----

MIIEogIBAAKCAQEA1gcU3k62SqlcmU9r182z3T6Gmr6Ed68RHJKWFm6XEnAUaWzY

YLmTt31YchXazG/tFbseNsN2Lrr0WwvXaEse82r7nx9tlVhrs8N5dvjOAlTbfnrv

j9NZW7Z5Xys52IZIiq0N6lWNGZrQsnJpXdqVCKMhavQsWNeQIpocvXLPz4sKd18g

HnWOmcmo/exqrISlrEw5tuzicyGJCwO2AJ+n8Ydc2OVzWmAKB+xrU2/16Lant0SW

vUKSO0tbBVBfkpGhHr1Uk1DTdpAUDxeXfesk7tfudn5egAEmAU2zCZ8cnVlOqf55

gCUYz6dVsSyaDhp6Efw0gktSykyEoXufTQKrwQIDAQABAoIBACNdZjBZlzt9AqT+

f5ZYEglTxJAbPO49yjkLa6tnOKU+SdElwBczctoV5yBqxg2TzPwTQCnSYFvWXnwQ

19YO251jJxKi8cuEob9BZHepIvk1plMe4yjDxncmDqYQEW3aum/Xqn33BuqdLzDd

QNXWQVv9AI+Yqx8+9z0QdAFF0Fq9lCJyvZgegw0JOkE1r6p/iVQ/TmgOTxOiC94q

WxyRuZBiOynGnPhvauTbPFWG57IZYOFkKEr07V6K9PxtPVvO9FzevliYILX3mwXR

oQMIG4+/jootU5s/vFchIbFd9E1MBl+Z/8bZgS7NHSB5jAJnOU4/6hiES+FgziYr

zY8xNwECgYEA/+E55crk/2zhXymZjhCc+TtMfC7cztuZFQ11hf0J4hvAK/hMC8Ty

Pl2J5m5bMWTy87GA+qC1c92QF8pv7CKDNZSD99f7AFw4w41azEj9Ir6QUM06UxxV

tLCWCOH4vxzLb2wyT8Bu40w1idfGx3faYpH+bThwmw4vratNSKby3vECgYEA1iDS

akWpZrC+CVQZueynuxp8AGawhQTjyX38yyqkf1xp/PykTwtEKEgP5FwUksB+lGW4

CJgE2UEwpcDdPa2/+k6yClx6vlIl7idGShF3cFTxZKWzBE6rSW/7eBK2hPOmlXgV

41QGHLs0bY7eKd4ojZJaxV0KfDdnY3TAfRyHOdECgYAW0CrMTQmbqEZzqI7TNrH4

GoxYKglvu+5rDRckSgoeiaDZirqk9fsvCkHoNICW58wtY+7+6WMkIGXfaSIPaIhQ

N5yIdU4gmxhIfwrQWdWPynOtcI65qDYP9Qp7YkI+L8AHgBsAN0TrqPjBAGbtk8b5

sNCBRl3rxRkFH9e1GYVf0QKBgA4HnIHGCrFlxy3JSt45uUuzEojcMZill18uWA/f

vWNy5Kbkzsc3D8Ir5o6p0ddDsYd7mrFFdJvff5Z8qoJODhQSb+vp30j1DPMrs5lK

x66egip8CNyxYtuu8KUPZNIVPMbyVUzNxpC/W1IKWFgZ7EJKYpQn4nX9E1Ma5TnN

UrbhAoGAZXRoazMpMiTvxPPXiM8G55qIkvi/QTJ+jcqp2hze/RhlOUdDRkPz2gwQ

QRU6ahPBA49pNUl27YDIfxSofZYMDPGx+A/P//U3qkhMWzPqCXX4JDZUNGXMQ28P

dizceDfUpFe3cCaqPwqMAIO8JtjmCHWOI5re6quHOKxuF+1KE5c=

-----END RSA PRIVATE KEY-----

I0221 16:30:57.971155   20195 main.go:110] libmachine: Using SSH client type: native

I0221 16:30:57.971375   20195 main.go:110] libmachine: &{{{<nil> 0 [] [] []} docker [0x7b9a50] 0x7b9a20 <nil>  [] 0s} 127.0.0.1 32806 <nil> <nil>}

I0221 16:30:57.971391   20195 main.go:110] libmachine: About to run SSH command:

docker --version

I0221 16:30:58.149669   20195 main.go:110] libmachine: SSH cmd err, output: <nil>: Docker version 19.03.2, build 6a30dfca03

I0221 16:30:58.149910   20195 main.go:110] libmachine: Setting Docker configuration on the remote daemon...

I0221 16:30:58.210257   20195 main.go:110] libmachine: Using SSH client type: native

I0221 16:30:58.210464   20195 main.go:110] libmachine: &{{{<nil> 0 [] [] []} docker [0x7b9a50] 0x7b9a20 <nil>  [] 0s} 127.0.0.1 32806 <nil> <nil>}

I0221 16:30:58.210496   20195 main.go:110] libmachine: About to run SSH command:

sudo mkdir -p /etc/systemd/system/docker.service.d && printf %s "[Service]

ExecStart=

ExecStart=/usr/bin/dockerd -H tcp://0.0.0.0:32804 -H unix:///var/run/docker.sock --storage-driver overlay2 --tlsverify --tlscacert /etc/docker/ca.pem --tlscert /etc/docker/server.pem --tlskey /etc/docker/server-key.pem --label provider=docker --insecure-registry 10.96.0.0/12 

Environment=

" | sudo tee /etc/systemd/system/docker.service.d/10-machine.conf

I0221 16:30:58.350521   20195 main.go:110] libmachine: SSH cmd err, output: <nil>: [Service]

ExecStart=

ExecStart=/usr/bin/dockerd -H tcp://0.0.0.0:32804 -H unix:///var/run/docker.sock --storage-driver overlay2 --tlsverify --tlscacert /etc/docker/ca.pem --tlscert /etc/docker/server.pem --tlskey /etc/docker/server-key.pem --label provider=docker --insecure-registry 10.96.0.0/12 

Environment=

I0221 16:30:58.410966   20195 main.go:110] libmachine: Using SSH client type: native

I0221 16:30:58.411196   20195 main.go:110] libmachine: &{{{<nil> 0 [] [] []} docker [0x7b9a50] 0x7b9a20 <nil>  [] 0s} 127.0.0.1 32806 <nil> <nil>}

I0221 16:30:58.411217   20195 main.go:110] libmachine: About to run SSH command:

sudo systemctl daemon-reload

I0221 16:30:58.596346   20195 main.go:110] libmachine: SSH cmd err, output: <nil>: 

I0221 16:30:58.656337   20195 main.go:110] libmachine: Using SSH client type: native

I0221 16:30:58.656546   20195 main.go:110] libmachine: &{{{<nil> 0 [] [] []} docker [0x7b9a50] 0x7b9a20 <nil>  [] 0s} 127.0.0.1 32806 <nil> <nil>}

I0221 16:30:58.656564   20195 main.go:110] libmachine: About to run SSH command:

sudo systemctl -f start docker

I0221 16:30:59.145434   20195 main.go:110] libmachine: SSH cmd err, output: <nil>: 

I0221 16:30:59.207854   20195 main.go:110] libmachine: Using SSH client type: native

I0221 16:30:59.208058   20195 main.go:110] libmachine: &{{{<nil> 0 [] [] []} docker [0x7b9a50] 0x7b9a20 <nil>  [] 0s} 127.0.0.1 32806 <nil> <nil>}

I0221 16:30:59.208110   20195 main.go:110] libmachine: About to run SSH command:

if ! type netstat 1>/dev/null; then ss -tln; else netstat -tln; fi

I0221 16:30:59.361002   20195 main.go:110] libmachine: SSH cmd err, output: <nil>: bash: line 0: type: netstat: not found

State     Recv-Q    Send-Q       Local Address:Port        Peer Address:Port    

LISTEN    0         128              127.0.0.1:36293            0.0.0.0:*       

LISTEN    0         128                0.0.0.0:22               0.0.0.0:*       

LISTEN    0         128                      *:32804                  *:*       

LISTEN    0         128                   [::]:22                  [::]:*       

I0221 16:30:59.361103   20195 main.go:110] libmachine: configuring swarm

I0221 16:30:59.361117   20195 main.go:110] libmachine: enabling docker in systemd

I0221 16:30:59.422040   20195 main.go:110] libmachine: Using SSH client type: native

I0221 16:30:59.422305   20195 main.go:110] libmachine: &{{{<nil> 0 [] [] []} docker [0x7b9a50] 0x7b9a20 <nil>  [] 0s} 127.0.0.1 32806 <nil> <nil>}

I0221 16:30:59.422324   20195 main.go:110] libmachine: About to run SSH command:

sudo systemctl -f enable docker

I0221 16:30:59.602622   20195 main.go:110] libmachine: SSH cmd err, output: <nil>: 

I0221 16:30:59.602654   20195 fix.go:63] fixHost completed within 15.700968623s

I0221 16:30:59.602667   20195 start.go:72] releasing machines lock for "vupgrade-20200221T162731.120338915-5900", held for 15.701029963s

I0221 16:31:00.014128   20195 profile.go:100] Saving config to /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/profiles/vupgrade-20200221T162731.120338915-5900/config.json ...

I0221 16:31:01.716003   20195 settings.go:123] acquiring lock: {Name:mkf6ddac37eb8a790632e2d747057cf61f9c2cae Clock:{} Delay:500ms Timeout:1m0s Cancel:<nil>}

I0221 16:31:01.716171   20195 settings.go:131] Updating kubeconfig:  /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/kubeconfig

I0221 16:31:01.718122   20195 lock.go:35] WriteFile acquiring /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/kubeconfig: {Name:mkbe8729a655040379a7a417b65cc98fdb1ee92c Clock:{} Delay:500ms Timeout:1m0s Cancel:<nil>}

I0221 16:31:01.718803   20195 cache_images.go:65] LoadImages start: [k8s.gcr.io/kube-proxy:v1.17.3 k8s.gcr.io/kube-scheduler:v1.17.3 k8s.gcr.io/kube-controller-manager:v1.17.3 k8s.gcr.io/kube-apiserver:v1.17.3 k8s.gcr.io/coredns:1.6.5 k8s.gcr.io/etcd:3.4.3-0 k8s.gcr.io/pause:3.1 gcr.io/k8s-minikube/storage-provisioner:v1.8.1 kubernetesui/dashboard:v2.0.0-beta8 kubernetesui/metrics-scraper:v1.0.2]

I0221 16:31:01.720840   20195 image.go:43] couldn't find image digest k8s.gcr.io/kube-proxy:v1.17.3 from local daemon: Error response from daemon: client version 1.41 is too new. Maximum supported API version is 1.40 

I0221 16:31:01.720852   20195 image.go:43] couldn't find image digest k8s.gcr.io/kube-scheduler:v1.17.3 from local daemon: Error response from daemon: client version 1.41 is too new. Maximum supported API version is 1.40 

I0221 16:31:01.720880   20195 image.go:73] retrieving image: k8s.gcr.io/kube-proxy:v1.17.3

I0221 16:31:01.720895   20195 image.go:73] retrieving image: k8s.gcr.io/kube-scheduler:v1.17.3

I0221 16:31:01.720903   20195 image.go:43] couldn't find image digest k8s.gcr.io/pause:3.1 from local daemon: Error response from daemon: client version 1.41 is too new. Maximum supported API version is 1.40 

I0221 16:31:01.720909   20195 image.go:43] couldn't find image digest kubernetesui/dashboard:v2.0.0-beta8 from local daemon: Error response from daemon: client version 1.41 is too new. Maximum supported API version is 1.40 

I0221 16:31:01.720927   20195 image.go:73] retrieving image: k8s.gcr.io/pause:3.1

I0221 16:31:01.720941   20195 image.go:73] retrieving image: kubernetesui/dashboard:v2.0.0-beta8

I0221 16:31:01.720840   20195 image.go:43] couldn't find image digest kubernetesui/metrics-scraper:v1.0.2 from local daemon: Error response from daemon: client version 1.41 is too new. Maximum supported API version is 1.40 

I0221 16:31:01.721021   20195 image.go:43] couldn't find image digest k8s.gcr.io/coredns:1.6.5 from local daemon: Error response from daemon: client version 1.41 is too new. Maximum supported API version is 1.40 

I0221 16:31:01.721045   20195 image.go:73] retrieving image: kubernetesui/metrics-scraper:v1.0.2

I0221 16:31:01.721051   20195 image.go:73] retrieving image: k8s.gcr.io/coredns:1.6.5

I0221 16:31:01.721151   20195 image.go:43] couldn't find image digest k8s.gcr.io/etcd:3.4.3-0 from local daemon: Error response from daemon: client version 1.41 is too new. Maximum supported API version is 1.40 

I0221 16:31:01.721182   20195 image.go:73] retrieving image: k8s.gcr.io/etcd:3.4.3-0

I0221 16:31:01.721213   20195 image.go:43] couldn't find image digest gcr.io/k8s-minikube/storage-provisioner:v1.8.1 from local daemon: Error response from daemon: client version 1.41 is too new. Maximum supported API version is 1.40 

I0221 16:31:01.721231   20195 image.go:73] retrieving image: gcr.io/k8s-minikube/storage-provisioner:v1.8.1

I0221 16:31:01.721261   20195 image.go:43] couldn't find image digest k8s.gcr.io/kube-apiserver:v1.17.3 from local daemon: Error response from daemon: client version 1.41 is too new. Maximum supported API version is 1.40 

I0221 16:31:01.721283   20195 image.go:73] retrieving image: k8s.gcr.io/kube-apiserver:v1.17.3

I0221 16:31:01.722147   20195 image.go:43] couldn't find image digest k8s.gcr.io/kube-controller-manager:v1.17.3 from local daemon: Error response from daemon: client version 1.41 is too new. Maximum supported API version is 1.40 

I0221 16:31:01.722177   20195 image.go:73] retrieving image: k8s.gcr.io/kube-controller-manager:v1.17.3

I0221 16:31:01.722194   20195 image.go:81] daemon lookup for kubernetesui/dashboard:v2.0.0-beta8: Error response from daemon: reference does not exist

I0221 16:31:01.722338   20195 image.go:81] daemon lookup for k8s.gcr.io/coredns:1.6.5: Error response from daemon: reference does not exist

I0221 16:31:01.722515   20195 image.go:81] daemon lookup for k8s.gcr.io/kube-apiserver:v1.17.3: Error response from daemon: reference does not exist

I0221 16:31:01.723001   20195 image.go:81] daemon lookup for k8s.gcr.io/etcd:3.4.3-0: Error response from daemon: reference does not exist

I0221 16:31:01.723017   20195 image.go:81] daemon lookup for k8s.gcr.io/kube-proxy:v1.17.3: Error response from daemon: reference does not exist

I0221 16:31:01.723002   20195 image.go:81] daemon lookup for kubernetesui/metrics-scraper:v1.0.2: Error response from daemon: reference does not exist

I0221 16:31:01.723060   20195 image.go:81] daemon lookup for k8s.gcr.io/kube-scheduler:v1.17.3: Error response from daemon: reference does not exist

I0221 16:31:01.723005   20195 image.go:81] daemon lookup for k8s.gcr.io/pause:3.1: Error response from daemon: reference does not exist

I0221 16:31:01.723403   20195 image.go:81] daemon lookup for k8s.gcr.io/kube-controller-manager:v1.17.3: Error response from daemon: reference does not exist

I0221 16:31:01.723463   20195 image.go:81] daemon lookup for gcr.io/k8s-minikube/storage-provisioner:v1.8.1: Error response from daemon: reference does not exist

I0221 16:31:02.328817   20195 cache_images.go:91] "k8s.gcr.io/kube-scheduler:v1.17.3" needs transfer: "k8s.gcr.io/kube-scheduler:v1.17.3" does not exist at hash "d109c0821a2b9225b69b99a95000df5cd1de5d606bc187b3620d730d7769c6ad" in container runtime

I0221 16:31:02.328854   20195 cache_images.go:177] Loading image from cache: /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-scheduler_v1.17.3

I0221 16:31:02.658033   20195 cache_images.go:91] "k8s.gcr.io/kube-apiserver:v1.17.3" needs transfer: "k8s.gcr.io/kube-apiserver:v1.17.3" does not exist at hash "90d27391b7808cde8d9a81cfa43b1e81de5c4912b4b52a7dccb19eb4fe3c236b" in container runtime

I0221 16:31:02.658077   20195 cache_images.go:177] Loading image from cache: /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-apiserver_v1.17.3

I0221 16:31:02.670650   20195 cache_images.go:91] "k8s.gcr.io/etcd:3.4.3-0" needs transfer: "k8s.gcr.io/etcd:3.4.3-0" does not exist at hash "303ce5db0e90dab1c5728ec70d21091201a23cdf8aeca70ab54943bbaaf0833f" in container runtime

I0221 16:31:02.670692   20195 cache_images.go:177] Loading image from cache: /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/etcd_3.4.3-0

I0221 16:31:02.714579   20195 cache_images.go:91] "k8s.gcr.io/coredns:1.6.5" needs transfer: "k8s.gcr.io/coredns:1.6.5" does not exist at hash "70f311871ae12c14bd0e02028f249f933f925e4370744e4e35f706da773a8f61" in container runtime

I0221 16:31:02.714631   20195 cache_images.go:177] Loading image from cache: /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/coredns_1.6.5

I0221 16:31:02.765647   20195 cache_images.go:91] "k8s.gcr.io/kube-controller-manager:v1.17.3" needs transfer: "k8s.gcr.io/kube-controller-manager:v1.17.3" does not exist at hash "b0f1517c1f4bb153597033d2efd81a9ac630e6a569307f993b2c0368afcf0302" in container runtime

I0221 16:31:02.765689   20195 cache_images.go:177] Loading image from cache: /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-controller-manager_v1.17.3

I0221 16:31:02.807810   20195 cache_images.go:91] "k8s.gcr.io/kube-proxy:v1.17.3" needs transfer: "k8s.gcr.io/kube-proxy:v1.17.3" does not exist at hash "ae853e93800dc2572aeb425e5765cf9b25212bfc43695299e61dece06cffa4a1" in container runtime

I0221 16:31:02.807854   20195 cache_images.go:177] Loading image from cache: /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-proxy_v1.17.3

I0221 16:31:02.881828   20195 docker.go:121] Loading image: /var/lib/minikube/images/kube-scheduler_v1.17.3

I0221 16:31:07.217243   20195 kic_runner.go:117] Done: [docker exec --privileged vupgrade-20200221T162731.120338915-5900 docker load -i /var/lib/minikube/images/kube-scheduler_v1.17.3]: (4.335298538s)

I0221 16:31:07.217305   20195 cache_images.go:199] Transferred and loaded /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-scheduler_v1.17.3 from cache

I0221 16:31:07.217329   20195 docker.go:121] Loading image: /var/lib/minikube/images/kube-apiserver_v1.17.3

I0221 16:31:09.322426   20195 kic_runner.go:117] Done: [docker exec --privileged vupgrade-20200221T162731.120338915-5900 docker load -i /var/lib/minikube/images/kube-apiserver_v1.17.3]: (2.104997811s)

I0221 16:31:09.322483   20195 cache_images.go:199] Transferred and loaded /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-apiserver_v1.17.3 from cache

I0221 16:31:09.322518   20195 docker.go:121] Loading image: /var/lib/minikube/images/etcd_3.4.3-0

I0221 16:31:13.211889   20195 kic_runner.go:117] Done: [docker exec --privileged vupgrade-20200221T162731.120338915-5900 docker load -i /var/lib/minikube/images/etcd_3.4.3-0]: (3.889272837s)

I0221 16:31:13.211934   20195 cache_images.go:199] Transferred and loaded /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/etcd_3.4.3-0 from cache

I0221 16:31:13.211959   20195 docker.go:121] Loading image: /var/lib/minikube/images/coredns_1.6.5

I0221 16:31:14.319620   20195 kic_runner.go:117] Done: [docker exec --privileged vupgrade-20200221T162731.120338915-5900 docker load -i /var/lib/minikube/images/coredns_1.6.5]: (1.107571134s)

I0221 16:31:14.319673   20195 cache_images.go:199] Transferred and loaded /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/coredns_1.6.5 from cache

I0221 16:31:14.319704   20195 docker.go:121] Loading image: /var/lib/minikube/images/kube-controller-manager_v1.17.3

I0221 16:31:16.123520   20195 kic_runner.go:117] Done: [docker exec --privileged vupgrade-20200221T162731.120338915-5900 docker load -i /var/lib/minikube/images/kube-controller-manager_v1.17.3]: (1.803727669s)

I0221 16:31:16.123568   20195 cache_images.go:199] Transferred and loaded /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-controller-manager_v1.17.3 from cache

I0221 16:31:16.123595   20195 docker.go:121] Loading image: /var/lib/minikube/images/kube-proxy_v1.17.3

I0221 16:31:18.202975   20195 kic_runner.go:117] Done: [docker exec --privileged vupgrade-20200221T162731.120338915-5900 docker load -i /var/lib/minikube/images/kube-proxy_v1.17.3]: (2.079236096s)

I0221 16:31:18.203033   20195 cache_images.go:199] Transferred and loaded /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-proxy_v1.17.3 from cache

I0221 16:31:18.203058   20195 cache_images.go:98] Successfully loaded all cached images

I0221 16:31:18.203067   20195 cache_images.go:69] LoadImages completed in 16.484237721s

I0221 16:31:18.203128   20195 kubeadm.go:119] kubeadm options: {CertDir:/var/lib/minikube/certs ServiceCIDR:10.96.0.0/12 PodSubnet:10.244.0.0/16 AdvertiseAddress:172.17.0.2 APIServerPort:8443 KubernetesVersion:v1.17.3 EtcdDataDir:/var/lib/minikube/etcd ClusterName:vupgrade-20200221T162731.120338915-5900 NodeName:vupgrade-20200221T162731.120338915-5900 DNSDomain:cluster.local CRISocket: ImageRepository: ComponentOptions:[{Component:apiServer ExtraArgs:map[enable-admission-plugins:NamespaceLifecycle,LimitRanger,ServiceAccount,DefaultStorageClass,DefaultTolerationSeconds,NodeRestriction,MutatingAdmissionWebhook,ValidatingAdmissionWebhook,ResourceQuota] Pairs:map[certSANs:["127.0.0.1", "localhost", "172.17.0.2"]]}] FeatureArgs:map[] NoTaintMaster:true}

I0221 16:31:18.203285   20195 kubeadm.go:123] kubeadm config:

apiVersion: kubeadm.k8s.io/v1beta2

kind: InitConfiguration

localAPIEndpoint:

advertiseAddress: 172.17.0.2

bindPort: 8443

bootstrapTokens:

- groups:

- system:bootstrappers:kubeadm:default-node-token

ttl: 24h0m0s

usages:

- signing

- authentication

nodeRegistration:

criSocket: /var/run/dockershim.sock

name: "vupgrade-20200221T162731.120338915-5900"

taints: []

---

apiVersion: kubeadm.k8s.io/v1beta2

kind: ClusterConfiguration

apiServer:

certSANs: ["127.0.0.1", "localhost", "172.17.0.2"]

extraArgs:

enable-admission-plugins: "NamespaceLifecycle,LimitRanger,ServiceAccount,DefaultStorageClass,DefaultTolerationSeconds,NodeRestriction,MutatingAdmissionWebhook,ValidatingAdmissionWebhook,ResourceQuota"

certificatesDir: /var/lib/minikube/certs

clusterName: kubernetes

controlPlaneEndpoint: localhost:8443

controllerManager: {}

dns:

type: CoreDNS

etcd:

local:

dataDir: /var/lib/minikube/etcd

kubernetesVersion: v1.17.3

networking:

dnsDomain: cluster.local

podSubnet: "10.244.0.0/16"

serviceSubnet: 10.96.0.0/12

I0221 16:31:18.529082   20195 kubeadm.go:435] kubelet [Unit]

Wants=docker.socket

[Service]

ExecStart=

ExecStart=/var/lib/minikube/binaries/v1.17.3/kubelet --authorization-mode=Webhook --bootstrap-kubeconfig=/etc/kubernetes/bootstrap-kubelet.conf --cgroup-driver=cgroupfs --client-ca-file=/var/lib/minikube/certs/ca.crt --cluster-domain=cluster.local --config=/var/lib/kubelet/config.yaml --container-runtime=docker --fail-swap-on=false --hostname-override=vupgrade-20200221T162731.120338915-5900 --kubeconfig=/etc/kubernetes/kubelet.conf --node-ip=172.17.0.2 --pod-manifest-path=/etc/kubernetes/manifests

[Install]

config:

{KubernetesVersion:v1.17.3 ClusterName:vupgrade-20200221T162731.120338915-5900 APIServerName:minikubeCA APIServerNames:[] APIServerIPs:[] DNSDomain:cluster.local ContainerRuntime:docker CRISocket: NetworkPlugin: FeatureGates: ServiceCIDR:10.96.0.0/12 ImageRepository: ExtraOptions:[{Component:kubeadm Key:pod-network-cidr Value:10.244.0.0/16}] ShouldLoadCachedImages:true EnableDefaultCNI:false}

W0221 16:31:18.694936   20195 kubeadm.go:440] unable to stop kubelet: /bin/bash -c "pgrep kubelet && sudo systemctl stop kubelet": exit status 1

stdout:

stderr:

command: "/bin/bash -c \"pgrep kubelet && sudo systemctl stop kubelet\"" output: ""

I0221 16:31:18.876882   20195 cache_binaries.go:93] Not caching binary, using https://storage.googleapis.com/kubernetes-release/release/v1.17.3/bin/linux/amd64/kubectl

I0221 16:31:18.876898   20195 cache_binaries.go:93] Not caching binary, using https://storage.googleapis.com/kubernetes-release/release/v1.17.3/bin/linux/amd64/kubeadm

I0221 16:31:18.876884   20195 cache_binaries.go:93] Not caching binary, using https://storage.googleapis.com/kubernetes-release/release/v1.17.3/bin/linux/amd64/kubelet

I0221 16:31:22.042936   20195 certs.go:59] Setting up /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube for IP: 172.17.0.2

I0221 16:31:22.042994   20195 certs.go:68] acquiring lock: {Name:mk1ca5ebf71cde36c7cf1834112cd97439b48ee9 Clock:{} Delay:500ms Timeout:1m0s Cancel:<nil>}

I0221 16:31:22.043210   20195 crypto.go:69] Generating cert /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/client.crt with IP's: []

I0221 16:31:22.045876   20195 crypto.go:157] Writing cert to /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/client.crt ...

I0221 16:31:22.045903   20195 lock.go:35] WriteFile acquiring /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/client.crt: {Name:mk483ef20e4c00fd8b12fc17791bb0af3060177f Clock:{} Delay:500ms Timeout:1m0s Cancel:<nil>}

I0221 16:31:22.046136   20195 crypto.go:165] Writing key to /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/client.key ...

I0221 16:31:22.046155   20195 lock.go:35] WriteFile acquiring /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/client.key: {Name:mk4df06cfc023cd15d844e9a51cf3dab1070fdce Clock:{} Delay:500ms Timeout:1m0s Cancel:<nil>}

I0221 16:31:22.046269   20195 crypto.go:69] Generating cert /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/apiserver.crt with IP's: [172.17.0.2 10.96.0.1 127.0.0.1 10.0.0.1]

I0221 16:31:22.048812   20195 crypto.go:157] Writing cert to /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/apiserver.crt ...

I0221 16:31:22.048831   20195 lock.go:35] WriteFile acquiring /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/apiserver.crt: {Name:mkd821b8505afab46c4584e54787fce831fd1e66 Clock:{} Delay:500ms Timeout:1m0s Cancel:<nil>}

I0221 16:31:22.048972   20195 crypto.go:165] Writing key to /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/apiserver.key ...

I0221 16:31:22.048987   20195 lock.go:35] WriteFile acquiring /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/apiserver.key: {Name:mk3b45b74c702216fba4222fa8acfdf5f8bb7bf6 Clock:{} Delay:500ms Timeout:1m0s Cancel:<nil>}

I0221 16:31:22.049087   20195 crypto.go:69] Generating cert /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/proxy-client.crt with IP's: []

I0221 16:31:22.052264   20195 crypto.go:157] Writing cert to /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/proxy-client.crt ...

I0221 16:31:22.052289   20195 lock.go:35] WriteFile acquiring /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/proxy-client.crt: {Name:mkc4443396d09eaa8b729b4e96f86e49a4b60cbf Clock:{} Delay:500ms Timeout:1m0s Cancel:<nil>}

I0221 16:31:22.052455   20195 crypto.go:165] Writing key to /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/proxy-client.key ...

I0221 16:31:22.052473   20195 lock.go:35] WriteFile acquiring /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/proxy-client.key: {Name:mk8fcec9ec1139758fa264f712d46d6005cea676 Clock:{} Delay:500ms Timeout:1m0s Cancel:<nil>}

I0221 16:31:26.947740   20195 kubeadm.go:303] restartCluster start

I0221 16:31:27.137480   20195 kubeadm.go:140] /data/minikube skipping compat symlinks: sudo test -d /data/minikube: exit status 1

stdout:

stderr:

I0221 16:31:28.550246   20195 kic_runner.go:117] Done: [docker exec --privileged vupgrade-20200221T162731.120338915-5900 /bin/bash -c sudo env PATH=/var/lib/minikube/binaries/v1.17.3:$PATH kubeadm init phase kubeconfig all --config /var/tmp/minikube/kubeadm.yaml]: (1.170373984s)

I0221 16:31:29.137384   20195 kverify.go:42] waiting for apiserver process to appear ...

I0221 16:31:29.314515   20195 kverify.go:56] duration metric: took 177.131193ms to wait for apiserver process to appear ...

I0221 16:31:29.384592   20195 kapi.go:58] client config for vupgrade-20200221T162731.120338915-5900: &rest.Config{Host:"https://127.0.0.1:32804", APIPath:"", ContentConfig:rest.ContentConfig{AcceptContentTypes:"", ContentType:"", GroupVersion:(*schema.GroupVersion)(nil), NegotiatedSerializer:runtime.NegotiatedSerializer(nil)}, Username:"", Password:"", BearerToken:"", BearerTokenFile:"", Impersonate:rest.ImpersonationConfig{UserName:"", Groups:[]string(nil), Extra:map[string][]string(nil)}, AuthProvider:<nil>, AuthConfigPersister:rest.AuthProviderConfigPersister(nil), ExecProvider:<nil>, TLSClientConfig:rest.sanitizedTLSClientConfig{Insecure:false, ServerName:"", CertFile:"/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/client.crt", KeyFile:"/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/client.key", CAFile:"/home/jenkins/minikube-integration/linux-amd64-docker-6717-33

24-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/ca.crt", CertData:[]uint8(nil), KeyData:[]uint8(nil), CAData:[]uint8(nil), NextProtos:[]string(nil)}, UserAgent:"", DisableCompression:false, Transport:http.RoundTripper(nil), WrapTransport:(transport.WrapperFunc)(0x14c98b0), QPS:0, Burst:0, RateLimiter:flowcontrol.RateLimiter(nil), Timeout:0, Dial:(func(context.Context, string, string) (net.Conn, error))(nil)}

I0221 16:31:29.387428   20195 kverify.go:72] waiting for kube-system pods to appear ...

I0221 16:31:38.824526   20195 kverify.go:84] 5 kube-system pods found

I0221 16:31:38.824571   20195 kverify.go:93] duration metric: took 9.437115255s to wait for pod list to return data ...

I0221 16:31:49.687867   20195 kubeadm.go:307] restartCluster took 22.740085866s

I0221 16:31:49.901127   20195 logs.go:177] 4 containers: [97628069d7fa 25e9ca5c89a1 2fbd7002922a ba2a49e01c07]

I0221 16:31:50.108811   20195 logs.go:177] 0 containers: []

W0221 16:31:50.108850   20195 logs.go:179] No container was found matching "coredns"

I0221 16:31:50.316373   20195 logs.go:177] 3 containers: [88c645f7f1e5 2cde2c131b01 c3c1ffc35a2a]

I0221 16:31:50.541159   20195 logs.go:177] 1 containers: [8828b286aa71]

I0221 16:31:50.746014   20195 logs.go:177] 0 containers: []

W0221 16:31:50.746085   20195 logs.go:179] No container was found matching "kubernetes-dashboard"

I0221 16:31:50.975409   20195 logs.go:177] 1 containers: [94a4d7f1a115]

I0221 16:31:51.229466   20195 logs.go:177] 3 containers: [9884c0bd9187 f2f27f2bf9cc b4ef8101082a]

I0221 16:31:51.229528   20195 logs.go:91] Gathering logs for kube-proxy [8828b286aa71] ...

I0221 16:31:51.478510   20195 logs.go:91] Gathering logs for storage-provisioner [94a4d7f1a115] ...

I0221 16:31:51.687899   20195 logs.go:91] Gathering logs for dmesg ...

I0221 16:31:51.863928   20195 logs.go:91] Gathering logs for Docker ...

I0221 16:31:52.044407   20195 logs.go:91] Gathering logs for kube-controller-manager [9884c0bd9187] ...

W0221 16:31:52.282814   20195 logs.go:106] Found kube-controller-manager [9884c0bd9187] problem: failed to create listener: failed to listen on 0.0.0.0:10252: listen tcp 0.0.0.0:10252: bind: address already in use

I0221 16:31:52.282856   20195 logs.go:91] Gathering logs for kube-controller-manager [b4ef8101082a] ...

I0221 16:31:52.530073   20195 logs.go:91] Gathering logs for container status ...

I0221 16:31:52.777837   20195 logs.go:91] Gathering logs for kube-apiserver [97628069d7fa] ...

I0221 16:31:52.986646   20195 logs.go:91] Gathering logs for kube-apiserver [25e9ca5c89a1] ...

W0221 16:31:53.200351   20195 logs.go:106] Found kube-apiserver [25e9ca5c89a1] problem: Error: failed to create listener: failed to listen on 0.0.0.0:8443: listen tcp 0.0.0.0:8443: bind: address already in use

I0221 16:31:53.215992   20195 logs.go:91] Gathering logs for kube-apiserver [ba2a49e01c07] ...

I0221 16:31:53.464609   20195 logs.go:91] Gathering logs for kube-scheduler [88c645f7f1e5] ...

W0221 16:31:53.672010   20195 logs.go:106] Found kube-scheduler [88c645f7f1e5] problem: failed to create listener: failed to listen on 0.0.0.0:10251: listen tcp 0.0.0.0:10251: bind: address already in use

I0221 16:31:53.672046   20195 logs.go:91] Gathering logs for kube-controller-manager [f2f27f2bf9cc] ...

I0221 16:31:53.878700   20195 logs.go:91] Gathering logs for kubelet ...

I0221 16:31:54.101026   20195 logs.go:91] Gathering logs for kube-apiserver [2fbd7002922a] ...

I0221 16:31:54.350202   20195 logs.go:91] Gathering logs for kube-scheduler [2cde2c131b01] ...

I0221 16:31:54.570446   20195 logs.go:91] Gathering logs for kube-scheduler [c3c1ffc35a2a] ...

W0221 16:31:54.797642   20195 exit.go:101] Error starting cluster: addon phase cmd:"/bin/bash -c \"sudo env PATH=/var/lib/minikube/binaries/v1.17.3:$PATH kubeadm init phase addon all --config /var/tmp/minikube/kubeadm.yaml\"": /bin/bash -c "sudo env PATH=/var/lib/minikube/binaries/v1.17.3:$PATH kubeadm init phase addon all --config /var/tmp/minikube/kubeadm.yaml": exit status 1

stdout:

stderr:

W0222 00:31:39.603973    4440 validation.go:28] Cannot validate kube-proxy config - no validator is available

W0222 00:31:39.604096    4440 validation.go:28] Cannot validate kubelet config - no validator is available

error execution phase addon/coredns: unable to create configmap: Post https://localhost:8443/api/v1/namespaces/kube-system/configmaps?timeout=10s: context deadline exceeded

To see the stack trace of this error execute with --v=5 or higher

* 

X Error starting cluster: addon phase cmd:"/bin/bash -c \"sudo env PATH=/var/lib/minikube/binaries/v1.17.3:$PATH kubeadm init phase addon all --config /var/tmp/minikube/kubeadm.yaml\"": /bin/bash -c "sudo env PATH=/var/lib/minikube/binaries/v1.17.3:$PATH kubeadm init phase addon all --config /var/tmp/minikube/kubeadm.yaml": exit status 1

stdout:

stderr:

W0222 00:31:39.603973    4440 validation.go:28] Cannot validate kube-proxy config - no validator is available

W0222 00:31:39.604096    4440 validation.go:28] Cannot validate kubelet config - no validator is available

error execution phase addon/coredns: unable to create configmap: Post https://localhost:8443/api/v1/namespaces/kube-system/configmaps?timeout=10s: context deadline exceeded

To see the stack trace of this error execute with --v=5 or higher

* 

* minikube is exiting due to an error. If the above message is not useful, open an issue:

- https://github.com/kubernetes/minikube/issues/new/choose

** /stderr **

version_upgrade_test.go:97: [out/minikube-linux-amd64 start -p vupgrade-20200221T162731.120338915-5900 --kubernetes-version=v1.17.3 --alsologtostderr -v=1 --vm-driver=docker ] failed: exit status 70

version_upgrade_test.go:100: (dbg) Run:  kubectl --context vupgrade-20200221T162731.120338915-5900 version --output=json

version_upgrade_test.go:100: (dbg) Non-zero exit: kubectl --context vupgrade-20200221T162731.120338915-5900 version --output=json: exit status 1 (9.460371785s)

-- stdout --

{

"clientVersion": {

"major": "1",

"minor": "17",

"gitVersion": "v1.17.3",

"gitCommit": "06ad960bfd03b39c8310aaf92d1e7c12ce618213",

"gitTreeState": "clean",

"buildDate": "2020-02-11T18:14:22Z",

"goVersion": "go1.13.6",

"compiler": "gc",

"platform": "linux/amd64"

}

}

-- /stdout --

** stderr ** 

Unable to connect to the server: EOF

** /stderr **

version_upgrade_test.go:102: error running kubectl: exit status 1

panic.go:563: *** TestVersionUpgrade FAILED at 2020-02-21 16:32:04.271266935 -0800 PST m=+1314.813392451

helpers.go:188: (dbg) Run:  out/minikube-linux-amd64 status --format={{.Host}} -p vupgrade-20200221T162731.120338915-5900

helpers.go:188: (dbg) Non-zero exit: out/minikube-linux-amd64 status --format={{.Host}} -p vupgrade-20200221T162731.120338915-5900: exit status 2 (562.275002ms)

-- stdout --

Running

-- /stdout --

helpers.go:188: status error: exit status 2 (may be ok)

helpers.go:194: <<< TestVersionUpgrade FAILED: start of post-mortem logs <<<

helpers.go:195: (dbg) Run:  out/minikube-linux-amd64 -p vupgrade-20200221T162731.120338915-5900 logs --problems

helpers.go:195: (dbg) Done: out/minikube-linux-amd64 -p vupgrade-20200221T162731.120338915-5900 logs --problems: (5.47110605s)

helpers.go:200: TestVersionUpgrade logs: * Problems detected in kube-controller-manager [9884c0bd9187]:

- failed to create listener: failed to listen on 0.0.0.0:10252: listen tcp 0.0.0.0:10252: bind: address already in use

* Problems detected in kube-scheduler [88c645f7f1e5]:

- failed to create listener: failed to listen on 0.0.0.0:10251: listen tcp 0.0.0.0:10251: bind: address already in use

helpers.go:202: (dbg) Run:  out/minikube-linux-amd64 status --format={{.APIServer}} -p vupgrade-20200221T162731.120338915-5900

helpers.go:202: (dbg) Non-zero exit: out/minikube-linux-amd64 status --format={{.APIServer}} -p vupgrade-20200221T162731.120338915-5900: exit status 2 (496.269741ms)

-- stdout --

Stopped

-- /stdout --

helpers.go:202: status error: exit status 2 (may be ok)

helpers.go:204: "vupgrade-20200221T162731.120338915-5900" apiserver is not running, skipping kubectl commands (state="Stopped")

helpers.go:160: (dbg) Run:  out/minikube-linux-amd64 delete -p vupgrade-20200221T162731.120338915-5900

helpers.go:160: (dbg) Done: out/minikube-linux-amd64 delete -p vupgrade-20200221T162731.120338915-5900: (1.683203549s)

=== RUN   TestStartStop/group/newest-cni

=== PAUSE TestStartStop/group/newest-cni

=== CONT  TestStartStop/group/newest-cni

--- FAIL: TestStartStop/group/newest-cni (192.71s)

start_stop_delete_test.go:93: (dbg) Run:  out/minikube-linux-amd64 start -p newest-cni-20200221T162731.120714771-5900 --alsologtostderr -v=3 --wait=true --feature-gates ServerSideApply=true --network-plugin=cni --extra-config=kubelet.network-plugin=cni --extra-config=kubeadm.pod-network-cidr=192.168.111.111/16 --vm-driver=docker  --kubernetes-version=v1.17.3

start_stop_delete_test.go:93: (dbg) Done: out/minikube-linux-amd64 start -p newest-cni-20200221T162731.120714771-5900 --alsologtostderr -v=3 --wait=true --feature-gates ServerSideApply=true --network-plugin=cni --extra-config=kubelet.network-plugin=cni --extra-config=kubeadm.pod-network-cidr=192.168.111.111/16 --vm-driver=docker  --kubernetes-version=v1.17.3: (2m8.361885867s)

start_stop_delete_test.go:102: (dbg) Run:  out/minikube-linux-amd64 stop -p newest-cni-20200221T162731.120714771-5900 --alsologtostderr -v=3

start_stop_delete_test.go:102: (dbg) Done: out/minikube-linux-amd64 stop -p newest-cni-20200221T162731.120714771-5900 --alsologtostderr -v=3: (2.31002825s)

start_stop_delete_test.go:109: (dbg) Run:  out/minikube-linux-amd64 status --format={{.Host}} -p newest-cni-20200221T162731.120714771-5900

start_stop_delete_test.go:109: (dbg) Non-zero exit: out/minikube-linux-amd64 status --format={{.Host}} -p newest-cni-20200221T162731.120714771-5900: exit status 7 (105.323226ms)

-- stdout --

Stopped

-- /stdout --

start_stop_delete_test.go:109: status error: exit status 7 (may be ok)

start_stop_delete_test.go:116: (dbg) Run:  out/minikube-linux-amd64 addons enable dashboard -p newest-cni-20200221T162731.120714771-5900

start_stop_delete_test.go:121: (dbg) Run:  out/minikube-linux-amd64 start -p newest-cni-20200221T162731.120714771-5900 --alsologtostderr -v=3 --wait=true --feature-gates ServerSideApply=true --network-plugin=cni --extra-config=kubelet.network-plugin=cni --extra-config=kubeadm.pod-network-cidr=192.168.111.111/16 --vm-driver=docker  --kubernetes-version=v1.17.3

start_stop_delete_test.go:121: (dbg) Done: out/minikube-linux-amd64 start -p newest-cni-20200221T162731.120714771-5900 --alsologtostderr -v=3 --wait=true --feature-gates ServerSideApply=true --network-plugin=cni --extra-config=kubelet.network-plugin=cni --extra-config=kubeadm.pod-network-cidr=192.168.111.111/16 --vm-driver=docker  --kubernetes-version=v1.17.3: (54.092278209s)

start_stop_delete_test.go:128: WARNING: cni mode requires additional setup before pods can schedule :(

start_stop_delete_test.go:138: (dbg) Run:  out/minikube-linux-amd64 status --format={{.Host}} -p newest-cni-20200221T162731.120714771-5900

start_stop_delete_test.go:138: (dbg) Non-zero exit: out/minikube-linux-amd64 status --format={{.Host}} -p newest-cni-20200221T162731.120714771-5900: exit status 2 (499.71485ms)

-- stdout --

Running

-- /stdout --

start_stop_delete_test.go:138: status error: exit status 2 (may be ok)

start_stop_delete_test.go:144: (dbg) Run:  out/minikube-linux-amd64 ssh -p newest-cni-20200221T162731.120714771-5900 "sudo crictl images -o json"

start_stop_delete_test.go:144: Found non-minikube image: busybox:latest

start_stop_delete_test.go:144: Found non-minikube image: k8s.gcr.io/pause:latest

start_stop_delete_test.go:147: (dbg) Run:  out/minikube-linux-amd64 pause -p newest-cni-20200221T162731.120714771-5900 --alsologtostderr -v=1

start_stop_delete_test.go:147: (dbg) Done: out/minikube-linux-amd64 pause -p newest-cni-20200221T162731.120714771-5900 --alsologtostderr -v=1: (1.101958164s)

start_stop_delete_test.go:147: (dbg) Run:  out/minikube-linux-amd64 status --format={{.APIServer}} -p newest-cni-20200221T162731.120714771-5900

start_stop_delete_test.go:147: (dbg) Non-zero exit: out/minikube-linux-amd64 status --format={{.APIServer}} -p newest-cni-20200221T162731.120714771-5900: exit status 2 (503.202673ms)

-- stdout --

Stopped

-- /stdout --

start_stop_delete_test.go:147: status error: exit status 2 (may be ok)

start_stop_delete_test.go:147: post-pause apiserver status = "Stopped"; want = "Paused"

start_stop_delete_test.go:147: (dbg) Run:  out/minikube-linux-amd64 status --format={{.Kubelet}} -p newest-cni-20200221T162731.120714771-5900

start_stop_delete_test.go:147: (dbg) Non-zero exit: out/minikube-linux-amd64 status --format={{.Kubelet}} -p newest-cni-20200221T162731.120714771-5900: exit status 2 (556.756622ms)

-- stdout --

Stopped

-- /stdout --

start_stop_delete_test.go:147: status error: exit status 2 (may be ok)

start_stop_delete_test.go:147: (dbg) Run:  out/minikube-linux-amd64 unpause -p newest-cni-20200221T162731.120714771-5900 --alsologtostderr -v=1

start_stop_delete_test.go:147: (dbg) Done: out/minikube-linux-amd64 unpause -p newest-cni-20200221T162731.120714771-5900 --alsologtostderr -v=1: (1.072813071s)

start_stop_delete_test.go:147: (dbg) Run:  out/minikube-linux-amd64 status --format={{.APIServer}} -p newest-cni-20200221T162731.120714771-5900

start_stop_delete_test.go:147: (dbg) Non-zero exit: out/minikube-linux-amd64 status --format={{.APIServer}} -p newest-cni-20200221T162731.120714771-5900: exit status 2 (668.294264ms)

-- stdout --

Stopped

-- /stdout --

start_stop_delete_test.go:147: status error: exit status 2 (may be ok)

start_stop_delete_test.go:147: post-unpause apiserver status = "Stopped"; want = "Running"

start_stop_delete_test.go:147: (dbg) Run:  out/minikube-linux-amd64 status --format={{.Kubelet}} -p newest-cni-20200221T162731.120714771-5900

start_stop_delete_test.go:147: (dbg) Non-zero exit: out/minikube-linux-amd64 status --format={{.Kubelet}} -p newest-cni-20200221T162731.120714771-5900: exit status 2 (604.919313ms)

-- stdout --

Running

-- /stdout --

start_stop_delete_test.go:147: status error: exit status 2 (may be ok)

start_stop_delete_test.go:151: (dbg) Run:  out/minikube-linux-amd64 delete -p newest-cni-20200221T162731.120714771-5900

start_stop_delete_test.go:151: (dbg) Done: out/minikube-linux-amd64 delete -p newest-cni-20200221T162731.120714771-5900: (1.84171504s)

start_stop_delete_test.go:156: (dbg) Run:  kubectl config get-contexts newest-cni-20200221T162731.120714771-5900

start_stop_delete_test.go:156: (dbg) Non-zero exit: kubectl config get-contexts newest-cni-20200221T162731.120714771-5900: exit status 1 (78.670307ms)

-- stdout --

CURRENT   NAME   CLUSTER   AUTHINFO   NAMESPACE

-- /stdout --

** stderr ** 

error: context newest-cni-20200221T162731.120714771-5900 not found

** /stderr **

start_stop_delete_test.go:158: config context error: exit status 1 (may be ok)

start_stop_delete_test.go:164: *** TestStartStop/group/newest-cni FAILED at 2020-02-21 16:30:43.379599485 -0800 PST m=+1233.921724968

helpers.go:188: (dbg) Run:  out/minikube-linux-amd64 status --format={{.Host}} -p newest-cni-20200221T162731.120714771-5900

helpers.go:188: (dbg) Non-zero exit: out/minikube-linux-amd64 status --format={{.Host}} -p newest-cni-20200221T162731.120714771-5900: exit status 7 (52.772708ms)

-- stdout --

Nonexistent

-- /stdout --

** stderr ** 

E0221 16:30:43.430272   20110 status.go:98] The "newest-cni-20200221T162731.120714771-5900" cluster does not exist!

** /stderr **

helpers.go:188: status error: exit status 7 (may be ok)

helpers.go:190: "newest-cni-20200221T162731.120714771-5900" host is not running, skipping log retrieval (state="Nonexistent")

helpers.go:160: (dbg) Run:  out/minikube-linux-amd64 delete -p newest-cni-20200221T162731.120714771-5900

=== RUN   TestStartStop/group/containerd

=== PAUSE TestStartStop/group/containerd

=== CONT  TestStartStop/group/containerd

--- FAIL: TestStartStop/group/containerd (39.08s)

start_stop_delete_test.go:93: (dbg) Run:  out/minikube-linux-amd64 start -p containerd-20200221T162731.120625703-5900 --alsologtostderr -v=3 --wait=true --container-runtime=containerd --docker-opt containerd=/var/run/containerd/containerd.sock --apiserver-port=8444 --vm-driver=docker  --kubernetes-version=v1.17.3

start_stop_delete_test.go:93: (dbg) Non-zero exit: out/minikube-linux-amd64 start -p containerd-20200221T162731.120625703-5900 --alsologtostderr -v=3 --wait=true --container-runtime=containerd --docker-opt containerd=/var/run/containerd/containerd.sock --apiserver-port=8444 --vm-driver=docker  --kubernetes-version=v1.17.3: exit status 70 (36.961919891s)

-- stdout --

* [containerd-20200221T162731.120625703-5900] minikube v1.7.3 on Debian 9.12

- KUBECONFIG=/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/kubeconfig

- MINIKUBE_BIN=out/minikube-linux-amd64

- MINIKUBE_HOME=/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube

- MINIKUBE_LOCATION=6717

* Using the docker (experimental) driver based on user configuration

* Creating Kubernetes in docker container with (CPUs=2), Memory=2000MB (30163MB available) ...

* Preparing Kubernetes v1.17.3 on containerd 1.3.2 ...

- opt containerd=/var/run/containerd/containerd.sock

-- /stdout --

** stderr ** 

I0221 16:27:31.178897    5058 notify.go:125] Checking for updates...

I0221 16:27:31.426178    5058 start.go:249] hostinfo: {"hostname":"kic-integration-slave8","uptime":4206,"bootTime":1582327045,"procs":246,"os":"linux","platform":"debian","platformFamily":"debian","platformVersion":"9.12","kernelVersion":"4.9.0-12-amd64","virtualizationSystem":"kvm","virtualizationRole":"host","hostid":"ae41e7f6-8b8e-4d40-b77d-1ebb5a2d5fdb"}

I0221 16:27:31.427152    5058 start.go:259] virtualization: kvm host

I0221 16:27:31.427485    5058 driver.go:211] Setting default libvirt URI to qemu:///system

I0221 16:27:31.588525    5058 start.go:296] selected driver: docker

I0221 16:27:31.588541    5058 start.go:472] validating driver "docker" against <nil>

I0221 16:27:31.588554    5058 start.go:478] status for docker: {Installed:true Healthy:true Error:<nil> Fix: Doc:}

I0221 16:27:31.588580    5058 start.go:860] auto setting extra-config to "kubeadm.pod-network-cidr=10.244.0.0/16".

I0221 16:27:31.589155    5058 profile.go:100] Saving config to /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/profiles/containerd-20200221T162731.120625703-5900/config.json ...

I0221 16:27:31.589284    5058 lock.go:35] WriteFile acquiring /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/profiles/containerd-20200221T162731.120625703-5900/config.json: {Name:mk1952fbb356887cb291f49a125b898c77bb70b4 Clock:{} Delay:500ms Timeout:1m0s Cancel:<nil>}

I0221 16:27:31.589571    5058 start.go:244] acquiring machines lock for containerd-20200221T162731.120625703-5900: {Name:mk88fe798e10191c7698c4f816989eadab63820d Clock:{} Delay:500ms Timeout:15m0s Cancel:<nil>}

I0221 16:27:31.589808    5058 cache.go:91] acquiring lock: {Name:mk44c9561e166e21785a4721df933828ea571af8 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}

I0221 16:27:31.589936    5058 cache.go:99] /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/kubernetesui/metrics-scraper_v1.0.2 exists

I0221 16:27:31.589962    5058 cache.go:80] cache image "kubernetesui/metrics-scraper:v1.0.2" -> "/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/kubernetesui/metrics-scraper_v1.0.2" took 160.243µs

I0221 16:27:31.589978    5058 cache.go:65] save to tar file kubernetesui/metrics-scraper:v1.0.2 -> /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/kubernetesui/metrics-scraper_v1.0.2 succeeded

I0221 16:27:31.589998    5058 cache.go:91] acquiring lock: {Name:mkdb0e6b8c9c1308a66fcc059b99f67d008724db Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}

I0221 16:27:31.590087    5058 cache.go:99] /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-proxy_v1.17.3 exists

I0221 16:27:31.590120    5058 cache.go:80] cache image "k8s.gcr.io/kube-proxy:v1.17.3" -> "/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-proxy_v1.17.3" took 124.274µs

I0221 16:27:31.590135    5058 cache.go:65] save to tar file k8s.gcr.io/kube-proxy:v1.17.3 -> /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-proxy_v1.17.3 succeeded

I0221 16:27:31.590159    5058 cache.go:91] acquiring lock: {Name:mk86cf48d663eb62ed4df8ddaf4f16b70290f235 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}

I0221 16:27:31.590227    5058 cache.go:99] /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-scheduler_v1.17.3 exists

I0221 16:27:31.590241    5058 cache.go:80] cache image "k8s.gcr.io/kube-scheduler:v1.17.3" -> "/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-scheduler_v1.17.3" took 85.396µs

I0221 16:27:31.590255    5058 cache.go:65] save to tar file k8s.gcr.io/kube-scheduler:v1.17.3 -> /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-scheduler_v1.17.3 succeeded

I0221 16:27:31.590271    5058 cache.go:91] acquiring lock: {Name:mk811d1e4da8db959175d8d0af21982c5a0582d1 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}

I0221 16:27:31.590330    5058 cache.go:99] /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-controller-manager_v1.17.3 exists

I0221 16:27:31.590342    5058 cache.go:80] cache image "k8s.gcr.io/kube-controller-manager:v1.17.3" -> "/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-controller-manager_v1.17.3" took 73.608µs

I0221 16:27:31.590355    5058 cache.go:65] save to tar file k8s.gcr.io/kube-controller-manager:v1.17.3 -> /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-controller-manager_v1.17.3 succeeded

I0221 16:27:31.590370    5058 cache.go:91] acquiring lock: {Name:mk3657c5277854a27db750e88cd99b544a4c7fdd Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}

I0221 16:27:31.590428    5058 cache.go:99] /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-apiserver_v1.17.3 exists

I0221 16:27:31.590439    5058 cache.go:80] cache image "k8s.gcr.io/kube-apiserver:v1.17.3" -> "/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-apiserver_v1.17.3" took 71.566µs

I0221 16:27:31.590453    5058 cache.go:65] save to tar file k8s.gcr.io/kube-apiserver:v1.17.3 -> /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-apiserver_v1.17.3 succeeded

I0221 16:27:31.590468    5058 cache.go:91] acquiring lock: {Name:mk5ac0830b02e897c33d1120aa18f80546481d7a Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}

I0221 16:27:31.590524    5058 cache.go:99] /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/coredns_1.6.5 exists

I0221 16:27:31.590536    5058 cache.go:80] cache image "k8s.gcr.io/coredns:1.6.5" -> "/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/coredns_1.6.5" took 70.409µs

I0221 16:27:31.590548    5058 cache.go:65] save to tar file k8s.gcr.io/coredns:1.6.5 -> /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/coredns_1.6.5 succeeded

I0221 16:27:31.590567    5058 cache.go:91] acquiring lock: {Name:mka61e146096dd5a61ec8feae30a9ff97e270596 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}

I0221 16:27:31.590624    5058 cache.go:99] /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/etcd_3.4.3-0 exists

I0221 16:27:31.590636    5058 cache.go:80] cache image "k8s.gcr.io/etcd:3.4.3-0" -> "/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/etcd_3.4.3-0" took 75.751µs

I0221 16:27:31.590647    5058 cache.go:65] save to tar file k8s.gcr.io/etcd:3.4.3-0 -> /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/etcd_3.4.3-0 succeeded

I0221 16:27:31.590661    5058 cache.go:91] acquiring lock: {Name:mkcb7d2cafc6915c86bdae0c7a30271b767095b0 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}

I0221 16:27:31.590716    5058 cache.go:99] /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/pause_3.1 exists

I0221 16:27:31.590727    5058 cache.go:80] cache image "k8s.gcr.io/pause:3.1" -> "/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/pause_3.1" took 69.202µs

I0221 16:27:31.590738    5058 cache.go:65] save to tar file k8s.gcr.io/pause:3.1 -> /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/pause_3.1 succeeded

I0221 16:27:31.590752    5058 cache.go:91] acquiring lock: {Name:mk52e42b7368bd673c054e2ccc405e493a6ca9d7 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}

I0221 16:27:31.590839    5058 cache.go:99] /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/gcr.io/k8s-minikube/storage-provisioner_v1.8.1 exists

I0221 16:27:31.590851    5058 cache.go:80] cache image "gcr.io/k8s-minikube/storage-provisioner:v1.8.1" -> "/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/gcr.io/k8s-minikube/storage-provisioner_v1.8.1" took 101.687µs

I0221 16:27:31.590863    5058 cache.go:65] save to tar file gcr.io/k8s-minikube/storage-provisioner:v1.8.1 -> /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/gcr.io/k8s-minikube/storage-provisioner_v1.8.1 succeeded

I0221 16:27:31.590878    5058 cache.go:91] acquiring lock: {Name:mk0edb0ba952dc44ab773b7cbbf3b90fb552a0bf Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}

I0221 16:27:31.590939    5058 cache.go:99] /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/kubernetesui/dashboard_v2.0.0-beta8 exists

I0221 16:27:31.590951    5058 cache.go:80] cache image "kubernetesui/dashboard:v2.0.0-beta8" -> "/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/kubernetesui/dashboard_v2.0.0-beta8" took 75.367µs

I0221 16:27:31.590967    5058 cache.go:65] save to tar file kubernetesui/dashboard:v2.0.0-beta8 -> /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/kubernetesui/dashboard_v2.0.0-beta8 succeeded

I0221 16:27:31.590975    5058 cache.go:72] Successfully saved all images to host disk.

I0221 16:27:53.498789    5058 start.go:248] acquired machines lock for "containerd-20200221T162731.120625703-5900" in 21.909185362s

I0221 16:27:53.498842    5058 start.go:81] Provisioning new machine with config: {Name:containerd-20200221T162731.120625703-5900 KeepContext:false EmbedCerts:false MinikubeISO:https://storage.googleapis.com/minikube/iso/minikube-v1.7.3.iso Memory:2000 CPUs:2 DiskSize:20000 Driver:docker HyperkitVpnKitSock: HyperkitVSockPorts:[] DockerEnv:[] InsecureRegistry:[] RegistryMirror:[] HostOnlyCIDR:192.168.99.1/24 HypervVirtualSwitch: HypervUseExternalSwitch:false HypervExternalAdapter: KVMNetwork:default KVMQemuURI:qemu:///system KVMGPU:false KVMHidden:false Downloader:{} DockerOpt:[containerd=/var/run/containerd/containerd.sock] DisableDriverMounts:false NFSShare:[] NFSSharesRoot:/nfsshares UUID: NoVTXCheck:false DNSProxy:false HostDNSResolver:true HostOnlyNicType:virtio NatNicType:virtio KubernetesConfig:{KubernetesVersion:v1.17.3 ClusterName:containerd-20200221T162731.120625703-5900 APIServerName:minikubeCA APIServerNames:[] APIServerIPs:[] DNSDomain:cluster.local ContainerRuntime:containerd CRISo

cket: NetworkPlugin:cni FeatureGates: ServiceCIDR:10.96.0.0/12 ImageRepository: ExtraOptions:[{Component:kubeadm Key:pod-network-cidr Value:10.244.0.0/16}] ShouldLoadCachedImages:true EnableDefaultCNI:true} Nodes:[{Name:containerd-20200221T162731.120625703-5900 IP: Port:8444 KubernetesVersion:v1.17.3 ControlPlane:true Worker:true}] Addons:map[]}

I0221 16:27:53.498948    5058 start.go:100] createHost starting for "containerd-20200221T162731.120625703-5900" (driver="docker")

I0221 16:27:53.500179    5058 start.go:136] libmachine.API.Create for "containerd-20200221T162731.120625703-5900" (driver="docker")

I0221 16:27:53.500293    5058 main.go:110] libmachine: Reading certificate data from /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/certs/ca.pem

I0221 16:27:53.500337    5058 main.go:110] libmachine: Decoding PEM data...

I0221 16:27:53.500361    5058 main.go:110] libmachine: Parsing certificate...

I0221 16:27:53.500568    5058 main.go:110] libmachine: Reading certificate data from /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/certs/cert.pem

I0221 16:27:53.500611    5058 main.go:110] libmachine: Decoding PEM data...

I0221 16:27:53.500699    5058 main.go:110] libmachine: Parsing certificate...

I0221 16:27:53.579336    5058 oci.go:105] Successfully created a docker volume containerd-20200221T162731.120625703-5900

I0221 16:27:54.413466    5058 kic.go:105] Creating ssh key for kic: /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/machines/containerd-20200221T162731.120625703-5900/id_rsa...

I0221 16:27:57.502673    5058 main.go:110] libmachine: provisioning hostname "containerd-20200221T162731.120625703-5900"

I0221 16:27:57.599935    5058 main.go:110] libmachine: Using SSH client type: native

I0221 16:27:57.600253    5058 main.go:110] libmachine: &{{{<nil> 0 [] [] []} docker [0x7b9a50] 0x7b9a20 <nil>  [] 0s} 127.0.0.1 32794 <nil> <nil>}

I0221 16:27:57.600284    5058 main.go:110] libmachine: About to run SSH command:

sudo hostname containerd-20200221T162731.120625703-5900 && echo "containerd-20200221T162731.120625703-5900" | sudo tee /etc/hostname

I0221 16:27:57.792885    5058 main.go:110] libmachine: SSH cmd err, output: <nil>: containerd-20200221T162731.120625703-5900

I0221 16:27:57.885369    5058 main.go:110] libmachine: Using SSH client type: native

I0221 16:27:57.885655    5058 main.go:110] libmachine: &{{{<nil> 0 [] [] []} docker [0x7b9a50] 0x7b9a20 <nil>  [] 0s} 127.0.0.1 32794 <nil> <nil>}

I0221 16:27:57.885698    5058 main.go:110] libmachine: About to run SSH command:

		if ! grep -xq '.*\scontainerd-20200221T162731.120625703-5900' /etc/hosts; then

			if grep -xq '127.0.1.1\s.*' /etc/hosts; then

				sudo sed -i 's/^127.0.1.1\s.*/127.0.1.1 containerd-20200221T162731.120625703-5900/g' /etc/hosts;

			else 

				echo '127.0.1.1 containerd-20200221T162731.120625703-5900' | sudo tee -a /etc/hosts; 

			fi

		fi

I0221 16:27:58.061027    5058 main.go:110] libmachine: SSH cmd err, output: <nil>: 127.0.1.1 containerd-20200221T162731.120625703-5900

I0221 16:27:58.061199    5058 main.go:110] libmachine: set auth options {CertDir:/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube CaCertPath:/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/certs/ca.pem CaPrivateKeyPath:/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/certs/ca-key.pem CaCertRemotePath:/etc/docker/ca.pem ServerCertPath:/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/machines/server.pem ServerKeyPath:/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/machines/server-key.pem ClientKeyPath:/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/certs/key.pem ServerCertRemotePath:/etc/docker/server.pe

m ServerKeyRemotePath:/etc/docker/server-key.pem ClientCertPath:/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/certs/cert.pem ServerCertSANs:[] StorePath:/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube}

I0221 16:27:58.061220    5058 main.go:110] libmachine: setting up certificates

I0221 16:27:58.061245    5058 main.go:110] libmachine: configureAuth start

I0221 16:27:58.141446    5058 main.go:110] libmachine: copyHostCerts

I0221 16:27:58.141881    5058 main.go:110] libmachine: generating server cert: /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/machines/server.pem ca-key=/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/certs/ca.pem private-key=/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/certs/ca-key.pem org=jenkins.containerd-20200221T162731.120625703-5900 san=[172.17.0.6 localhost 127.0.0.1]

I0221 16:27:58.599966    5058 main.go:110] libmachine: copyRemoteCerts

I0221 16:27:58.765808    5058 ssh_runner.go:101] Run: sudo mkdir -p /etc/docker /etc/docker /etc/docker

I0221 16:27:58.858851    5058 ssh_runner.go:155] Checked if /etc/docker/ca.pem exists, but got error: Process exited with status 1

I0221 16:27:58.859180    5058 ssh_runner.go:174] Transferring 1038 bytes to /etc/docker/ca.pem

I0221 16:27:58.860042    5058 ssh_runner.go:193] ca.pem: copied 1038 bytes

I0221 16:27:58.898255    5058 ssh_runner.go:155] Checked if /etc/docker/server.pem exists, but got error: Process exited with status 1

I0221 16:27:58.901566    5058 ssh_runner.go:174] Transferring 1168 bytes to /etc/docker/server.pem

I0221 16:27:58.902782    5058 ssh_runner.go:193] server.pem: copied 1168 bytes

I0221 16:27:58.948263    5058 ssh_runner.go:155] Checked if /etc/docker/server-key.pem exists, but got error: Process exited with status 1

I0221 16:27:58.948618    5058 ssh_runner.go:174] Transferring 1675 bytes to /etc/docker/server-key.pem

I0221 16:27:58.949524    5058 ssh_runner.go:193] server-key.pem: copied 1675 bytes

I0221 16:27:58.978983    5058 main.go:110] libmachine: configureAuth took 917.612044ms

I0221 16:27:58.979029    5058 main.go:110] libmachine: setting minikube options for container-runtime

I0221 16:27:58.979239    5058 start.go:141] libmachine.API.Create for "containerd-20200221T162731.120625703-5900" took 5.479058268s

I0221 16:27:58.979258    5058 start.go:182] post-start starting for "containerd-20200221T162731.120625703-5900" (driver="docker")

I0221 16:27:58.979264    5058 start.go:192] creating required directories: [/etc/kubernetes/addons /etc/kubernetes/manifests /var/tmp/minikube /var/lib/minikube /var/lib/minikube/certs /var/lib/minikube/images /var/lib/minikube/binaries /tmp/gvisor /usr/share/ca-certificates /etc/ssl/certs]

I0221 16:27:58.979281    5058 start.go:215] determining appropriate runner for "docker"

I0221 16:27:58.979292    5058 start.go:226] Returning KICRunner for "docker" driver

I0221 16:27:59.252847    5058 filesync.go:118] Scanning /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/addons for local assets ...

I0221 16:27:59.253055    5058 filesync.go:118] Scanning /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/files for local assets ...

I0221 16:27:59.253272    5058 filesync.go:141] local asset: /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/files/etc/test/nested/copy/5900/hosts -> hosts in /etc/test/nested/copy/5900

I0221 16:27:59.957478    5058 start.go:185] post-start completed in 978.192409ms

I0221 16:27:59.957849    5058 start.go:103] createHost completed in 6.45888584s

I0221 16:27:59.957868    5058 start.go:72] releasing machines lock for "containerd-20200221T162731.120625703-5900", held for 6.459045675s

I0221 16:28:00.680394    5058 profile.go:100] Saving config to /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/profiles/containerd-20200221T162731.120625703-5900/config.json ...

I0221 16:28:05.357220    5058 kic_runner.go:117] Done: [docker exec --privileged containerd-20200221T162731.120625703-5900 systemctl is-active --quiet service docker]: (4.411379534s)

W0221 16:28:08.078470    5058 exit.go:101] Failed to get driver URL: api host port binding: get host-bind port 8444 for "containerd-20200221T162731.120625703-5900", output 

Template parsing error: template: :1:4: executing "" at <index (index .NetworkSettings.Ports "8444/tcp") 0>: error calling index: index of untyped nil

: exit status 1

* 

X Failed to get driver URL: api host port binding: get host-bind port 8444 for "containerd-20200221T162731.120625703-5900", output 

Template parsing error: template: :1:4: executing "" at <index (index .NetworkSettings.Ports "8444/tcp") 0>: error calling index: index of untyped nil

: exit status 1

* 

* minikube is exiting due to an error. If the above message is not useful, open an issue:

- https://github.com/kubernetes/minikube/issues/new/choose

** /stderr **

start_stop_delete_test.go:95: [out/minikube-linux-amd64 start -p containerd-20200221T162731.120625703-5900 --alsologtostderr -v=3 --wait=true --container-runtime=containerd --docker-opt containerd=/var/run/containerd/containerd.sock --apiserver-port=8444 --vm-driver=docker  --kubernetes-version=v1.17.3] failed: exit status 70

panic.go:563: *** TestStartStop/group/containerd FAILED at 2020-02-21 16:28:08.08283271 -0800 PST m=+1078.624958263

helpers.go:188: (dbg) Run:  out/minikube-linux-amd64 status --format={{.Host}} -p containerd-20200221T162731.120625703-5900

helpers.go:188: (dbg) Non-zero exit: out/minikube-linux-amd64 status --format={{.Host}} -p containerd-20200221T162731.120625703-5900: exit status 6 (779.916775ms)

-- stdout --

Running

WARNING: Your kubectl is pointing to stale minikube-vm.

To fix the kubectl context, run `minikube update-context`

-- /stdout --

helpers.go:188: status error: exit status 6 (may be ok)

helpers.go:190: "containerd-20200221T162731.120625703-5900" host is not running, skipping log retrieval (state="Running\nWARNING: Your kubectl is pointing to stale minikube-vm.\nTo fix the kubectl context, run `minikube update-context`")

helpers.go:160: (dbg) Run:  out/minikube-linux-amd64 delete -p containerd-20200221T162731.120625703-5900

helpers.go:160: (dbg) Done: out/minikube-linux-amd64 delete -p containerd-20200221T162731.120625703-5900: (1.33668922s)

=== RUN   TestStartStop/group/crio

=== PAUSE TestStartStop/group/crio

=== CONT  TestStartStop/group/crio

--- FAIL: TestStartStop/group/crio (28.46s)

start_stop_delete_test.go:93: (dbg) Run:  out/minikube-linux-amd64 start -p crio-20200221T162731.120843736-5900 --alsologtostderr -v=3 --wait=true --container-runtime=crio --disable-driver-mounts --extra-config=kubeadm.ignore-preflight-errors=SystemVerification --vm-driver=docker  --kubernetes-version=v1.15.7

start_stop_delete_test.go:93: (dbg) Non-zero exit: out/minikube-linux-amd64 start -p crio-20200221T162731.120843736-5900 --alsologtostderr -v=3 --wait=true --container-runtime=crio --disable-driver-mounts --extra-config=kubeadm.ignore-preflight-errors=SystemVerification --vm-driver=docker  --kubernetes-version=v1.15.7: exit status 70 (26.457922551s)

-- stdout --

* [crio-20200221T162731.120843736-5900] minikube v1.7.3 on Debian 9.12

- KUBECONFIG=/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/kubeconfig

- MINIKUBE_BIN=out/minikube-linux-amd64

- MINIKUBE_HOME=/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube

- MINIKUBE_LOCATION=6717

* Using the docker (experimental) driver based on user configuration

* Creating Kubernetes in docker container with (CPUs=2), Memory=2000MB (30163MB available) ...

-- /stdout --

** stderr ** 

I0221 16:27:31.193891    5085 notify.go:125] Checking for updates...

I0221 16:27:31.453783    5085 start.go:249] hostinfo: {"hostname":"kic-integration-slave8","uptime":4206,"bootTime":1582327045,"procs":245,"os":"linux","platform":"debian","platformFamily":"debian","platformVersion":"9.12","kernelVersion":"4.9.0-12-amd64","virtualizationSystem":"kvm","virtualizationRole":"host","hostid":"ae41e7f6-8b8e-4d40-b77d-1ebb5a2d5fdb"}

I0221 16:27:31.454778    5085 start.go:259] virtualization: kvm host

I0221 16:27:31.455087    5085 driver.go:211] Setting default libvirt URI to qemu:///system

I0221 16:27:31.782884    5085 start.go:296] selected driver: docker

I0221 16:27:31.782901    5085 start.go:472] validating driver "docker" against <nil>

I0221 16:27:31.782914    5085 start.go:478] status for docker: {Installed:true Healthy:true Error:<nil> Fix: Doc:}

I0221 16:27:31.783552    5085 cache.go:91] acquiring lock: {Name:mk5cb79855f080ef903c82ad1d2382720f81c883 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}

I0221 16:27:31.783643    5085 cache.go:91] acquiring lock: {Name:mk56550c63a41f72137c00a77d6e5897d9285d96 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}

I0221 16:27:31.783736    5085 profile.go:100] Saving config to /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/profiles/crio-20200221T162731.120843736-5900/config.json ...

I0221 16:27:31.783816    5085 cache.go:91] acquiring lock: {Name:mk99be5b5f5e43aa31bd6cea7a030f65d4154521 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}

I0221 16:27:31.783853    5085 lock.go:35] WriteFile acquiring /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/profiles/crio-20200221T162731.120843736-5900/config.json: {Name:mkc9cef62304063b57751842c0a254b0629d809e Clock:{} Delay:500ms Timeout:1m0s Cancel:<nil>}

I0221 16:27:31.783951    5085 cache.go:91] acquiring lock: {Name:mk30a5f143eca3a889dd6f36269768837f05764d Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}

I0221 16:27:31.784101    5085 image.go:73] retrieving image: k8s.gcr.io/coredns:1.3.1

I0221 16:27:31.784159    5085 image.go:73] retrieving image: k8s.gcr.io/kube-controller-manager:v1.15.7

I0221 16:27:31.784325    5085 cache.go:91] acquiring lock: {Name:mk23dcda30f4b32ad59e99e63810e6b2773967a1 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}

I0221 16:27:31.784418    5085 cache.go:91] acquiring lock: {Name:mkf91a51e156ef5596dd3eac2cea53b58b866cd4 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}

I0221 16:27:31.784466    5085 cache.go:91] acquiring lock: {Name:mkcb7d2cafc6915c86bdae0c7a30271b767095b0 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}

I0221 16:27:31.784541    5085 cache.go:99] /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/pause_3.1 exists

I0221 16:27:31.784562    5085 cache.go:80] cache image "k8s.gcr.io/pause:3.1" -> "/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/pause_3.1" took 98.94µs

I0221 16:27:31.784577    5085 cache.go:65] save to tar file k8s.gcr.io/pause:3.1 -> /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/pause_3.1 succeeded

I0221 16:27:31.784582    5085 image.go:73] retrieving image: k8s.gcr.io/kube-proxy:v1.15.7

I0221 16:27:31.784598    5085 cache.go:91] acquiring lock: {Name:mk52e42b7368bd673c054e2ccc405e493a6ca9d7 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}

I0221 16:27:31.784663    5085 cache.go:99] /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/gcr.io/k8s-minikube/storage-provisioner_v1.8.1 exists

I0221 16:27:31.784676    5085 cache.go:80] cache image "gcr.io/k8s-minikube/storage-provisioner:v1.8.1" -> "/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/gcr.io/k8s-minikube/storage-provisioner_v1.8.1" took 79.988µs

I0221 16:27:31.784687    5085 cache.go:65] save to tar file gcr.io/k8s-minikube/storage-provisioner:v1.8.1 -> /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/gcr.io/k8s-minikube/storage-provisioner_v1.8.1 succeeded

I0221 16:27:31.784709    5085 cache.go:91] acquiring lock: {Name:mk0edb0ba952dc44ab773b7cbbf3b90fb552a0bf Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}

I0221 16:27:31.783549    5085 cache.go:91] acquiring lock: {Name:mk44c9561e166e21785a4721df933828ea571af8 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}

I0221 16:27:31.784448    5085 image.go:73] retrieving image: k8s.gcr.io/etcd:3.3.10

I0221 16:27:31.784907    5085 cache.go:99] /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/kubernetesui/metrics-scraper_v1.0.2 exists

I0221 16:27:31.784917    5085 start.go:244] acquiring machines lock for crio-20200221T162731.120843736-5900: {Name:mk88fe798e10191c7698c4f816989eadab63820d Clock:{} Delay:500ms Timeout:15m0s Cancel:<nil>}

I0221 16:27:31.784929    5085 cache.go:80] cache image "kubernetesui/metrics-scraper:v1.0.2" -> "/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/kubernetesui/metrics-scraper_v1.0.2" took 1.395598ms

I0221 16:27:31.784948    5085 cache.go:65] save to tar file kubernetesui/metrics-scraper:v1.0.2 -> /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/kubernetesui/metrics-scraper_v1.0.2 succeeded

I0221 16:27:31.784108    5085 image.go:73] retrieving image: k8s.gcr.io/kube-scheduler:v1.15.7

I0221 16:27:31.784766    5085 image.go:73] retrieving image: k8s.gcr.io/kube-apiserver:v1.15.7

I0221 16:27:31.784770    5085 cache.go:99] /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/kubernetesui/dashboard_v2.0.0-beta8 exists

I0221 16:27:31.785069    5085 cache.go:80] cache image "kubernetesui/dashboard:v2.0.0-beta8" -> "/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/kubernetesui/dashboard_v2.0.0-beta8" took 359.455µs

I0221 16:27:31.785099    5085 cache.go:65] save to tar file kubernetesui/dashboard:v2.0.0-beta8 -> /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/kubernetesui/dashboard_v2.0.0-beta8 succeeded

I0221 16:27:31.785785    5085 image.go:81] daemon lookup for k8s.gcr.io/coredns:1.3.1: Error response from daemon: reference does not exist

I0221 16:27:31.785834    5085 image.go:81] daemon lookup for k8s.gcr.io/kube-proxy:v1.15.7: Error response from daemon: reference does not exist

I0221 16:27:31.785876    5085 image.go:81] daemon lookup for k8s.gcr.io/kube-apiserver:v1.15.7: Error response from daemon: reference does not exist

I0221 16:27:31.786007    5085 image.go:81] daemon lookup for k8s.gcr.io/etcd:3.3.10: Error response from daemon: reference does not exist

I0221 16:27:31.786018    5085 image.go:81] daemon lookup for k8s.gcr.io/kube-scheduler:v1.15.7: Error response from daemon: reference does not exist

I0221 16:27:31.786245    5085 image.go:81] daemon lookup for k8s.gcr.io/kube-controller-manager:v1.15.7: Error response from daemon: reference does not exist

I0221 16:27:31.989332    5085 cache.go:123] opening:  /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-scheduler_v1.15.7

I0221 16:27:31.989381    5085 cache.go:123] opening:  /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-proxy_v1.15.7

I0221 16:27:31.989580    5085 cache.go:123] opening:  /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-controller-manager_v1.15.7

I0221 16:27:32.009559    5085 cache.go:123] opening:  /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-apiserver_v1.15.7

I0221 16:27:32.009603    5085 cache.go:123] opening:  /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/etcd_3.3.10

I0221 16:27:32.029212    5085 cache.go:123] opening:  /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/coredns_1.3.1

I0221 16:27:32.604470    5085 cache.go:154] /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/coredns_1.3.1 exists

I0221 16:27:32.604532    5085 cache.go:80] cache image "k8s.gcr.io/coredns:1.3.1" -> "/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/coredns_1.3.1" took 820.583052ms

I0221 16:27:32.604569    5085 cache.go:65] save to tar file k8s.gcr.io/coredns:1.3.1 -> /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/coredns_1.3.1 succeeded

I0221 16:27:32.923448    5085 cache.go:154] /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-scheduler_v1.15.7 exists

I0221 16:27:32.923529    5085 cache.go:80] cache image "k8s.gcr.io/kube-scheduler:v1.15.7" -> "/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-scheduler_v1.15.7" took 1.139989033s

I0221 16:27:32.923549    5085 cache.go:65] save to tar file k8s.gcr.io/kube-scheduler:v1.15.7 -> /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-scheduler_v1.15.7 succeeded

I0221 16:27:33.023523    5085 cache.go:154] /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-controller-manager_v1.15.7 exists

I0221 16:27:33.023593    5085 cache.go:80] cache image "k8s.gcr.io/kube-controller-manager:v1.15.7" -> "/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-controller-manager_v1.15.7" took 1.239952574s

I0221 16:27:33.023611    5085 cache.go:65] save to tar file k8s.gcr.io/kube-controller-manager:v1.15.7 -> /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-controller-manager_v1.15.7 succeeded

I0221 16:27:33.239786    5085 cache.go:154] /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-proxy_v1.15.7 exists

I0221 16:27:33.239885    5085 cache.go:80] cache image "k8s.gcr.io/kube-proxy:v1.15.7" -> "/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-proxy_v1.15.7" took 1.455478943s

I0221 16:27:33.239909    5085 cache.go:65] save to tar file k8s.gcr.io/kube-proxy:v1.15.7 -> /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-proxy_v1.15.7 succeeded

I0221 16:27:33.307886    5085 cache.go:154] /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/etcd_3.3.10 exists

I0221 16:27:33.307946    5085 cache.go:80] cache image "k8s.gcr.io/etcd:3.3.10" -> "/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/etcd_3.3.10" took 1.523626201s

I0221 16:27:33.307961    5085 cache.go:65] save to tar file k8s.gcr.io/etcd:3.3.10 -> /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/etcd_3.3.10 succeeded

I0221 16:27:33.343198    5085 cache.go:154] /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-apiserver_v1.15.7 exists

I0221 16:27:33.343249    5085 cache.go:80] cache image "k8s.gcr.io/kube-apiserver:v1.15.7" -> "/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-apiserver_v1.15.7" took 1.559437317s

I0221 16:27:33.343264    5085 cache.go:65] save to tar file k8s.gcr.io/kube-apiserver:v1.15.7 -> /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/cache/images/k8s.gcr.io/kube-apiserver_v1.15.7 succeeded

I0221 16:27:33.343289    5085 cache.go:72] Successfully saved all images to host disk.

I0221 16:27:45.938260    5085 start.go:248] acquired machines lock for "crio-20200221T162731.120843736-5900" in 14.153308785s

I0221 16:27:45.938303    5085 start.go:81] Provisioning new machine with config: {Name:crio-20200221T162731.120843736-5900 KeepContext:false EmbedCerts:false MinikubeISO:https://storage.googleapis.com/minikube/iso/minikube-v1.7.3.iso Memory:2000 CPUs:2 DiskSize:20000 Driver:docker HyperkitVpnKitSock: HyperkitVSockPorts:[] DockerEnv:[] InsecureRegistry:[] RegistryMirror:[] HostOnlyCIDR:192.168.99.1/24 HypervVirtualSwitch: HypervUseExternalSwitch:false HypervExternalAdapter: KVMNetwork:default KVMQemuURI:qemu:///system KVMGPU:false KVMHidden:false Downloader:{} DockerOpt:[] DisableDriverMounts:true NFSShare:[] NFSSharesRoot:/nfsshares UUID: NoVTXCheck:false DNSProxy:false HostDNSResolver:true HostOnlyNicType:virtio NatNicType:virtio KubernetesConfig:{KubernetesVersion:v1.15.7 ClusterName:crio-20200221T162731.120843736-5900 APIServerName:minikubeCA APIServerNames:[] APIServerIPs:[] DNSDomain:cluster.local ContainerRuntime:crio CRISocket: NetworkPlugin:cni FeatureGates: ServiceCIDR:10.96.0.0/12 Im

ageRepository: ExtraOptions:[{Component:kubeadm Key:ignore-preflight-errors Value:SystemVerification}] ShouldLoadCachedImages:true EnableDefaultCNI:true} Nodes:[{Name:crio-20200221T162731.120843736-5900 IP: Port:8443 KubernetesVersion:v1.15.7 ControlPlane:true Worker:true}] Addons:map[]}

I0221 16:27:45.938418    5085 start.go:100] createHost starting for "crio-20200221T162731.120843736-5900" (driver="docker")

I0221 16:27:45.939781    5085 start.go:136] libmachine.API.Create for "crio-20200221T162731.120843736-5900" (driver="docker")

I0221 16:27:45.939906    5085 main.go:110] libmachine: Reading certificate data from /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/certs/ca.pem

I0221 16:27:45.939965    5085 main.go:110] libmachine: Decoding PEM data...

I0221 16:27:45.939994    5085 main.go:110] libmachine: Parsing certificate...

I0221 16:27:45.940305    5085 main.go:110] libmachine: Reading certificate data from /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/certs/cert.pem

I0221 16:27:45.940364    5085 main.go:110] libmachine: Decoding PEM data...

I0221 16:27:45.940392    5085 main.go:110] libmachine: Parsing certificate...

I0221 16:27:46.017890    5085 oci.go:105] Successfully created a docker volume crio-20200221T162731.120843736-5900

I0221 16:27:46.806759    5085 kic.go:105] Creating ssh key for kic: /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/machines/crio-20200221T162731.120843736-5900/id_rsa...

I0221 16:27:50.693348    5085 main.go:110] libmachine: provisioning hostname "crio-20200221T162731.120843736-5900"

I0221 16:27:50.773977    5085 main.go:110] libmachine: Using SSH client type: native

I0221 16:27:50.774426    5085 main.go:110] libmachine: &{{{<nil> 0 [] [] []} docker [0x7b9a50] 0x7b9a20 <nil>  [] 0s} 127.0.0.1 32791 <nil> <nil>}

I0221 16:27:50.774455    5085 main.go:110] libmachine: About to run SSH command:

sudo hostname crio-20200221T162731.120843736-5900 && echo "crio-20200221T162731.120843736-5900" | sudo tee /etc/hostname

I0221 16:27:50.948689    5085 main.go:110] libmachine: SSH cmd err, output: <nil>: crio-20200221T162731.120843736-5900

I0221 16:27:51.025184    5085 main.go:110] libmachine: Using SSH client type: native

I0221 16:27:51.025404    5085 main.go:110] libmachine: &{{{<nil> 0 [] [] []} docker [0x7b9a50] 0x7b9a20 <nil>  [] 0s} 127.0.0.1 32791 <nil> <nil>}

I0221 16:27:51.025447    5085 main.go:110] libmachine: About to run SSH command:

		if ! grep -xq '.*\scrio-20200221T162731.120843736-5900' /etc/hosts; then

			if grep -xq '127.0.1.1\s.*' /etc/hosts; then

				sudo sed -i 's/^127.0.1.1\s.*/127.0.1.1 crio-20200221T162731.120843736-5900/g' /etc/hosts;

			else 

				echo '127.0.1.1 crio-20200221T162731.120843736-5900' | sudo tee -a /etc/hosts; 

			fi

		fi

I0221 16:27:51.186705    5085 main.go:110] libmachine: SSH cmd err, output: <nil>: 127.0.1.1 crio-20200221T162731.120843736-5900

I0221 16:27:51.186866    5085 main.go:110] libmachine: set auth options {CertDir:/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube CaCertPath:/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/certs/ca.pem CaPrivateKeyPath:/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/certs/ca-key.pem CaCertRemotePath:/etc/docker/ca.pem ServerCertPath:/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/machines/server.pem ServerKeyPath:/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/machines/server-key.pem ClientKeyPath:/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/certs/key.pem ServerCertRemotePath:/etc/docker/server.pe

m ServerKeyRemotePath:/etc/docker/server-key.pem ClientCertPath:/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/certs/cert.pem ServerCertSANs:[] StorePath:/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube}

I0221 16:27:51.186886    5085 main.go:110] libmachine: setting up certificates

I0221 16:27:51.186903    5085 main.go:110] libmachine: configureAuth start

I0221 16:27:51.254926    5085 main.go:110] libmachine: copyHostCerts

I0221 16:27:51.255362    5085 main.go:110] libmachine: generating server cert: /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/machines/server.pem ca-key=/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/certs/ca.pem private-key=/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/certs/ca-key.pem org=jenkins.crio-20200221T162731.120843736-5900 san=[172.17.0.5 localhost 127.0.0.1]

I0221 16:27:51.865504    5085 main.go:110] libmachine: copyRemoteCerts

I0221 16:27:52.000403    5085 ssh_runner.go:101] Run: sudo mkdir -p /etc/docker /etc/docker /etc/docker

I0221 16:27:52.070424    5085 ssh_runner.go:155] Checked if /etc/docker/ca.pem exists, but got error: Process exited with status 1

I0221 16:27:52.070825    5085 ssh_runner.go:174] Transferring 1038 bytes to /etc/docker/ca.pem

I0221 16:27:52.071911    5085 ssh_runner.go:193] ca.pem: copied 1038 bytes

I0221 16:27:52.117242    5085 ssh_runner.go:155] Checked if /etc/docker/server.pem exists, but got error: Process exited with status 1

I0221 16:27:52.117673    5085 ssh_runner.go:174] Transferring 1159 bytes to /etc/docker/server.pem

I0221 16:27:52.122443    5085 ssh_runner.go:193] server.pem: copied 1159 bytes

I0221 16:27:52.160625    5085 ssh_runner.go:155] Checked if /etc/docker/server-key.pem exists, but got error: Process exited with status 1

I0221 16:27:52.161065    5085 ssh_runner.go:174] Transferring 1679 bytes to /etc/docker/server-key.pem

I0221 16:27:52.162061    5085 ssh_runner.go:193] server-key.pem: copied 1679 bytes

I0221 16:27:52.194611    5085 main.go:110] libmachine: configureAuth took 1.007662573s

I0221 16:27:52.194641    5085 main.go:110] libmachine: setting minikube options for container-runtime

I0221 16:27:52.291018    5085 main.go:110] libmachine: Using SSH client type: native

I0221 16:27:52.291300    5085 main.go:110] libmachine: &{{{<nil> 0 [] [] []} docker [0x7b9a50] 0x7b9a20 <nil>  [] 0s} 127.0.0.1 32791 <nil> <nil>}

I0221 16:27:52.291333    5085 main.go:110] libmachine: About to run SSH command:

sudo mkdir -p /etc/sysconfig && printf %s "

CRIO_MINIKUBE_OPTIONS='--insecure-registry 10.96.0.0/12 '

" | sudo tee /etc/sysconfig/crio.minikube

I0221 16:27:52.459861    5085 main.go:110] libmachine: SSH cmd err, output: <nil>: 

CRIO_MINIKUBE_OPTIONS='--insecure-registry 10.96.0.0/12 '

I0221 16:27:52.459926    5085 start.go:141] libmachine.API.Create for "crio-20200221T162731.120843736-5900" took 6.520147372s

I0221 16:27:52.459945    5085 start.go:182] post-start starting for "crio-20200221T162731.120843736-5900" (driver="docker")

I0221 16:27:52.459955    5085 start.go:192] creating required directories: [/etc/kubernetes/addons /etc/kubernetes/manifests /var/tmp/minikube /var/lib/minikube /var/lib/minikube/certs /var/lib/minikube/images /var/lib/minikube/binaries /tmp/gvisor /usr/share/ca-certificates /etc/ssl/certs]

I0221 16:27:52.459993    5085 start.go:215] determining appropriate runner for "docker"

I0221 16:27:52.460007    5085 start.go:226] Returning KICRunner for "docker" driver

I0221 16:27:52.804920    5085 filesync.go:118] Scanning /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/addons for local assets ...

I0221 16:27:52.805079    5085 filesync.go:118] Scanning /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/files for local assets ...

I0221 16:27:52.805587    5085 filesync.go:141] local asset: /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/files/etc/test/nested/copy/5900/hosts -> hosts in /etc/test/nested/copy/5900

I0221 16:27:53.498247    5085 start.go:185] post-start completed in 1.038275838s

I0221 16:27:53.498638    5085 start.go:103] createHost completed in 7.560204145s

I0221 16:27:53.498659    5085 start.go:72] releasing machines lock for "crio-20200221T162731.120843736-5900", held for 7.560372332s

I0221 16:27:54.068784    5085 profile.go:100] Saving config to /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/profiles/crio-20200221T162731.120843736-5900/config.json ...

W0221 16:27:57.574317    5085 exit.go:101] Failed to enable container runtime: generateCRIOConfig.: /bin/bash -c "sudo sed -e 's|^pause_image = .*$|pause_image = "k8s.gcr.io/pause:3.1"|' -i /etc/crio/crio.conf": exit status 2

stdout:

stderr:

sed: can't read /etc/crio/crio.conf: No such file or directory

* 

X Failed to enable container runtime: generateCRIOConfig.: /bin/bash -c "sudo sed -e 's|^pause_image = .*$|pause_image = "k8s.gcr.io/pause:3.1"|' -i /etc/crio/crio.conf": exit status 2

stdout:

stderr:

sed: can't read /etc/crio/crio.conf: No such file or directory

* 

* minikube is exiting due to an error. If the above message is not useful, open an issue:

- https://github.com/kubernetes/minikube/issues/new/choose

** /stderr **

start_stop_delete_test.go:95: [out/minikube-linux-amd64 start -p crio-20200221T162731.120843736-5900 --alsologtostderr -v=3 --wait=true --container-runtime=crio --disable-driver-mounts --extra-config=kubeadm.ignore-preflight-errors=SystemVerification --vm-driver=docker  --kubernetes-version=v1.15.7] failed: exit status 70

panic.go:563: *** TestStartStop/group/crio FAILED at 2020-02-21 16:27:57.579272808 -0800 PST m=+1068.121398336

helpers.go:188: (dbg) Run:  out/minikube-linux-amd64 status --format={{.Host}} -p crio-20200221T162731.120843736-5900

helpers.go:188: (dbg) Non-zero exit: out/minikube-linux-amd64 status --format={{.Host}} -p crio-20200221T162731.120843736-5900: exit status 6 (788.516881ms)

-- stdout --

Running

WARNING: Your kubectl is pointing to stale minikube-vm.

To fix the kubectl context, run `minikube update-context`

-- /stdout --

helpers.go:188: status error: exit status 6 (may be ok)

helpers.go:190: "crio-20200221T162731.120843736-5900" host is not running, skipping log retrieval (state="Running\nWARNING: Your kubectl is pointing to stale minikube-vm.\nTo fix the kubectl context, run `minikube update-context`")

helpers.go:160: (dbg) Run:  out/minikube-linux-amd64 delete -p crio-20200221T162731.120843736-5900

helpers.go:160: (dbg) Done: out/minikube-linux-amd64 delete -p crio-20200221T162731.120843736-5900: (1.216363727s)

=== RUN   TestFunctional/parallel/ProfileCmd/profile_list

--- FAIL: TestFunctional/parallel/ProfileCmd/profile_list (0.62s)

functional_test.go:540: (dbg) Run:  out/minikube-linux-amd64 profile list

functional_test.go:540: (dbg) Non-zero exit: out/minikube-linux-amd64 profile list: exit status 78 (618.504217ms)

-- stdout --

|---------------------------------------------|-----------|---------|------------|------|----------|---------|

|                   Profile                   | VM Driver | Runtime |     IP     | Port | Version  | Status  |

|---------------------------------------------|-----------|---------|------------|------|----------|---------|

| docker-flags-20200221T162731.120278192-5900 | docker    | docker  | 172.17.0.3 | 8443 | v1.17.3  | Running |

| functional-20200221T162618.306598987-5900   | docker    | docker  | 172.17.0.2 | 8443 | v1.17.3  | Running |

| newest-cni-20200221T162731.120714771-5900   | docker    | docker  | 172.17.0.4 | 8443 | v1.17.3  | Running |

| old-docker-20200221T162731.120478793-5900   | docker    | docker  | 172.17.0.5 | 8443 | v1.11.10 | Running |

| vupgrade-20200221T162731.120338915-5900     | docker    | docker  |            | 8443 | v1.11.10 |         |

|---------------------------------------------|-----------|---------|------------|------|----------|---------|

-- /stdout --

** stderr ** 

X error loading profiles: state: get container vupgrade-20200221T162731.120338915-5900 status: exit status 1

** /stderr **

functional_test.go:542: [out/minikube-linux-amd64 profile list] failed: exit status 78

=== RUN   TestDownloadOnly/group/v1.11.10

--- PASS: TestDownloadOnly/group/v1.11.10 (8.22s)

aaa_download_only_test.go:61: (dbg) Run:  out/minikube-linux-amd64 start --download-only -p download-20200221T161009.490951845-5900 --force --alsologtostderr --kubernetes-version=v1.11.10

aaa_download_only_test.go:61: (dbg) Done: out/minikube-linux-amd64 start --download-only -p download-20200221T161009.490951845-5900 --force --alsologtostderr --kubernetes-version=v1.11.10: (8.219867006s)

=== RUN   TestDownloadOnly/group/v1.17.3

--- PASS: TestDownloadOnly/group/v1.17.3 (2.90s)

aaa_download_only_test.go:63: (dbg) Run:  out/minikube-linux-amd64 start --download-only -p download-20200221T161009.490951845-5900 --force --alsologtostderr --kubernetes-version=v1.17.3

aaa_download_only_test.go:63: (dbg) Done: out/minikube-linux-amd64 start --download-only -p download-20200221T161009.490951845-5900 --force --alsologtostderr --kubernetes-version=v1.17.3: (2.902878104s)

=== RUN   TestDownloadOnly/group/v1.17.3#01

--- PASS: TestDownloadOnly/group/v1.17.3#01 (0.22s)

aaa_download_only_test.go:63: (dbg) Run:  out/minikube-linux-amd64 start --download-only -p download-20200221T161009.490951845-5900 --force --alsologtostderr --kubernetes-version=v1.17.3

=== RUN   TestDownloadOnly/group/DeleteAll

--- PASS: TestDownloadOnly/group/DeleteAll (0.46s)

aaa_download_only_test.go:142: (dbg) Run:  out/minikube-linux-amd64 delete --all

=== RUN   TestDownloadOnly/group/DeleteAlwaysSucceeds

--- PASS: TestDownloadOnly/group/DeleteAlwaysSucceeds (0.57s)

aaa_download_only_test.go:152: (dbg) Run:  out/minikube-linux-amd64 delete -p download-20200221T161009.490951845-5900

helpers.go:160: (dbg) Run:  out/minikube-linux-amd64 delete -p download-20200221T161009.490951845-5900

helpers.go:160: (dbg) Done: out/minikube-linux-amd64 delete -p download-20200221T161009.490951845-5900: (2.055400023s)

=== RUN   TestOffline/group/docker

=== PAUSE TestOffline/group/docker

=== CONT  TestOffline/group/docker

--- PASS: TestOffline/group/docker (423.34s)

aab_offline_test.go:53: (dbg) Run:  out/minikube-linux-amd64 start -p offline-docker-20200221T161023.921403194-5900 --alsologtostderr -v=1 --wait=true --container-runtime docker --vm-driver=docker 

aab_offline_test.go:53: (dbg) Done: out/minikube-linux-amd64 start -p offline-docker-20200221T161023.921403194-5900 --alsologtostderr -v=1 --wait=true --container-runtime docker --vm-driver=docker : (7m1.80666799s)

helpers.go:160: (dbg) Run:  out/minikube-linux-amd64 delete -p offline-docker-20200221T161023.921403194-5900

helpers.go:160: (dbg) Done: out/minikube-linux-amd64 delete -p offline-docker-20200221T161023.921403194-5900: (1.529723681s)

=== RUN   TestOffline/group/containerd

=== PAUSE TestOffline/group/containerd

=== CONT  TestOffline/group/containerd

--- PASS: TestOffline/group/containerd (427.66s)

aab_offline_test.go:53: (dbg) Run:  out/minikube-linux-amd64 start -p offline-containerd-20200221T161023.921735736-5900 --alsologtostderr -v=1 --wait=true --container-runtime containerd --vm-driver=docker 

aab_offline_test.go:53: (dbg) Done: out/minikube-linux-amd64 start -p offline-containerd-20200221T161023.921735736-5900 --alsologtostderr -v=1 --wait=true --container-runtime containerd --vm-driver=docker : (7m6.304226175s)

helpers.go:160: (dbg) Run:  out/minikube-linux-amd64 delete -p offline-containerd-20200221T161023.921735736-5900

helpers.go:160: (dbg) Done: out/minikube-linux-amd64 delete -p offline-containerd-20200221T161023.921735736-5900: (1.360319546s)

=== RUN   TestAddons/parallel/Registry

=== PAUSE TestAddons/parallel/Registry

=== CONT  TestAddons/parallel/Registry

--- PASS: TestAddons/parallel/Registry (52.34s)

addons_test.go:151: registry stabilized in 5.535102253s

addons_test.go:153: (dbg) TestAddons/parallel/Registry: waiting 6m0s for pods matching "actual-registry=true" in namespace "kube-system" ...

helpers.go:279: "registry-869hf" [96953b44-2eab-43c1-85e0-521ce680248f] Pending

helpers.go:279: "registry-869hf" [96953b44-2eab-43c1-85e0-521ce680248f] Pending / Ready:ContainersNotReady (containers with unready status: [registry]) / ContainersReady:ContainersNotReady (containers with unready status: [registry])

helpers.go:279: "registry-869hf" [96953b44-2eab-43c1-85e0-521ce680248f] Running

addons_test.go:153: (dbg) TestAddons/parallel/Registry: actual-registry=true healthy within 14.084245175s

addons_test.go:156: (dbg) TestAddons/parallel/Registry: waiting 10m0s for pods matching "registry-proxy=true" in namespace "kube-system" ...

helpers.go:279: "registry-proxy-2mfhf" [e75dfbf9-865a-42d4-8167-e673cbed80af] Pending / Ready:ContainersNotReady (containers with unready status: [registry-proxy]) / ContainersReady:ContainersNotReady (containers with unready status: [registry-proxy])

helpers.go:279: "registry-proxy-2mfhf" [e75dfbf9-865a-42d4-8167-e673cbed80af] Running

addons_test.go:156: (dbg) TestAddons/parallel/Registry: registry-proxy=true healthy within 22.008907205s

addons_test.go:161: (dbg) Run:  kubectl --context addons-20200221T161731.586772848-5900 delete po -l run=registry-test --now

addons_test.go:166: (dbg) Run:  kubectl --context addons-20200221T161731.586772848-5900 run --rm registry-test --restart=Never --image=busybox -it -- sh -c "wget --spider -S http://registry.kube-system.svc.cluster.local"

addons_test.go:166: (dbg) Done: kubectl --context addons-20200221T161731.586772848-5900 run --rm registry-test --restart=Never --image=busybox -it -- sh -c "wget --spider -S http://registry.kube-system.svc.cluster.local": (9.379229142s)

addons_test.go:176: (dbg) Run:  out/minikube-linux-amd64 -p addons-20200221T161731.586772848-5900 ip

addons_test.go:205: (dbg) Run:  out/minikube-linux-amd64 -p addons-20200221T161731.586772848-5900 addons disable registry --alsologtostderr -v=1

addons_test.go:205: (dbg) Done: out/minikube-linux-amd64 -p addons-20200221T161731.586772848-5900 addons disable registry --alsologtostderr -v=1: (1.110134766s)

=== RUN   TestAddons/parallel/Ingress

=== PAUSE TestAddons/parallel/Ingress

=== CONT  TestAddons/parallel/Ingress

2020/02/21 16:19:30 [DEBUG] GET http://172.17.0.2:5000

--- PASS: TestAddons/parallel/Ingress (50.30s)

addons_test.go:96: (dbg) TestAddons/parallel/Ingress: waiting 12m0s for pods matching "app.kubernetes.io/name=nginx-ingress-controller" in namespace "kube-system" ...

helpers.go:279: "nginx-ingress-controller-6fc5bcc8c9-bwp9l" [af7439f7-29f3-4ae3-a184-2ab9b62aa697] Pending

helpers.go:279: "nginx-ingress-controller-6fc5bcc8c9-bwp9l" [af7439f7-29f3-4ae3-a184-2ab9b62aa697] Pending / Ready:ContainersNotReady (containers with unready status: [nginx-ingress-controller]) / ContainersReady:ContainersNotReady (containers with unready status: [nginx-ingress-controller])

helpers.go:279: "nginx-ingress-controller-6fc5bcc8c9-bwp9l" [af7439f7-29f3-4ae3-a184-2ab9b62aa697] Running / Ready:ContainersNotReady (containers with unready status: [nginx-ingress-controller]) / ContainersReady:ContainersNotReady (containers with unready status: [nginx-ingress-controller])

addons_test.go:96: (dbg) TestAddons/parallel/Ingress: app.kubernetes.io/name=nginx-ingress-controller healthy within 28.082265357s

addons_test.go:100: (dbg) Run:  kubectl --context addons-20200221T161731.586772848-5900 replace --force -f testdata/nginx-ing.yaml

addons_test.go:100: (dbg) Done: kubectl --context addons-20200221T161731.586772848-5900 replace --force -f testdata/nginx-ing.yaml: (1.451452705s)

addons_test.go:104: (dbg) Run:  kubectl --context addons-20200221T161731.586772848-5900 replace --force -f testdata/nginx-pod-svc.yaml

addons_test.go:109: (dbg) TestAddons/parallel/Ingress: waiting 4m0s for pods matching "run=nginx" in namespace "default" ...

helpers.go:279: "nginx" [8d282606-c4e1-40f0-8826-ae9cea34d294] Pending / Ready:ContainersNotReady (containers with unready status: [nginx]) / ContainersReady:ContainersNotReady (containers with unready status: [nginx])

helpers.go:279: "nginx" [8d282606-c4e1-40f0-8826-ae9cea34d294] Running

addons_test.go:109: (dbg) TestAddons/parallel/Ingress: run=nginx healthy within 11.333400287s

addons_test.go:118: (dbg) Run:  out/minikube-linux-amd64 -p addons-20200221T161731.586772848-5900 ssh "curl http://127.0.0.1:80 -H 'Host: nginx.example.com'"

addons_test.go:118: (dbg) Done: out/minikube-linux-amd64 -p addons-20200221T161731.586772848-5900 ssh "curl http://127.0.0.1:80 -H 'Host: nginx.example.com'": (2.574524972s)

addons_test.go:135: (dbg) Run:  out/minikube-linux-amd64 -p addons-20200221T161731.586772848-5900 addons disable ingress --alsologtostderr -v=1

addons_test.go:135: (dbg) Done: out/minikube-linux-amd64 -p addons-20200221T161731.586772848-5900 addons disable ingress --alsologtostderr -v=1: (1.117436478s)

=== RUN   TestFunctional/serial/CopySyncFile

--- PASS: TestFunctional/serial/CopySyncFile (0.00s)

functional_test.go:737: local sync path: /home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube/files/etc/test/nested/copy/5900/hosts

=== RUN   TestFunctional/serial/StartWithProxy

2020/02/21 16:26:25 [017] WARN: Error copying to client: readfrom tcp 10.150.0.3:39438->104.18.122.25:443: splice: connection reset by peer

--- PASS: TestFunctional/serial/StartWithProxy (61.85s)

functional_test.go:184: (dbg) Run:  out/minikube-linux-amd64 start -p functional-20200221T162618.306598987-5900 --wait=true --memory 2500MB --vm-driver=docker 

functional_test.go:184: (dbg) Done: out/minikube-linux-amd64 start -p functional-20200221T162618.306598987-5900 --wait=true --memory 2500MB --vm-driver=docker : (1m1.847717126s)

=== RUN   TestFunctional/serial/KubeContext

--- PASS: TestFunctional/serial/KubeContext (0.08s)

functional_test.go:202: (dbg) Run:  kubectl config current-context

=== RUN   TestFunctional/serial/KubectlGetPods

--- PASS: TestFunctional/serial/KubectlGetPods (0.57s)

functional_test.go:213: (dbg) Run:  kubectl --context functional-20200221T162618.306598987-5900 get po -A

=== RUN   TestFunctional/serial/CacheCmd/cache/add

--- PASS: TestFunctional/serial/CacheCmd/cache/add (7.42s)

functional_test.go:400: (dbg) Run:  out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 cache add busybox:latest

functional_test.go:400: (dbg) Done: out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 cache add busybox:latest: (3.605137528s)

functional_test.go:400: (dbg) Run:  out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 cache add busybox:1.28.4-glibc

functional_test.go:400: (dbg) Done: out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 cache add busybox:1.28.4-glibc: (1.960870211s)

functional_test.go:400: (dbg) Run:  out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 cache add k8s.gcr.io/pause:latest

functional_test.go:400: (dbg) Done: out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 cache add k8s.gcr.io/pause:latest: (1.854709226s)

=== RUN   TestFunctional/serial/CacheCmd/cache/delete_busybox:1.28.4-glibc

--- PASS: TestFunctional/serial/CacheCmd/cache/delete_busybox:1.28.4-glibc (0.05s)

functional_test.go:407: (dbg) Run:  out/minikube-linux-amd64 cache delete busybox:1.28.4-glibc

=== RUN   TestFunctional/serial/CacheCmd/cache/list

--- PASS: TestFunctional/serial/CacheCmd/cache/list (0.04s)

functional_test.go:414: (dbg) Run:  out/minikube-linux-amd64 cache list

=== RUN   TestFunctional/serial/CacheCmd/cache/verify_cache_inside_node

--- PASS: TestFunctional/serial/CacheCmd/cache/verify_cache_inside_node (0.28s)

functional_test.go:427: (dbg) Run:  out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 ssh sudo crictl images

=== RUN   TestFunctional/serial/CacheCmd/cache/cache_reload

--- PASS: TestFunctional/serial/CacheCmd/cache/cache_reload (2.40s)

functional_test.go:440: (dbg) Run:  out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 ssh sudo docker rmi busybox:latest

functional_test.go:445: (dbg) Run:  out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 ssh sudo crictl inspecti busybox:latest

functional_test.go:445: (dbg) Non-zero exit: out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 ssh sudo crictl inspecti busybox:latest: exit status 1 (275.23867ms)

-- stdout --

FATA[0000] no such image "busybox:latest" present       

-- /stdout --

** stderr ** 

ssh: Process exited with status 1

** /stderr **

functional_test.go:450: (dbg) Run:  out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 cache reload

functional_test.go:450: (dbg) Done: out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 cache reload: (1.503200019s)

functional_test.go:455: (dbg) Run:  out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 ssh sudo crictl inspecti busybox:latest

=== RUN   TestFunctional/serial/MinikubeKubectlCmd

--- PASS: TestFunctional/serial/MinikubeKubectlCmd (0.12s)

functional_test.go:228: (dbg) Run:  out/minikube-linux-amd64 kubectl -- get pods

=== RUN   TestStartStop/group/old-docker

=== PAUSE TestStartStop/group/old-docker

=== CONT  TestStartStop/group/old-docker

--- PASS: TestStartStop/group/old-docker (302.57s)

start_stop_delete_test.go:93: (dbg) Run:  out/minikube-linux-amd64 start -p old-docker-20200221T162731.120478793-5900 --alsologtostderr -v=3 --wait=true --kvm-network=default --kvm-qemu-uri=qemu:///system --disable-driver-mounts --keep-context=false --container-runtime=docker --vm-driver=docker  --kubernetes-version=v1.11.10

start_stop_delete_test.go:93: (dbg) Done: out/minikube-linux-amd64 start -p old-docker-20200221T162731.120478793-5900 --alsologtostderr -v=3 --wait=true --kvm-network=default --kvm-qemu-uri=qemu:///system --disable-driver-mounts --keep-context=false --container-runtime=docker --vm-driver=docker  --kubernetes-version=v1.11.10: (2m59.296933663s)

start_stop_delete_test.go:99: (dbg) Run:  kubectl --context old-docker-20200221T162731.120478793-5900 create -f testdata/busybox.yaml

start_stop_delete_test.go:99: (dbg) TestStartStop/group/old-docker: waiting 8m0s for pods matching "integration-test=busybox" in namespace "default" ...

helpers.go:279: "busybox" [884c5799-550a-11ea-9467-0242b0e33310] Pending

helpers.go:279: "busybox" [884c5799-550a-11ea-9467-0242b0e33310] Pending / Ready:ContainersNotReady (containers with unready status: [busybox]) / ContainersReady:ContainersNotReady (containers with unready status: [busybox])

helpers.go:279: "busybox" [884c5799-550a-11ea-9467-0242b0e33310] Running

start_stop_delete_test.go:99: (dbg) TestStartStop/group/old-docker: integration-test=busybox healthy within 10.023258137s

start_stop_delete_test.go:99: (dbg) Run:  kubectl --context old-docker-20200221T162731.120478793-5900 exec busybox -- /bin/sh -c "ulimit -n"

start_stop_delete_test.go:102: (dbg) Run:  out/minikube-linux-amd64 stop -p old-docker-20200221T162731.120478793-5900 --alsologtostderr -v=3

start_stop_delete_test.go:102: (dbg) Done: out/minikube-linux-amd64 stop -p old-docker-20200221T162731.120478793-5900 --alsologtostderr -v=3: (10.754445399s)

start_stop_delete_test.go:109: (dbg) Run:  out/minikube-linux-amd64 status --format={{.Host}} -p old-docker-20200221T162731.120478793-5900

start_stop_delete_test.go:109: (dbg) Non-zero exit: out/minikube-linux-amd64 status --format={{.Host}} -p old-docker-20200221T162731.120478793-5900: exit status 7 (106.494721ms)

-- stdout --

Stopped

-- /stdout --

start_stop_delete_test.go:109: status error: exit status 7 (may be ok)

start_stop_delete_test.go:116: (dbg) Run:  out/minikube-linux-amd64 addons enable dashboard -p old-docker-20200221T162731.120478793-5900

start_stop_delete_test.go:121: (dbg) Run:  out/minikube-linux-amd64 start -p old-docker-20200221T162731.120478793-5900 --alsologtostderr -v=3 --wait=true --kvm-network=default --kvm-qemu-uri=qemu:///system --disable-driver-mounts --keep-context=false --container-runtime=docker --vm-driver=docker  --kubernetes-version=v1.11.10

start_stop_delete_test.go:121: (dbg) Done: out/minikube-linux-amd64 start -p old-docker-20200221T162731.120478793-5900 --alsologtostderr -v=3 --wait=true --kvm-network=default --kvm-qemu-uri=qemu:///system --disable-driver-mounts --keep-context=false --container-runtime=docker --vm-driver=docker  --kubernetes-version=v1.11.10: (1m15.107188494s)

start_stop_delete_test.go:130: (dbg) TestStartStop/group/old-docker: waiting 4m0s for pods matching "integration-test=busybox" in namespace "default" ...

helpers.go:279: "busybox" [884c5799-550a-11ea-9467-0242b0e33310] Running

start_stop_delete_test.go:130: (dbg) TestStartStop/group/old-docker: integration-test=busybox healthy within 5.017100027s

start_stop_delete_test.go:133: (dbg) TestStartStop/group/old-docker: waiting 4m0s for pods matching "k8s-app=kubernetes-dashboard" in namespace "kubernetes-dashboard" ...

helpers.go:279: "kubernetes-dashboard-dcd78ff99-87wnp" [c70fc862-550a-11ea-8be6-02426f9fec9f] Pending / Ready:ContainersNotReady (containers with unready status: [kubernetes-dashboard]) / ContainersReady:ContainersNotReady (containers with unready status: [kubernetes-dashboard])

helpers.go:279: "kubernetes-dashboard-dcd78ff99-87wnp" [c70fc862-550a-11ea-8be6-02426f9fec9f] Running

start_stop_delete_test.go:133: (dbg) TestStartStop/group/old-docker: k8s-app=kubernetes-dashboard healthy within 12.006486018s

start_stop_delete_test.go:138: (dbg) Run:  out/minikube-linux-amd64 status --format={{.Host}} -p old-docker-20200221T162731.120478793-5900

start_stop_delete_test.go:144: (dbg) Run:  out/minikube-linux-amd64 ssh -p old-docker-20200221T162731.120478793-5900 "sudo crictl images -o json"

start_stop_delete_test.go:144: Found non-minikube image: busybox:1.28.4-glibc

start_stop_delete_test.go:144: Found non-minikube image: busybox:latest

start_stop_delete_test.go:144: Found non-minikube image: k8s.gcr.io/pause:latest

start_stop_delete_test.go:144: Found non-minikube image: kindest/kindnetd:0.5.3

start_stop_delete_test.go:147: (dbg) Run:  out/minikube-linux-amd64 pause -p old-docker-20200221T162731.120478793-5900 --alsologtostderr -v=1

start_stop_delete_test.go:147: (dbg) Done: out/minikube-linux-amd64 pause -p old-docker-20200221T162731.120478793-5900 --alsologtostderr -v=1: (1.197665425s)

start_stop_delete_test.go:147: (dbg) Run:  out/minikube-linux-amd64 status --format={{.APIServer}} -p old-docker-20200221T162731.120478793-5900

start_stop_delete_test.go:147: (dbg) Non-zero exit: out/minikube-linux-amd64 status --format={{.APIServer}} -p old-docker-20200221T162731.120478793-5900: exit status 2 (847.682827ms)

-- stdout --

Paused

-- /stdout --

start_stop_delete_test.go:147: status error: exit status 2 (may be ok)

start_stop_delete_test.go:147: (dbg) Run:  out/minikube-linux-amd64 status --format={{.Kubelet}} -p old-docker-20200221T162731.120478793-5900

start_stop_delete_test.go:147: (dbg) Non-zero exit: out/minikube-linux-amd64 status --format={{.Kubelet}} -p old-docker-20200221T162731.120478793-5900: exit status 2 (831.962927ms)

-- stdout --

Stopped

-- /stdout --

start_stop_delete_test.go:147: status error: exit status 2 (may be ok)

start_stop_delete_test.go:147: (dbg) Run:  out/minikube-linux-amd64 unpause -p old-docker-20200221T162731.120478793-5900 --alsologtostderr -v=1

start_stop_delete_test.go:147: (dbg) Run:  out/minikube-linux-amd64 status --format={{.APIServer}} -p old-docker-20200221T162731.120478793-5900

start_stop_delete_test.go:147: (dbg) Done: out/minikube-linux-amd64 status --format={{.APIServer}} -p old-docker-20200221T162731.120478793-5900: (1.019642485s)

start_stop_delete_test.go:147: (dbg) Run:  out/minikube-linux-amd64 status --format={{.Kubelet}} -p old-docker-20200221T162731.120478793-5900

start_stop_delete_test.go:151: (dbg) Run:  out/minikube-linux-amd64 delete -p old-docker-20200221T162731.120478793-5900

start_stop_delete_test.go:151: (dbg) Done: out/minikube-linux-amd64 delete -p old-docker-20200221T162731.120478793-5900: (1.694183188s)

start_stop_delete_test.go:156: (dbg) Run:  kubectl config get-contexts old-docker-20200221T162731.120478793-5900

start_stop_delete_test.go:156: (dbg) Non-zero exit: kubectl config get-contexts old-docker-20200221T162731.120478793-5900: exit status 1 (58.022999ms)

-- stdout --

CURRENT   NAME   CLUSTER   AUTHINFO   NAMESPACE

-- /stdout --

** stderr ** 

error: context old-docker-20200221T162731.120478793-5900 not found

** /stderr **

start_stop_delete_test.go:158: config context error: exit status 1 (may be ok)

helpers.go:160: (dbg) Run:  out/minikube-linux-amd64 delete -p old-docker-20200221T162731.120478793-5900

=== RUN   TestFunctional/parallel/ComponentHealth

=== PAUSE TestFunctional/parallel/ComponentHealth

=== CONT  TestFunctional/parallel/ComponentHealth

--- PASS: TestFunctional/parallel/ComponentHealth (0.19s)

functional_test.go:236: (dbg) Run:  kubectl --context functional-20200221T162618.306598987-5900 get cs -o=json

=== RUN   TestFunctional/parallel/ConfigCmd

=== PAUSE TestFunctional/parallel/ConfigCmd

=== CONT  TestFunctional/parallel/ConfigCmd

2020/02/21 16:29:05 [DEBUG] GET http://127.0.0.1:45015/api/v1/namespaces/kubernetes-dashboard/services/http:kubernetes-dashboard:/proxy/

2020/02/21 16:29:10 [DEBUG] GET http://172.17.0.2:32366

--- PASS: TestFunctional/parallel/ConfigCmd (0.54s)

functional_test.go:481: (dbg) Run:  out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 config unset cpus

functional_test.go:481: (dbg) Run:  out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 config get cpus

functional_test.go:481: (dbg) Non-zero exit: out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 config get cpus: exit status 64 (70.063124ms)

** stderr ** 

Error: specified key could not be found in config

** /stderr **

functional_test.go:481: (dbg) Run:  out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 config set cpus 2

functional_test.go:481: (dbg) Run:  out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 config get cpus

functional_test.go:481: (dbg) Run:  out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 config unset cpus

functional_test.go:481: (dbg) Run:  out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 config get cpus

functional_test.go:481: (dbg) Non-zero exit: out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 config get cpus: exit status 64 (103.554014ms)

** stderr ** 

Error: specified key could not be found in config

** /stderr **

=== RUN   TestFunctional/parallel/DashboardCmd

=== PAUSE TestFunctional/parallel/DashboardCmd

=== CONT  TestFunctional/parallel/DashboardCmd

--- PASS: TestFunctional/parallel/DashboardCmd (37.33s)

functional_test.go:303: (dbg) daemon: [out/minikube-linux-amd64 dashboard --url -p functional-20200221T162618.306598987-5900 --alsologtostderr -v=1]

functional_test.go:308: (dbg) stopping [out/minikube-linux-amd64 dashboard --url -p functional-20200221T162618.306598987-5900 --alsologtostderr -v=1] ...

helpers.go:393: unable to kill pid 23492: os: process already finished

=== RUN   TestFunctional/parallel/DNS

=== PAUSE TestFunctional/parallel/DNS

=== CONT  TestFunctional/parallel/DNS

--- PASS: TestFunctional/parallel/DNS (9.90s)

functional_test.go:340: (dbg) Run:  kubectl --context functional-20200221T162618.306598987-5900 replace --force -f testdata/busybox.yaml

functional_test.go:345: (dbg) TestFunctional/parallel/DNS: waiting 4m0s for pods matching "integration-test=busybox" in namespace "default" ...

helpers.go:279: "busybox" [782af2ef-d39a-4547-abfe-3ab97dd1b149] Pending

helpers.go:279: "busybox" [782af2ef-d39a-4547-abfe-3ab97dd1b149] Pending / Ready:ContainersNotReady (containers with unready status: [busybox]) / ContainersReady:ContainersNotReady (containers with unready status: [busybox])

helpers.go:279: "busybox" [782af2ef-d39a-4547-abfe-3ab97dd1b149] Running

functional_test.go:345: (dbg) TestFunctional/parallel/DNS: integration-test=busybox healthy within 9.017232177s

functional_test.go:351: (dbg) Run:  kubectl --context functional-20200221T162618.306598987-5900 exec busybox nslookup kubernetes.default

=== RUN   TestFunctional/parallel/DryRun

=== PAUSE TestFunctional/parallel/DryRun

=== CONT  TestFunctional/parallel/DryRun

--- PASS: TestFunctional/parallel/DryRun (1.10s)

functional_test.go:375: (dbg) Run:  out/minikube-linux-amd64 start -p functional-20200221T162618.306598987-5900 --dry-run --memory 250MB --alsologtostderr -v=1 --vm-driver=docker 

functional_test.go:375: (dbg) Non-zero exit: out/minikube-linux-amd64 start -p functional-20200221T162618.306598987-5900 --dry-run --memory 250MB --alsologtostderr -v=1 --vm-driver=docker : exit status 78 (497.506498ms)

-- stdout --

* [functional-20200221T162618.306598987-5900] minikube v1.7.3 on Debian 9.12

- KUBECONFIG=/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/kubeconfig

- MINIKUBE_BIN=out/minikube-linux-amd64

- MINIKUBE_HOME=/home/jenkins/minikube-integration/linux-amd64-docker-6717-3324-e6535896b4cbd78f679ea016458ba93abb182b2a/.minikube

- MINIKUBE_LOCATION=6717

* Using the docker (experimental) driver based on user configuration

-- /stdout --

** stderr ** 

I0221 16:28:27.771445   21590 notify.go:125] Checking for updates...

I0221 16:28:27.977743   21590 start.go:249] hostinfo: {"hostname":"kic-integration-slave8","uptime":4262,"bootTime":1582327045,"procs":346,"os":"linux","platform":"debian","platformFamily":"debian","platformVersion":"9.12","kernelVersion":"4.9.0-12-amd64","virtualizationSystem":"kvm","virtualizationRole":"host","hostid":"ae41e7f6-8b8e-4d40-b77d-1ebb5a2d5fdb"}

I0221 16:28:27.978736   21590 start.go:259] virtualization: kvm host

I0221 16:28:27.979407   21590 driver.go:211] Setting default libvirt URI to qemu:///system

I0221 16:28:28.168162   21590 start.go:296] selected driver: docker

I0221 16:28:28.168180   21590 start.go:472] validating driver "docker" against &{Name:functional-20200221T162618.306598987-5900 KeepContext:false EmbedCerts:false MinikubeISO:https://storage.googleapis.com/minikube/iso/minikube-v1.7.3.iso Memory:2500 CPUs:2 DiskSize:20000 Driver:docker HyperkitVpnKitSock: HyperkitVSockPorts:[] DockerEnv:[] InsecureRegistry:[] RegistryMirror:[] HostOnlyCIDR:192.168.99.1/24 HypervVirtualSwitch: HypervUseExternalSwitch:false HypervExternalAdapter: KVMNetwork:default KVMQemuURI:qemu:///system KVMGPU:false KVMHidden:false Downloader:<nil> DockerOpt:[] DisableDriverMounts:false NFSShare:[] NFSSharesRoot:/nfsshares UUID: NoVTXCheck:false DNSProxy:false HostDNSResolver:true HostOnlyNicType:virtio NatNicType:virtio KubernetesConfig:{KubernetesVersion:v1.17.3 ClusterName:functional-20200221T162618.306598987-5900 APIServerName:minikubeCA APIServerNames:[] APIServerIPs:[] DNSDomain:cluster.local ContainerRuntime:docker CRISocket: NetworkPlugin: FeatureGates: ServiceCIDR:1

0.96.0.0/12 ImageRepository: ExtraOptions:[{Component:kubeadm Key:pod-network-cidr Value:10.244.0.0/16}] ShouldLoadCachedImages:true EnableDefaultCNI:false} Nodes:[{Name:functional-20200221T162618.306598987-5900 IP:172.17.0.2 Port:8443 KubernetesVersion:v1.17.3 ControlPlane:true Worker:true}] Addons:map[default-storageclass:true storage-provisioner:true]}

I0221 16:28:28.168276   21590 start.go:478] status for docker: {Installed:true Healthy:true Error:<nil> Fix: Doc:}

I0221 16:28:28.168948   21590 start.go:860] auto setting extra-config to "kubeadm.pod-network-cidr=10.244.0.0/16".

X Requested memory allocation 250 is less than the minimum allowed of 1024

** /stderr **

functional_test.go:386: (dbg) Run:  out/minikube-linux-amd64 start -p functional-20200221T162618.306598987-5900 --dry-run --alsologtostderr -v=1 --vm-driver=docker 

=== RUN   TestFunctional/parallel/StatusCmd

=== PAUSE TestFunctional/parallel/StatusCmd

=== CONT  TestFunctional/parallel/StatusCmd

--- PASS: TestFunctional/parallel/StatusCmd (3.95s)

functional_test.go:261: (dbg) Run:  out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 status

functional_test.go:261: (dbg) Done: out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 status: (1.515654517s)

functional_test.go:267: (dbg) Run:  out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 status -f host:{{.Host}},kublet:{{.Kubelet}},apiserver:{{.APIServer}},kubeconfig:{{.Kubeconfig}}

functional_test.go:267: (dbg) Done: out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 status -f host:{{.Host}},kublet:{{.Kubelet}},apiserver:{{.APIServer}},kubeconfig:{{.Kubeconfig}}: (1.16919268s)

functional_test.go:277: (dbg) Run:  out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 status -o json

functional_test.go:277: (dbg) Done: out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 status -o json: (1.259047313s)

=== RUN   TestFunctional/parallel/LogsCmd

=== PAUSE TestFunctional/parallel/LogsCmd

=== CONT  TestFunctional/parallel/LogsCmd

--- PASS: TestFunctional/parallel/LogsCmd (14.21s)

functional_test.go:499: (dbg) Run:  out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 logs

functional_test.go:499: (dbg) Done: out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 logs: (14.207416556s)

=== RUN   TestFunctional/parallel/MountCmd

=== PAUSE TestFunctional/parallel/MountCmd

=== CONT  TestFunctional/parallel/MountCmd

--- PASS: TestFunctional/parallel/MountCmd (15.44s)

fn_mount_cmd.go:62: (dbg) daemon: [out/minikube-linux-amd64 mount -p functional-20200221T162618.306598987-5900 /tmp/mounttest362568717:/mount-9p --alsologtostderr -v=1]

fn_mount_cmd.go:96: wrote "test-1582331292234305352" to /tmp/mounttest362568717/created-by-test

fn_mount_cmd.go:96: wrote "test-1582331292234305352" to /tmp/mounttest362568717/created-by-test-removed-by-pod

fn_mount_cmd.go:96: wrote "test-1582331292234305352" to /tmp/mounttest362568717/test-1582331292234305352

fn_mount_cmd.go:104: (dbg) Run:  out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 ssh "findmnt -T /mount-9p | grep 9p"

fn_mount_cmd.go:104: (dbg) Non-zero exit: out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 ssh "findmnt -T /mount-9p | grep 9p": exit status 1 (7.039053422s)

** stderr ** 

ssh: Process exited with status 1

** /stderr **

fn_mount_cmd.go:104: (dbg) Run:  out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 ssh "findmnt -T /mount-9p | grep 9p"

fn_mount_cmd.go:118: (dbg) Run:  out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 ssh -- ls -la /mount-9p

fn_mount_cmd.go:122: guest mount directory contents

total 2

-rw-r--r-- 1 docker docker 24 Feb 22 00:28 created-by-test

-rw-r--r-- 1 docker docker 24 Feb 22 00:28 created-by-test-removed-by-pod

-rw-r--r-- 1 docker docker 24 Feb 22 00:28 test-1582331292234305352

fn_mount_cmd.go:126: (dbg) Run:  out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 ssh cat /mount-9p/test-1582331292234305352

fn_mount_cmd.go:137: (dbg) Run:  kubectl --context functional-20200221T162618.306598987-5900 replace --force -f testdata/busybox-mount-test.yaml

fn_mount_cmd.go:142: (dbg) TestFunctional/parallel/MountCmd: waiting 4m0s for pods matching "integration-test=busybox-mount" in namespace "default" ...

helpers.go:279: "busybox-mount" [6b2a5e8c-ea96-461e-b97e-867b86f6d438] Pending

helpers.go:279: "busybox-mount" [6b2a5e8c-ea96-461e-b97e-867b86f6d438] Pending / Ready:ContainersNotReady (containers with unready status: [mount-munger]) / ContainersReady:ContainersNotReady (containers with unready status: [mount-munger])

helpers.go:279: "busybox-mount" [6b2a5e8c-ea96-461e-b97e-867b86f6d438] Succeeded: Initialized:PodCompleted / Ready:PodCompleted / ContainersReady:PodCompleted

fn_mount_cmd.go:142: (dbg) TestFunctional/parallel/MountCmd: integration-test=busybox-mount healthy within 3.013095174s

fn_mount_cmd.go:158: (dbg) Run:  kubectl --context functional-20200221T162618.306598987-5900 logs busybox-mount

fn_mount_cmd.go:170: (dbg) Run:  out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 ssh stat /mount-9p/created-by-test

fn_mount_cmd.go:170: (dbg) Run:  out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 ssh stat /mount-9p/created-by-pod

fn_mount_cmd.go:79: (dbg) Run:  out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 ssh "sudo umount -f /mount-9p"

fn_mount_cmd.go:83: (dbg) stopping [out/minikube-linux-amd64 mount -p functional-20200221T162618.306598987-5900 /tmp/mounttest362568717:/mount-9p --alsologtostderr -v=1] ...

=== RUN   TestFunctional/parallel/ServiceCmd

=== PAUSE TestFunctional/parallel/ServiceCmd

=== CONT  TestFunctional/parallel/ServiceCmd

--- PASS: TestFunctional/parallel/ServiceCmd (60.77s)

functional_test.go:589: (dbg) Run:  kubectl --context functional-20200221T162618.306598987-5900 create deployment hello-node --image=gcr.io/hello-minikube-zero-install/hello-node

functional_test.go:593: (dbg) Run:  kubectl --context functional-20200221T162618.306598987-5900 expose deployment hello-node --type=NodePort --port=8080

functional_test.go:598: (dbg) TestFunctional/parallel/ServiceCmd: waiting 10m0s for pods matching "app=hello-node" in namespace "default" ...

helpers.go:279: "hello-node-7676b5fb8d-9jr6t" [b1403105-20cb-4b7c-9cba-905602a18240] Pending / Ready:ContainersNotReady (containers with unready status: [hello-node]) / ContainersReady:ContainersNotReady (containers with unready status: [hello-node])

helpers.go:279: "hello-node-7676b5fb8d-9jr6t" [b1403105-20cb-4b7c-9cba-905602a18240] Running

functional_test.go:598: (dbg) TestFunctional/parallel/ServiceCmd: app=hello-node healthy within 58.016114667s

functional_test.go:602: (dbg) Run:  out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 service list

functional_test.go:602: (dbg) Done: out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 service list: (1.546031389s)

functional_test.go:611: (dbg) Run:  out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 service --namespace=default --https --url hello-node

functional_test.go:629: (dbg) Run:  out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 service hello-node --url --format={{.IP}}

functional_test.go:638: (dbg) Run:  out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 service hello-node --url

functional_test.go:652: url: http://172.17.0.2:32366

functional_test.go:64: *** TestFunctional FAILED at 2020-02-21 16:29:10.464993051 -0800 PST m=+1141.007118529

helpers.go:188: (dbg) Run:  out/minikube-linux-amd64 status --format={{.Host}} -p functional-20200221T162618.306598987-5900

helpers.go:188: (dbg) Done: out/minikube-linux-amd64 status --format={{.Host}} -p functional-20200221T162618.306598987-5900: (1.341486229s)

helpers.go:194: <<< TestFunctional FAILED: start of post-mortem logs <<<

helpers.go:195: (dbg) Run:  out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 logs --problems

helpers.go:195: (dbg) Done: out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 logs --problems: (7.891980501s)

helpers.go:200: TestFunctional logs: 

helpers.go:202: (dbg) Run:  out/minikube-linux-amd64 status --format={{.APIServer}} -p functional-20200221T162618.306598987-5900

helpers.go:202: (dbg) Done: out/minikube-linux-amd64 status --format={{.APIServer}} -p functional-20200221T162618.306598987-5900: (1.436352919s)

helpers.go:208: (dbg) Run:  kubectl --context functional-20200221T162618.306598987-5900 get po -A --show-labels

helpers.go:213: (dbg) kubectl --context functional-20200221T162618.306598987-5900 get po -A --show-labels:

NAMESPACE              NAME                                                                READY   STATUS      RESTARTS   AGE    LABELS

default                busybox                                                             1/1     Running     0          54s    integration-test=busybox

default                busybox-mount                                                       0/1     Completed   0          59s    integration-test=busybox-mount

default                hello-node-7676b5fb8d-9jr6t                                         1/1     Running     0          72s    app=hello-node,pod-template-hash=7676b5fb8d

default                mysql-5787d7b5fc-5vtxl                                              1/1     Running     0          104s   app=mysql,pod-template-hash=5787d7b5fc

default                nginx-svc                                                           1/1     Running     0          102s   run=nginx-svc

kube-system            coredns-6955765f44-d9tbf                                            1/1     Running     0          105s   k8s-app=kube-dns,pod-template-hash=6955765f44

kube-system            coredns-6955765f44-f5f27                                            1/1     Running     0          105s   k8s-app=kube-dns,pod-template-hash=6955765f44

kube-system            etcd-functional-20200221t162618.306598987-5900                      1/1     Running     0          2m4s   component=etcd,tier=control-plane

kube-system            kindnet-6klzh                                                       1/1     Running     0          105s   app=kindnet,controller-revision-hash=6f48886b45,k8s-app=kindnet,pod-template-generation=1,tier=node

kube-system            kube-apiserver-functional-20200221t162618.306598987-5900            1/1     Running     0          2m4s   component=kube-apiserver,tier=control-plane

kube-system            kube-controller-manager-functional-20200221t162618.306598987-5900   1/1     Running     0          2m4s   component=kube-controller-manager,tier=control-plane

kube-system            kube-proxy-7msdx                                                    1/1     Running     0          105s   controller-revision-hash=5fc47fcbf5,k8s-app=kube-proxy,pod-template-generation=1

kube-system            kube-scheduler-functional-20200221t162618.306598987-5900            1/1     Running     0          2m4s   component=kube-scheduler,tier=control-plane

kube-system            storage-provisioner                                                 1/1     Running     1          2m2s   addonmanager.kubernetes.io/mode=Reconcile,integration-test=storage-provisioner

kubernetes-dashboard   dashboard-metrics-scraper-7b64584c5c-nmsd8                          1/1     Running     0          45s    k8s-app=dashboard-metrics-scraper,pod-template-hash=7b64584c5c

kubernetes-dashboard   kubernetes-dashboard-79d9cd965-6pghs                                1/1     Running     0          45s    k8s-app=kubernetes-dashboard,pod-template-hash=79d9cd965

helpers.go:215: (dbg) Run:  kubectl --context functional-20200221T162618.306598987-5900 describe node

helpers.go:219: (dbg) kubectl --context functional-20200221T162618.306598987-5900 describe node:

Name:               functional-20200221t162618.306598987-5900

Roles:              master

Labels:             beta.kubernetes.io/arch=amd64

beta.kubernetes.io/os=linux

kubernetes.io/arch=amd64

kubernetes.io/hostname=functional-20200221t162618.306598987-5900

kubernetes.io/os=linux

minikube.k8s.io/commit=4baa941e1b6173be3295a31d4bbce19c721db465

minikube.k8s.io/name=functional-20200221T162618.306598987-5900

minikube.k8s.io/updated_at=2020_02_21T16_27_17_0700

minikube.k8s.io/version=v1.7.3

node-role.kubernetes.io/master=

Annotations:        kubeadm.alpha.kubernetes.io/cri-socket: /var/run/dockershim.sock

node.alpha.kubernetes.io/ttl: 0

volumes.kubernetes.io/controller-managed-attach-detach: true

CreationTimestamp:  Fri, 21 Feb 2020 16:27:11 -0800

Taints:             <none>

Unschedulable:      false

Lease:

HolderIdentity:  functional-20200221t162618.306598987-5900

AcquireTime:     <unset>

RenewTime:       Fri, 21 Feb 2020 16:29:20 -0800

Conditions:

Type             Status  LastHeartbeatTime                 LastTransitionTime                Reason                       Message

----             ------  -----------------                 ------------------                ------                       -------

MemoryPressure   False   Fri, 21 Feb 2020 16:29:15 -0800   Fri, 21 Feb 2020 16:27:05 -0800   KubeletHasSufficientMemory   kubelet has sufficient memory available

DiskPressure     False   Fri, 21 Feb 2020 16:29:15 -0800   Fri, 21 Feb 2020 16:27:05 -0800   KubeletHasNoDiskPressure     kubelet has no disk pressure

PIDPressure      False   Fri, 21 Feb 2020 16:29:15 -0800   Fri, 21 Feb 2020 16:27:05 -0800   KubeletHasSufficientPID      kubelet has sufficient PID available

Ready            True    Fri, 21 Feb 2020 16:29:15 -0800   Fri, 21 Feb 2020 16:27:25 -0800   KubeletReady                 kubelet is posting ready status

Addresses:

InternalIP:  172.17.0.2

Hostname:    functional-20200221t162618.306598987-5900

Capacity:

cpu:                8

ephemeral-storage:  515928484Ki

hugepages-1Gi:      0

hugepages-2Mi:      0

memory:             30887012Ki

pods:               110

Allocatable:

cpu:                8

ephemeral-storage:  475479690068

hugepages-1Gi:      0

hugepages-2Mi:      0

memory:             30784612Ki

pods:               110

System Info:

Machine ID:                 4810e8ef468b466cb63af00d84169a59

System UUID:                2b10145a-eff7-4f6b-8b02-bc1e237e0ddd

Boot ID:                    c3ffdf3d-9c8e-486e-8376-faccf0fe3cdb

Kernel Version:             4.9.0-12-amd64

OS Image:                   Ubuntu 19.10

Operating System:           linux

Architecture:               amd64

Container Runtime Version:  docker://19.3.2

Kubelet Version:            v1.17.3

Kube-Proxy Version:         v1.17.3

PodCIDR:                      10.244.0.0/24

PodCIDRs:                     10.244.0.0/24

Non-terminated Pods:          (15 in total)

Namespace                   Name                                                                 CPU Requests  CPU Limits  Memory Requests  Memory Limits  AGE

---------                   ----                                                                 ------------  ----------  ---------------  -------------  ---

default                     busybox                                                              0 (0%)        0 (0%)      0 (0%)           0 (0%)         54s

default                     hello-node-7676b5fb8d-9jr6t                                          0 (0%)        0 (0%)      0 (0%)           0 (0%)         72s

default                     mysql-5787d7b5fc-5vtxl                                               0 (0%)        0 (0%)      0 (0%)           0 (0%)         104s

default                     nginx-svc                                                            0 (0%)        0 (0%)      0 (0%)           0 (0%)         102s

kube-system                 coredns-6955765f44-d9tbf                                             100m (1%)     0 (0%)      70Mi (0%)        170Mi (0%)     105s

kube-system                 coredns-6955765f44-f5f27                                             100m (1%)     0 (0%)      70Mi (0%)        170Mi (0%)     105s

kube-system                 etcd-functional-20200221t162618.306598987-5900                       0 (0%)        0 (0%)      0 (0%)           0 (0%)         2m4s

kube-system                 kindnet-6klzh                                                        100m (1%)     100m (1%)   50Mi (0%)        50Mi (0%)      105s

kube-system                 kube-apiserver-functional-20200221t162618.306598987-5900             250m (3%)     0 (0%)      0 (0%)           0 (0%)         2m4s

kube-system                 kube-controller-manager-functional-20200221t162618.306598987-5900    200m (2%)     0 (0%)      0 (0%)           0 (0%)         2m4s

kube-system                 kube-proxy-7msdx                                                     0 (0%)        0 (0%)      0 (0%)           0 (0%)         105s

kube-system                 kube-scheduler-functional-20200221t162618.306598987-5900             100m (1%)     0 (0%)      0 (0%)           0 (0%)         2m4s

kube-system                 storage-provisioner                                                  0 (0%)        0 (0%)      0 (0%)           0 (0%)         2m2s

kubernetes-dashboard        dashboard-metrics-scraper-7b64584c5c-nmsd8                           0 (0%)        0 (0%)      0 (0%)           0 (0%)         45s

kubernetes-dashboard        kubernetes-dashboard-79d9cd965-6pghs                                 0 (0%)        0 (0%)      0 (0%)           0 (0%)         45s

Allocated resources:

(Total limits may be over 100 percent, i.e., overcommitted.)

Resource           Requests    Limits

--------           --------    ------

cpu                850m (10%)  100m (1%)

memory             190Mi (0%)  390Mi (1%)

ephemeral-storage  0 (0%)      0 (0%)

Events:

Type    Reason                   Age                    From                                                   Message

----    ------                   ----                   ----                                                   -------

Normal  NodeHasSufficientMemory  2m17s (x5 over 2m18s)  kubelet, functional-20200221t162618.306598987-5900     Node functional-20200221t162618.306598987-5900 status is now: NodeHasSufficientMemory

Normal  NodeHasNoDiskPressure    2m17s (x4 over 2m18s)  kubelet, functional-20200221t162618.306598987-5900     Node functional-20200221t162618.306598987-5900 status is now: NodeHasNoDiskPressure

Normal  NodeHasSufficientPID     2m17s (x4 over 2m18s)  kubelet, functional-20200221t162618.306598987-5900     Node functional-20200221t162618.306598987-5900 status is now: NodeHasSufficientPID

Normal  Starting                 2m7s                   kubelet, functional-20200221t162618.306598987-5900     Starting kubelet.

Normal  NodeHasSufficientMemory  2m7s                   kubelet, functional-20200221t162618.306598987-5900     Node functional-20200221t162618.306598987-5900 status is now: NodeHasSufficientMemory

Normal  NodeHasNoDiskPressure    2m7s                   kubelet, functional-20200221t162618.306598987-5900     Node functional-20200221t162618.306598987-5900 status is now: NodeHasNoDiskPressure

Normal  NodeHasSufficientPID     2m7s                   kubelet, functional-20200221t162618.306598987-5900     Node functional-20200221t162618.306598987-5900 status is now: NodeHasSufficientPID

Normal  NodeNotReady             2m6s                   kubelet, functional-20200221t162618.306598987-5900     Node functional-20200221t162618.306598987-5900 status is now: NodeNotReady

Normal  NodeAllocatableEnforced  2m6s                   kubelet, functional-20200221t162618.306598987-5900     Updated Node Allocatable limit across pods

Normal  NodeReady                116s                   kubelet, functional-20200221t162618.306598987-5900     Node functional-20200221t162618.306598987-5900 status is now: NodeReady

Normal  Starting                 102s                   kube-proxy, functional-20200221t162618.306598987-5900  Starting kube-proxy.

helpers.go:221: <<< TestFunctional FAILED: end of post-mortem logs <<<

helpers.go:160: (dbg) Run:  out/minikube-linux-amd64 delete -p functional-20200221T162618.306598987-5900

helpers.go:160: (dbg) Done: out/minikube-linux-amd64 delete -p functional-20200221T162618.306598987-5900: (2.864525296s)

=== RUN   TestFunctional/parallel/AddonsCmd

=== PAUSE TestFunctional/parallel/AddonsCmd

=== CONT  TestFunctional/parallel/AddonsCmd

> docker-machine-driver-kvm2.sha256: 65 B / 65 B [-------] 100.00% ? p/s 0s=== CONT  TestFunctional/parallel/NodeLabels

--- PASS: TestFunctional/parallel/AddonsCmd (0.20s)

functional_test.go:665: (dbg) Run:  out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 addons list

functional_test.go:676: (dbg) Run:  out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 addons list -o json

=== RUN   TestFunctional/parallel/PersistentVolumeClaim

=== PAUSE TestFunctional/parallel/PersistentVolumeClaim

=== CONT  TestFunctional/parallel/PersistentVolumeClaim

--- PASS: TestFunctional/parallel/PersistentVolumeClaim (12.65s)

fn_pvc.go:40: (dbg) TestFunctional/parallel/PersistentVolumeClaim: waiting 4m0s for pods matching "integration-test=storage-provisioner" in namespace "kube-system" ...

helpers.go:279: "storage-provisioner" [9564fc93-aa7e-418a-be0a-0261cd36c64b] Running

fn_pvc.go:40: (dbg) TestFunctional/parallel/PersistentVolumeClaim: integration-test=storage-provisioner healthy within 5.616666429s

fn_pvc.go:45: (dbg) Run:  kubectl --context functional-20200221T162618.306598987-5900 get storageclass -o=json

fn_pvc.go:65: (dbg) Run:  kubectl --context functional-20200221T162618.306598987-5900 apply -f testdata/pvc.yaml

fn_pvc.go:71: (dbg) Run:  kubectl --context functional-20200221T162618.306598987-5900 get pvc testpvc -o=json

fn_pvc.go:71: (dbg) Run:  kubectl --context functional-20200221T162618.306598987-5900 get pvc testpvc -o=json

fn_pvc.go:71: (dbg) Run:  kubectl --context functional-20200221T162618.306598987-5900 get pvc testpvc -o=json

=== RUN   TestFunctional/parallel/TunnelCmd

=== PAUSE TestFunctional/parallel/TunnelCmd

=== CONT  TestFunctional/parallel/TunnelCmd

--- PASS: TestFunctional/parallel/TunnelCmd (27.14s)

fn_tunnel_cmd.go:63: (dbg) daemon: [out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 tunnel --alsologtostderr -v=1]

fn_tunnel_cmd.go:70: (dbg) Run:  kubectl --context functional-20200221T162618.306598987-5900 apply -f testdata/testsvc.yaml

fn_tunnel_cmd.go:74: (dbg) TestFunctional/parallel/TunnelCmd: waiting 4m0s for pods matching "run=nginx-svc" in namespace "default" ...

helpers.go:279: "nginx-svc" [9c92c7ab-9c88-469c-b297-c3fc92d3110d] Pending / Ready:ContainersNotReady (containers with unready status: [nginx]) / ContainersReady:ContainersNotReady (containers with unready status: [nginx])

helpers.go:279: "nginx-svc" [9c92c7ab-9c88-469c-b297-c3fc92d3110d] Running

fn_tunnel_cmd.go:74: (dbg) TestFunctional/parallel/TunnelCmd: run=nginx-svc healthy within 26.089690807s

fn_tunnel_cmd.go:85: (dbg) Run:  kubectl --context functional-20200221T162618.306598987-5900 get svc nginx-svc -o jsonpath={.status.loadBalancer.ingress[0].ip}

fn_tunnel_cmd.go:130: (dbg) stopping [out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 tunnel --alsologtostderr -v=1] ...

=== RUN   TestFunctional/parallel/SSHCmd

=== PAUSE TestFunctional/parallel/SSHCmd

=== CONT  TestFunctional/parallel/SSHCmd

--- PASS: TestFunctional/parallel/SSHCmd (0.40s)

functional_test.go:693: (dbg) Run:  out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 ssh "echo hello"

=== RUN   TestFunctional/parallel/MySQL

=== PAUSE TestFunctional/parallel/MySQL

=== CONT  TestFunctional/parallel/MySQL

--- PASS: TestFunctional/parallel/MySQL (59.42s)

functional_test.go:704: (dbg) Run:  kubectl --context functional-20200221T162618.306598987-5900 replace --force -f testdata/mysql.yaml

functional_test.go:709: (dbg) TestFunctional/parallel/MySQL: waiting 10m0s for pods matching "app=mysql" in namespace "default" ...

helpers.go:279: "mysql-5787d7b5fc-5vtxl" [b2e0492c-9575-430b-b594-9d3e75fce03b] Pending / Ready:ContainersNotReady (containers with unready status: [mysql]) / ContainersReady:ContainersNotReady (containers with unready status: [mysql])

helpers.go:279: "mysql-5787d7b5fc-5vtxl" [b2e0492c-9575-430b-b594-9d3e75fce03b] Running

functional_test.go:709: (dbg) TestFunctional/parallel/MySQL: app=mysql healthy within 27.500414804s

functional_test.go:716: (dbg) Run:  kubectl --context functional-20200221T162618.306598987-5900 exec mysql-5787d7b5fc-5vtxl -- mysql -ppassword -e "show databases;"

functional_test.go:716: (dbg) Non-zero exit: kubectl --context functional-20200221T162618.306598987-5900 exec mysql-5787d7b5fc-5vtxl -- mysql -ppassword -e "show databases;": exit status 1 (436.128633ms)

** stderr ** 

Warning: Using a password on the command line interface can be insecure.

ERROR 2002 (HY000): Can't connect to local MySQL server through socket '/var/run/mysqld/mysqld.sock' (2)

command terminated with exit code 1

** /stderr **

functional_test.go:716: (dbg) Run:  kubectl --context functional-20200221T162618.306598987-5900 exec mysql-5787d7b5fc-5vtxl -- mysql -ppassword -e "show databases;"

functional_test.go:716: (dbg) Non-zero exit: kubectl --context functional-20200221T162618.306598987-5900 exec mysql-5787d7b5fc-5vtxl -- mysql -ppassword -e "show databases;": exit status 1 (410.075256ms)

** stderr ** 

Warning: Using a password on the command line interface can be insecure.

ERROR 1045 (28000): Access denied for user 'root'@'localhost' (using password: YES)

command terminated with exit code 1

** /stderr **

functional_test.go:716: (dbg) Run:  kubectl --context functional-20200221T162618.306598987-5900 exec mysql-5787d7b5fc-5vtxl -- mysql -ppassword -e "show databases;"

functional_test.go:716: (dbg) Non-zero exit: kubectl --context functional-20200221T162618.306598987-5900 exec mysql-5787d7b5fc-5vtxl -- mysql -ppassword -e "show databases;": exit status 1 (1.691169406s)

** stderr ** 

Warning: Using a password on the command line interface can be insecure.

ERROR 2002 (HY000): Can't connect to local MySQL server through socket '/var/run/mysqld/mysqld.sock' (2)

command terminated with exit code 1

** /stderr **

functional_test.go:716: (dbg) Run:  kubectl --context functional-20200221T162618.306598987-5900 exec mysql-5787d7b5fc-5vtxl -- mysql -ppassword -e "show databases;"

=== RUN   TestFunctional/parallel/FileSync

=== PAUSE TestFunctional/parallel/FileSync

=== CONT  TestFunctional/parallel/FileSync

--- PASS: TestFunctional/parallel/FileSync (0.53s)

functional_test.go:751: Checking for existence of /etc/test/nested/copy/5900/hosts within VM

functional_test.go:752: (dbg) Run:  out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 ssh "cat /etc/test/nested/copy/5900/hosts"

functional_test.go:757: file sync test content: Test file for checking file sync process

=== RUN   TestFunctional/parallel/UpdateContextCmd

=== PAUSE TestFunctional/parallel/UpdateContextCmd

=== CONT  TestFunctional/parallel/UpdateContextCmd

--- PASS: TestFunctional/parallel/UpdateContextCmd (2.07s)

functional_test.go:771: (dbg) Run:  out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 update-context --alsologtostderr -v=2

functional_test.go:771: (dbg) Done: out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 update-context --alsologtostderr -v=2: (2.071834207s)

=== RUN   TestFunctional/parallel/DockerEnv

=== PAUSE TestFunctional/parallel/DockerEnv

=== CONT  TestFunctional/parallel/DockerEnv

> minikube-linux-amd64: 4.00 MiB / 48.25 MiB [->____________] 8.29% ? p/s ?    > docker-machine-driver-kvm2: 18.02 MiB / 48.57 MiB [-->___] 37.09% ? p/s ?    > minikube-linux-amd64: 40.00 MiB / 48.25 MiB [--------->__] 82.90% ? p/s ?    > docker-machine-driver-kvm2: 39.39 MiB / 48.57 MiB [---->_] 81.09% ? p/s ?    > minikube-linux-amd64: 48.25 MiB / 48.25 MiB [-] 100.00% 123.69 MiB p/s 1s    > docker-machine-driver-kvm2: 48.57 MiB / 48.57 MiB  100.00% 163.43 MiB p/s    > docker-machine-driver-kvm2.sha256: 65 B / 65 B [-------] 100.00% ? p/s 0s    > docker-machine-driver-kvm2: 20.06 MiB / 48.57 MiB [-->___] 41.29% ? p/s ?    > docker-machine-driver-kvm2: 25.39 MiB / 48.57 MiB [--->__] 52.26% ? p/s ?    > docker-machine-driver-kvm2: 36.77 MiB / 48.57 MiB [---->_] 75.70% ? p/s ?    > docker-machine-driver-kvm2: 48.57 MiB / 48.57 MiB  100.00% 92.59 MiB p/s --- PASS: TestKVMDriverInstallOrUpdate (3.34s)

--- PASS: TestFunctional/parallel/DockerEnv (6.55s)

functional_test.go:147: (dbg) Run:  /bin/bash -c "eval $(out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 docker-env) && out/minikube-linux-amd64 status -p functional-20200221T162618.306598987-5900"

functional_test.go:147: (dbg) Done: /bin/bash -c "eval $(out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 docker-env) && out/minikube-linux-amd64 status -p functional-20200221T162618.306598987-5900": (5.641167592s)

functional_test.go:159: (dbg) Run:  /bin/bash -c "eval $(out/minikube-linux-amd64 -p functional-20200221T162618.306598987-5900 docker-env) && docker images"

=== RUN   TestFunctional/parallel/NodeLabels

=== PAUSE TestFunctional/parallel/NodeLabels

--- PASS: TestFunctional/parallel/NodeLabels (0.14s)

functional_test.go:129: (dbg) Run:  kubectl --context functional-20200221T162618.306598987-5900 get nodes --output=go-template "--template='{{range $k, $v := (index .items 0).metadata.labels}}{{$k}} {{end}}'"

=== RUN   TestFunctional/parallel/ProfileCmd/profile_not_create

--- PASS: TestFunctional/parallel/ProfileCmd/profile_not_create (0.79s)

functional_test.go:515: (dbg) Run:  out/minikube-linux-amd64 profile lis

functional_test.go:519: (dbg) Run:  out/minikube-linux-amd64 profile list --output json

=== RUN   TestFunctional/parallel/ProfileCmd/profile_json_output

--- PASS: TestFunctional/parallel/ProfileCmd/profile_json_output (1.06s)

functional_test.go:563: (dbg) Run:  out/minikube-linux-amd64 profile list --output json

functional_test.go:563: (dbg) Done: out/minikube-linux-amd64 profile list --output json: (1.063761125s)

=== RUN   TestDownloadOnly/group/ExpectedDefaultDriver

--- SKIP: TestDownloadOnly/group/ExpectedDefaultDriver (0.00s)

aaa_download_only_test.go:112: --expected-default-driver is unset, skipping test

=== RUN   TestHyperKitDriverInstallOrUpdate

--- SKIP: TestHyperKitDriverInstallOrUpdate (0.00s)

driver_install_or_update_test.go:101: Skip if not darwin.

=== RUN   TestGvisorAddon

--- SKIP: TestGvisorAddon (0.00s)

gvisor_addon_test.go:33: skipping test because --gvisor=false

=== RUN   TestChangeNoneUser

--- SKIP: TestChangeNoneUser (0.00s)

none_test.go:38: Only test none driver.