=== RUN TestPreload
preload_test.go:44: (dbg) Run: out/minikube-linux-amd64 start -p test-preload-015503 --memory=2200 --alsologtostderr --wait=true --preload=false --driver=kvm2 --kubernetes-version=v1.24.4
E1226 22:15:03.654230 215337 cert_rotation.go:168] key failed with : open /home/jenkins/minikube-integration/17857-208151/.minikube/profiles/functional-091879/client.crt: no such file or directory
preload_test.go:44: (dbg) Done: out/minikube-linux-amd64 start -p test-preload-015503 --memory=2200 --alsologtostderr --wait=true --preload=false --driver=kvm2 --kubernetes-version=v1.24.4: (1m35.005782719s)
preload_test.go:52: (dbg) Run: out/minikube-linux-amd64 -p test-preload-015503 image pull gcr.io/k8s-minikube/busybox
preload_test.go:52: (dbg) Done: out/minikube-linux-amd64 -p test-preload-015503 image pull gcr.io/k8s-minikube/busybox: (1.246508385s)
preload_test.go:58: (dbg) Run: out/minikube-linux-amd64 stop -p test-preload-015503
preload_test.go:58: (dbg) Done: out/minikube-linux-amd64 stop -p test-preload-015503: (13.115685198s)
preload_test.go:66: (dbg) Run: out/minikube-linux-amd64 start -p test-preload-015503 --memory=2200 --alsologtostderr -v=1 --wait=true --driver=kvm2
preload_test.go:66: (dbg) Non-zero exit: out/minikube-linux-amd64 start -p test-preload-015503 --memory=2200 --alsologtostderr -v=1 --wait=true --driver=kvm2 : exit status 90 (27.248537874s)
-- stdout --
* [test-preload-015503] minikube v1.32.0 on Ubuntu 20.04 (kvm/amd64)
- MINIKUBE_LOCATION=17857
- MINIKUBE_SUPPRESS_DOCKER_PERFORMANCE=true
- KUBECONFIG=/home/jenkins/minikube-integration/17857-208151/kubeconfig
- MINIKUBE_HOME=/home/jenkins/minikube-integration/17857-208151/.minikube
- MINIKUBE_BIN=out/minikube-linux-amd64
- MINIKUBE_FORCE_SYSTEMD=
* Kubernetes 1.28.4 is now available. If you would like to upgrade, specify: --kubernetes-version=v1.28.4
* Using the kvm2 driver based on existing profile
* Starting control plane node test-preload-015503 in cluster test-preload-015503
* Downloading Kubernetes v1.24.4 preload ...
* Restarting existing kvm2 VM for "test-preload-015503" ...
-- /stdout --
** stderr **
I1226 22:15:30.725834 233786 out.go:296] Setting OutFile to fd 1 ...
I1226 22:15:30.726107 233786 out.go:343] TERM=,COLORTERM=, which probably does not support color
I1226 22:15:30.726118 233786 out.go:309] Setting ErrFile to fd 2...
I1226 22:15:30.726122 233786 out.go:343] TERM=,COLORTERM=, which probably does not support color
I1226 22:15:30.726349 233786 root.go:338] Updating PATH: /home/jenkins/minikube-integration/17857-208151/.minikube/bin
I1226 22:15:30.726879 233786 out.go:303] Setting JSON to false
I1226 22:15:30.727778 233786 start.go:128] hostinfo: {"hostname":"ubuntu-20-agent-3","uptime":21483,"bootTime":1703607448,"procs":215,"os":"linux","platform":"ubuntu","platformFamily":"debian","platformVersion":"20.04","kernelVersion":"5.15.0-1047-gcp","kernelArch":"x86_64","virtualizationSystem":"kvm","virtualizationRole":"guest","hostId":"591c9f12-2938-3743-e2bf-c56a050d43d1"}
I1226 22:15:30.727839 233786 start.go:138] virtualization: kvm guest
I1226 22:15:30.730357 233786 out.go:177] * [test-preload-015503] minikube v1.32.0 on Ubuntu 20.04 (kvm/amd64)
I1226 22:15:30.732269 233786 notify.go:220] Checking for updates...
I1226 22:15:30.732286 233786 out.go:177] - MINIKUBE_LOCATION=17857
I1226 22:15:30.733896 233786 out.go:177] - MINIKUBE_SUPPRESS_DOCKER_PERFORMANCE=true
I1226 22:15:30.735413 233786 out.go:177] - KUBECONFIG=/home/jenkins/minikube-integration/17857-208151/kubeconfig
I1226 22:15:30.736737 233786 out.go:177] - MINIKUBE_HOME=/home/jenkins/minikube-integration/17857-208151/.minikube
I1226 22:15:30.738171 233786 out.go:177] - MINIKUBE_BIN=out/minikube-linux-amd64
I1226 22:15:30.739670 233786 out.go:177] - MINIKUBE_FORCE_SYSTEMD=
I1226 22:15:30.741382 233786 config.go:182] Loaded profile config "test-preload-015503": Driver=kvm2, ContainerRuntime=docker, KubernetesVersion=v1.24.4
I1226 22:15:30.741768 233786 main.go:141] libmachine: Found binary path at /home/jenkins/workspace/KVM_Linux_integration/out/docker-machine-driver-kvm2
I1226 22:15:30.741814 233786 main.go:141] libmachine: Launching plugin server for driver kvm2
I1226 22:15:30.756072 233786 main.go:141] libmachine: Plugin server listening at address 127.0.0.1:38107
I1226 22:15:30.756574 233786 main.go:141] libmachine: () Calling .GetVersion
I1226 22:15:30.757233 233786 main.go:141] libmachine: Using API Version 1
I1226 22:15:30.757261 233786 main.go:141] libmachine: () Calling .SetConfigRaw
I1226 22:15:30.757628 233786 main.go:141] libmachine: () Calling .GetMachineName
I1226 22:15:30.757804 233786 main.go:141] libmachine: (test-preload-015503) Calling .DriverName
I1226 22:15:30.760160 233786 out.go:177] * Kubernetes 1.28.4 is now available. If you would like to upgrade, specify: --kubernetes-version=v1.28.4
I1226 22:15:30.761910 233786 driver.go:392] Setting default libvirt URI to qemu:///system
I1226 22:15:30.762201 233786 main.go:141] libmachine: Found binary path at /home/jenkins/workspace/KVM_Linux_integration/out/docker-machine-driver-kvm2
I1226 22:15:30.762237 233786 main.go:141] libmachine: Launching plugin server for driver kvm2
I1226 22:15:30.776612 233786 main.go:141] libmachine: Plugin server listening at address 127.0.0.1:35641
I1226 22:15:30.776981 233786 main.go:141] libmachine: () Calling .GetVersion
I1226 22:15:30.777392 233786 main.go:141] libmachine: Using API Version 1
I1226 22:15:30.777412 233786 main.go:141] libmachine: () Calling .SetConfigRaw
I1226 22:15:30.777745 233786 main.go:141] libmachine: () Calling .GetMachineName
I1226 22:15:30.777948 233786 main.go:141] libmachine: (test-preload-015503) Calling .DriverName
I1226 22:15:30.812047 233786 out.go:177] * Using the kvm2 driver based on existing profile
I1226 22:15:30.813625 233786 start.go:298] selected driver: kvm2
I1226 22:15:30.813642 233786 start.go:902] validating driver "kvm2" against &{Name:test-preload-015503 KeepContext:false EmbedCerts:false MinikubeISO:https://storage.googleapis.com/minikube-builds/iso/17806/minikube-v1.32.1-1702708929-17806-amd64.iso KicBaseImage:gcr.io/k8s-minikube/kicbase-builds:v0.0.42-1703498848-17857@sha256:81ae12a49915e4f02aa382dd3758a30a6649e1143c32b3d03309750104577c6c Memory:2200 CPUs:2 DiskSize:20000 VMDriver: Driver:kvm2 HyperkitVpnKitSock: HyperkitVSockPorts:[] DockerEnv:[] ContainerVolumeMounts:[] InsecureRegistry:[] RegistryMirror:[] HostOnlyCIDR:192.168.59.1/24 HypervVirtualSwitch: HypervUseExternalSwitch:false HypervExternalAdapter: KVMNetwork:default KVMQemuURI:qemu:///system KVMGPU:false KVMHidden:false KVMNUMACount:1 APIServerPort:0 DockerOpt:[] DisableDriverMounts:false NFSShare:[] NFSSharesRoot:/nfsshares UUID: NoVTXCheck:false DNSProxy:false HostDNSResolver:true HostOnlyNicType:virtio NatNicType:virtio SSHIPAddress: SSHUser:root SSHKey: SSHPort:22 KubernetesConf
ig:{KubernetesVersion:v1.24.4 ClusterName:test-preload-015503 Namespace:default APIServerName:minikubeCA APIServerNames:[] APIServerIPs:[] DNSDomain:cluster.local ContainerRuntime:docker CRISocket: NetworkPlugin:cni FeatureGates: ServiceCIDR:10.96.0.0/12 ImageRepository: LoadBalancerStartIP: LoadBalancerEndIP: CustomIngressCert: RegistryAliases: ExtraOptions:[] ShouldLoadCachedImages:true EnableDefaultCNI:false CNI: NodeIP: NodePort:8443 NodeName:} Nodes:[{Name: IP:192.168.39.177 Port:8443 KubernetesVersion:v1.24.4 ContainerRuntime:docker ControlPlane:true Worker:true}] Addons:map[default-storageclass:true storage-provisioner:true] CustomAddonImages:map[] CustomAddonRegistries:map[] VerifyComponents:map[apiserver:true apps_running:true default_sa:true extra:true kubelet:true node_ready:true system_pods:true] StartHostTimeout:6m0s ScheduledStop:<nil> ExposedPorts:[] ListenAddress: Network: Subnet: MultiNodeRequested:false ExtraDisks:0 CertExpiration:26280h0m0s Mount:false MountString:/home/jenkins:/minikube-ho
st Mount9PVersion:9p2000.L MountGID:docker MountIP: MountMSize:262144 MountOptions:[] MountPort:0 MountType:9p MountUID:docker BinaryMirror: DisableOptimizations:false DisableMetrics:false CustomQemuFirmwarePath: SocketVMnetClientPath: SocketVMnetPath: StaticIP: SSHAuthSock: SSHAgentPID:0 AutoPauseInterval:1m0s GPUs:}
I1226 22:15:30.813766 233786 start.go:913] status for kvm2: {Installed:true Healthy:true Running:true NeedsImprovement:false Error:<nil> Reason: Fix: Doc: Version:}
I1226 22:15:30.814486 233786 install.go:52] acquiring lock: {Name:mk900956b073697a4aa6c80a27c6bb0742a99a53 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I1226 22:15:30.814580 233786 install.go:117] Validating docker-machine-driver-kvm2, PATH=/home/jenkins/minikube-integration/17857-208151/.minikube/bin:/home/jenkins/workspace/KVM_Linux_integration/out/:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games:/usr/local/go/bin:/home/jenkins/go/bin:/usr/local/bin/:/usr/local/go/bin/:/home/jenkins/go/bin
I1226 22:15:30.829060 233786 install.go:137] /home/jenkins/workspace/KVM_Linux_integration/out/docker-machine-driver-kvm2 version is 1.32.0
I1226 22:15:30.829388 233786 start_flags.go:931] Waiting for all components: map[apiserver:true apps_running:true default_sa:true extra:true kubelet:true node_ready:true system_pods:true]
I1226 22:15:30.829445 233786 cni.go:84] Creating CNI manager for ""
I1226 22:15:30.829462 233786 cni.go:158] "kvm2" driver + "docker" container runtime found on kubernetes v1.24+, recommending bridge
I1226 22:15:30.829473 233786 start_flags.go:323] config:
{Name:test-preload-015503 KeepContext:false EmbedCerts:false MinikubeISO:https://storage.googleapis.com/minikube-builds/iso/17806/minikube-v1.32.1-1702708929-17806-amd64.iso KicBaseImage:gcr.io/k8s-minikube/kicbase-builds:v0.0.42-1703498848-17857@sha256:81ae12a49915e4f02aa382dd3758a30a6649e1143c32b3d03309750104577c6c Memory:2200 CPUs:2 DiskSize:20000 VMDriver: Driver:kvm2 HyperkitVpnKitSock: HyperkitVSockPorts:[] DockerEnv:[] ContainerVolumeMounts:[] InsecureRegistry:[] RegistryMirror:[] HostOnlyCIDR:192.168.59.1/24 HypervVirtualSwitch: HypervUseExternalSwitch:false HypervExternalAdapter: KVMNetwork:default KVMQemuURI:qemu:///system KVMGPU:false KVMHidden:false KVMNUMACount:1 APIServerPort:0 DockerOpt:[] DisableDriverMounts:false NFSShare:[] NFSSharesRoot:/nfsshares UUID: NoVTXCheck:false DNSProxy:false HostDNSResolver:true HostOnlyNicType:virtio NatNicType:virtio SSHIPAddress: SSHUser:root SSHKey: SSHPort:22 KubernetesConfig:{KubernetesVersion:v1.24.4 ClusterName:test-preload-015503 Namespace:defaul
t APIServerName:minikubeCA APIServerNames:[] APIServerIPs:[] DNSDomain:cluster.local ContainerRuntime:docker CRISocket: NetworkPlugin:cni FeatureGates: ServiceCIDR:10.96.0.0/12 ImageRepository: LoadBalancerStartIP: LoadBalancerEndIP: CustomIngressCert: RegistryAliases: ExtraOptions:[] ShouldLoadCachedImages:true EnableDefaultCNI:false CNI: NodeIP: NodePort:8443 NodeName:} Nodes:[{Name: IP:192.168.39.177 Port:8443 KubernetesVersion:v1.24.4 ContainerRuntime:docker ControlPlane:true Worker:true}] Addons:map[default-storageclass:true storage-provisioner:true] CustomAddonImages:map[] CustomAddonRegistries:map[] VerifyComponents:map[apiserver:true apps_running:true default_sa:true extra:true kubelet:true node_ready:true system_pods:true] StartHostTimeout:6m0s ScheduledStop:<nil> ExposedPorts:[] ListenAddress: Network: Subnet: MultiNodeRequested:false ExtraDisks:0 CertExpiration:26280h0m0s Mount:false MountString:/home/jenkins:/minikube-host Mount9PVersion:9p2000.L MountGID:docker MountIP: MountMSize:262144 MountOpt
ions:[] MountPort:0 MountType:9p MountUID:docker BinaryMirror: DisableOptimizations:false DisableMetrics:false CustomQemuFirmwarePath: SocketVMnetClientPath: SocketVMnetPath: StaticIP: SSHAuthSock: SSHAgentPID:0 AutoPauseInterval:1m0s GPUs:}
I1226 22:15:30.829641 233786 iso.go:125] acquiring lock: {Name:mk8919db102251b156db2c1fe3d2a20f4430e4b3 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I1226 22:15:30.831319 233786 out.go:177] * Starting control plane node test-preload-015503 in cluster test-preload-015503
I1226 22:15:30.832609 233786 preload.go:132] Checking if preload exists for k8s version v1.24.4 and runtime docker
I1226 22:15:30.857905 233786 preload.go:119] Found remote preload: https://storage.googleapis.com/minikube-preloaded-volume-tarballs/v18/v1.24.4/preloaded-images-k8s-v18-v1.24.4-docker-overlay2-amd64.tar.lz4
I1226 22:15:30.857929 233786 cache.go:56] Caching tarball of preloaded images
I1226 22:15:30.858063 233786 preload.go:132] Checking if preload exists for k8s version v1.24.4 and runtime docker
I1226 22:15:30.859863 233786 out.go:177] * Downloading Kubernetes v1.24.4 preload ...
I1226 22:15:30.861167 233786 preload.go:238] getting checksum for preloaded-images-k8s-v18-v1.24.4-docker-overlay2-amd64.tar.lz4 ...
I1226 22:15:30.887403 233786 download.go:107] Downloading: https://storage.googleapis.com/minikube-preloaded-volume-tarballs/v18/v1.24.4/preloaded-images-k8s-v18-v1.24.4-docker-overlay2-amd64.tar.lz4?checksum=md5:20cbd62a1b5d1968f21881a4a0f4f59e -> /home/jenkins/minikube-integration/17857-208151/.minikube/cache/preloaded-tarball/preloaded-images-k8s-v18-v1.24.4-docker-overlay2-amd64.tar.lz4
I1226 22:15:33.762135 233786 preload.go:249] saving checksum for preloaded-images-k8s-v18-v1.24.4-docker-overlay2-amd64.tar.lz4 ...
I1226 22:15:33.762245 233786 preload.go:256] verifying checksum of /home/jenkins/minikube-integration/17857-208151/.minikube/cache/preloaded-tarball/preloaded-images-k8s-v18-v1.24.4-docker-overlay2-amd64.tar.lz4 ...
I1226 22:15:34.617537 233786 cache.go:59] Finished verifying existence of preloaded tar for v1.24.4 on docker
I1226 22:15:34.617702 233786 profile.go:148] Saving config to /home/jenkins/minikube-integration/17857-208151/.minikube/profiles/test-preload-015503/config.json ...
I1226 22:15:34.617957 233786 start.go:365] acquiring machines lock for test-preload-015503: {Name:mk9fda4701bf6ec5ef4895c88affce55fd0f368c Clock:{} Delay:500ms Timeout:13m0s Cancel:<nil>}
I1226 22:15:34.618043 233786 start.go:369] acquired machines lock for "test-preload-015503" in 58.876µs
I1226 22:15:34.618083 233786 start.go:96] Skipping create...Using existing machine configuration
I1226 22:15:34.618088 233786 fix.go:54] fixHost starting:
I1226 22:15:34.618380 233786 main.go:141] libmachine: Found binary path at /home/jenkins/workspace/KVM_Linux_integration/out/docker-machine-driver-kvm2
I1226 22:15:34.618422 233786 main.go:141] libmachine: Launching plugin server for driver kvm2
I1226 22:15:34.632775 233786 main.go:141] libmachine: Plugin server listening at address 127.0.0.1:36891
I1226 22:15:34.633306 233786 main.go:141] libmachine: () Calling .GetVersion
I1226 22:15:34.633769 233786 main.go:141] libmachine: Using API Version 1
I1226 22:15:34.633791 233786 main.go:141] libmachine: () Calling .SetConfigRaw
I1226 22:15:34.634139 233786 main.go:141] libmachine: () Calling .GetMachineName
I1226 22:15:34.634382 233786 main.go:141] libmachine: (test-preload-015503) Calling .DriverName
I1226 22:15:34.634555 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetState
I1226 22:15:34.636218 233786 fix.go:102] recreateIfNeeded on test-preload-015503: state=Stopped err=<nil>
I1226 22:15:34.636255 233786 main.go:141] libmachine: (test-preload-015503) Calling .DriverName
W1226 22:15:34.636431 233786 fix.go:128] unexpected machine state, will restart: <nil>
I1226 22:15:34.638626 233786 out.go:177] * Restarting existing kvm2 VM for "test-preload-015503" ...
I1226 22:15:34.639821 233786 main.go:141] libmachine: (test-preload-015503) Calling .Start
I1226 22:15:34.639999 233786 main.go:141] libmachine: (test-preload-015503) Ensuring networks are active...
I1226 22:15:34.640735 233786 main.go:141] libmachine: (test-preload-015503) Ensuring network default is active
I1226 22:15:34.641013 233786 main.go:141] libmachine: (test-preload-015503) Ensuring network mk-test-preload-015503 is active
I1226 22:15:34.641322 233786 main.go:141] libmachine: (test-preload-015503) Getting domain xml...
I1226 22:15:34.641976 233786 main.go:141] libmachine: (test-preload-015503) Creating domain...
I1226 22:15:35.857310 233786 main.go:141] libmachine: (test-preload-015503) Waiting to get IP...
I1226 22:15:35.858095 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:35.858491 233786 main.go:141] libmachine: (test-preload-015503) DBG | unable to find current IP address of domain test-preload-015503 in network mk-test-preload-015503
I1226 22:15:35.858551 233786 main.go:141] libmachine: (test-preload-015503) DBG | I1226 22:15:35.858466 233832 retry.go:31] will retry after 233.00652ms: waiting for machine to come up
I1226 22:15:36.093057 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:36.093444 233786 main.go:141] libmachine: (test-preload-015503) DBG | unable to find current IP address of domain test-preload-015503 in network mk-test-preload-015503
I1226 22:15:36.093471 233786 main.go:141] libmachine: (test-preload-015503) DBG | I1226 22:15:36.093414 233832 retry.go:31] will retry after 272.373397ms: waiting for machine to come up
I1226 22:15:36.368011 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:36.368360 233786 main.go:141] libmachine: (test-preload-015503) DBG | unable to find current IP address of domain test-preload-015503 in network mk-test-preload-015503
I1226 22:15:36.368384 233786 main.go:141] libmachine: (test-preload-015503) DBG | I1226 22:15:36.368325 233832 retry.go:31] will retry after 326.317825ms: waiting for machine to come up
I1226 22:15:36.695751 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:36.696119 233786 main.go:141] libmachine: (test-preload-015503) DBG | unable to find current IP address of domain test-preload-015503 in network mk-test-preload-015503
I1226 22:15:36.696160 233786 main.go:141] libmachine: (test-preload-015503) DBG | I1226 22:15:36.696090 233832 retry.go:31] will retry after 413.475005ms: waiting for machine to come up
I1226 22:15:37.110685 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:37.111142 233786 main.go:141] libmachine: (test-preload-015503) DBG | unable to find current IP address of domain test-preload-015503 in network mk-test-preload-015503
I1226 22:15:37.111167 233786 main.go:141] libmachine: (test-preload-015503) DBG | I1226 22:15:37.111092 233832 retry.go:31] will retry after 737.743969ms: waiting for machine to come up
I1226 22:15:37.850351 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:37.850777 233786 main.go:141] libmachine: (test-preload-015503) DBG | unable to find current IP address of domain test-preload-015503 in network mk-test-preload-015503
I1226 22:15:37.850802 233786 main.go:141] libmachine: (test-preload-015503) DBG | I1226 22:15:37.850707 233832 retry.go:31] will retry after 663.756301ms: waiting for machine to come up
I1226 22:15:38.516604 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:38.516967 233786 main.go:141] libmachine: (test-preload-015503) DBG | unable to find current IP address of domain test-preload-015503 in network mk-test-preload-015503
I1226 22:15:38.516999 233786 main.go:141] libmachine: (test-preload-015503) DBG | I1226 22:15:38.516906 233832 retry.go:31] will retry after 1.014648729s: waiting for machine to come up
I1226 22:15:39.532968 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:39.533281 233786 main.go:141] libmachine: (test-preload-015503) DBG | unable to find current IP address of domain test-preload-015503 in network mk-test-preload-015503
I1226 22:15:39.533307 233786 main.go:141] libmachine: (test-preload-015503) DBG | I1226 22:15:39.533220 233832 retry.go:31] will retry after 1.371131464s: waiting for machine to come up
I1226 22:15:40.906298 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:40.906669 233786 main.go:141] libmachine: (test-preload-015503) DBG | unable to find current IP address of domain test-preload-015503 in network mk-test-preload-015503
I1226 22:15:40.906706 233786 main.go:141] libmachine: (test-preload-015503) DBG | I1226 22:15:40.906611 233832 retry.go:31] will retry after 1.462475341s: waiting for machine to come up
I1226 22:15:42.371241 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:42.371682 233786 main.go:141] libmachine: (test-preload-015503) DBG | unable to find current IP address of domain test-preload-015503 in network mk-test-preload-015503
I1226 22:15:42.371714 233786 main.go:141] libmachine: (test-preload-015503) DBG | I1226 22:15:42.371639 233832 retry.go:31] will retry after 2.18366527s: waiting for machine to come up
I1226 22:15:44.557727 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:44.558189 233786 main.go:141] libmachine: (test-preload-015503) DBG | unable to find current IP address of domain test-preload-015503 in network mk-test-preload-015503
I1226 22:15:44.558223 233786 main.go:141] libmachine: (test-preload-015503) DBG | I1226 22:15:44.558120 233832 retry.go:31] will retry after 2.435967011s: waiting for machine to come up
I1226 22:15:46.997385 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:46.997810 233786 main.go:141] libmachine: (test-preload-015503) DBG | unable to find current IP address of domain test-preload-015503 in network mk-test-preload-015503
I1226 22:15:46.997832 233786 main.go:141] libmachine: (test-preload-015503) DBG | I1226 22:15:46.997770 233832 retry.go:31] will retry after 3.285540299s: waiting for machine to come up
I1226 22:15:50.284615 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:50.284977 233786 main.go:141] libmachine: (test-preload-015503) DBG | unable to find current IP address of domain test-preload-015503 in network mk-test-preload-015503
I1226 22:15:50.285007 233786 main.go:141] libmachine: (test-preload-015503) DBG | I1226 22:15:50.284926 233832 retry.go:31] will retry after 2.921721562s: waiting for machine to come up
I1226 22:15:53.209235 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:53.209587 233786 main.go:141] libmachine: (test-preload-015503) Found IP for machine: 192.168.39.177
I1226 22:15:53.209619 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has current primary IP address 192.168.39.177 and MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:53.209664 233786 main.go:141] libmachine: (test-preload-015503) Reserving static IP address...
I1226 22:15:53.210014 233786 main.go:141] libmachine: (test-preload-015503) DBG | found host DHCP lease matching {name: "test-preload-015503", mac: "52:54:00:a2:4a:01", ip: "192.168.39.177"} in network mk-test-preload-015503: {Iface:virbr1 ExpiryTime:2023-12-26 23:13:57 +0000 UTC Type:0 Mac:52:54:00:a2:4a:01 Iaid: IPaddr:192.168.39.177 Prefix:24 Hostname:test-preload-015503 Clientid:01:52:54:00:a2:4a:01}
I1226 22:15:53.210038 233786 main.go:141] libmachine: (test-preload-015503) Reserved static IP address: 192.168.39.177
I1226 22:15:53.210057 233786 main.go:141] libmachine: (test-preload-015503) DBG | skip adding static IP to network mk-test-preload-015503 - found existing host DHCP lease matching {name: "test-preload-015503", mac: "52:54:00:a2:4a:01", ip: "192.168.39.177"}
I1226 22:15:53.210079 233786 main.go:141] libmachine: (test-preload-015503) DBG | Getting to WaitForSSH function...
I1226 22:15:53.210088 233786 main.go:141] libmachine: (test-preload-015503) Waiting for SSH to be available...
I1226 22:15:53.212159 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:53.212532 233786 main.go:141] libmachine: (test-preload-015503) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:a2:4a:01", ip: ""} in network mk-test-preload-015503: {Iface:virbr1 ExpiryTime:2023-12-26 23:13:57 +0000 UTC Type:0 Mac:52:54:00:a2:4a:01 Iaid: IPaddr:192.168.39.177 Prefix:24 Hostname:test-preload-015503 Clientid:01:52:54:00:a2:4a:01}
I1226 22:15:53.212569 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined IP address 192.168.39.177 and MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:53.212694 233786 main.go:141] libmachine: (test-preload-015503) DBG | Using SSH client type: external
I1226 22:15:53.212719 233786 main.go:141] libmachine: (test-preload-015503) DBG | Using SSH private key: /home/jenkins/minikube-integration/17857-208151/.minikube/machines/test-preload-015503/id_rsa (-rw-------)
I1226 22:15:53.212763 233786 main.go:141] libmachine: (test-preload-015503) DBG | &{[-F /dev/null -o ConnectionAttempts=3 -o ConnectTimeout=10 -o ControlMaster=no -o ControlPath=none -o LogLevel=quiet -o PasswordAuthentication=no -o ServerAliveInterval=60 -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null docker@192.168.39.177 -o IdentitiesOnly=yes -i /home/jenkins/minikube-integration/17857-208151/.minikube/machines/test-preload-015503/id_rsa -p 22] /usr/bin/ssh <nil>}
I1226 22:15:53.212774 233786 main.go:141] libmachine: (test-preload-015503) DBG | About to run SSH command:
I1226 22:15:53.212810 233786 main.go:141] libmachine: (test-preload-015503) DBG | exit 0
I1226 22:15:53.299956 233786 main.go:141] libmachine: (test-preload-015503) DBG | SSH cmd err, output: <nil>:
I1226 22:15:53.300387 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetConfigRaw
I1226 22:15:53.301080 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetIP
I1226 22:15:53.303193 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:53.303527 233786 main.go:141] libmachine: (test-preload-015503) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:a2:4a:01", ip: ""} in network mk-test-preload-015503: {Iface:virbr1 ExpiryTime:2023-12-26 23:13:57 +0000 UTC Type:0 Mac:52:54:00:a2:4a:01 Iaid: IPaddr:192.168.39.177 Prefix:24 Hostname:test-preload-015503 Clientid:01:52:54:00:a2:4a:01}
I1226 22:15:53.303559 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined IP address 192.168.39.177 and MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:53.303757 233786 profile.go:148] Saving config to /home/jenkins/minikube-integration/17857-208151/.minikube/profiles/test-preload-015503/config.json ...
I1226 22:15:53.303938 233786 machine.go:88] provisioning docker machine ...
I1226 22:15:53.303972 233786 main.go:141] libmachine: (test-preload-015503) Calling .DriverName
I1226 22:15:53.304195 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetMachineName
I1226 22:15:53.304487 233786 buildroot.go:166] provisioning hostname "test-preload-015503"
I1226 22:15:53.304510 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetMachineName
I1226 22:15:53.304671 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHHostname
I1226 22:15:53.306510 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:53.306899 233786 main.go:141] libmachine: (test-preload-015503) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:a2:4a:01", ip: ""} in network mk-test-preload-015503: {Iface:virbr1 ExpiryTime:2023-12-26 23:13:57 +0000 UTC Type:0 Mac:52:54:00:a2:4a:01 Iaid: IPaddr:192.168.39.177 Prefix:24 Hostname:test-preload-015503 Clientid:01:52:54:00:a2:4a:01}
I1226 22:15:53.306935 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined IP address 192.168.39.177 and MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:53.307153 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHPort
I1226 22:15:53.307331 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHKeyPath
I1226 22:15:53.307512 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHKeyPath
I1226 22:15:53.307669 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHUsername
I1226 22:15:53.307827 233786 main.go:141] libmachine: Using SSH client type: native
I1226 22:15:53.308203 233786 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x809380] 0x80c060 <nil> [] 0s} 192.168.39.177 22 <nil> <nil>}
I1226 22:15:53.308221 233786 main.go:141] libmachine: About to run SSH command:
sudo hostname test-preload-015503 && echo "test-preload-015503" | sudo tee /etc/hostname
I1226 22:15:53.433033 233786 main.go:141] libmachine: SSH cmd err, output: <nil>: test-preload-015503
I1226 22:15:53.433071 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHHostname
I1226 22:15:53.435752 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:53.436110 233786 main.go:141] libmachine: (test-preload-015503) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:a2:4a:01", ip: ""} in network mk-test-preload-015503: {Iface:virbr1 ExpiryTime:2023-12-26 23:13:57 +0000 UTC Type:0 Mac:52:54:00:a2:4a:01 Iaid: IPaddr:192.168.39.177 Prefix:24 Hostname:test-preload-015503 Clientid:01:52:54:00:a2:4a:01}
I1226 22:15:53.436145 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined IP address 192.168.39.177 and MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:53.436290 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHPort
I1226 22:15:53.436539 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHKeyPath
I1226 22:15:53.436740 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHKeyPath
I1226 22:15:53.436891 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHUsername
I1226 22:15:53.437080 233786 main.go:141] libmachine: Using SSH client type: native
I1226 22:15:53.437391 233786 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x809380] 0x80c060 <nil> [] 0s} 192.168.39.177 22 <nil> <nil>}
I1226 22:15:53.437408 233786 main.go:141] libmachine: About to run SSH command:
if ! grep -xq '.*\stest-preload-015503' /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 test-preload-015503/g' /etc/hosts;
else
echo '127.0.1.1 test-preload-015503' | sudo tee -a /etc/hosts;
fi
fi
I1226 22:15:53.557031 233786 main.go:141] libmachine: SSH cmd err, output: <nil>:
I1226 22:15:53.557067 233786 buildroot.go:172] set auth options {CertDir:/home/jenkins/minikube-integration/17857-208151/.minikube CaCertPath:/home/jenkins/minikube-integration/17857-208151/.minikube/certs/ca.pem CaPrivateKeyPath:/home/jenkins/minikube-integration/17857-208151/.minikube/certs/ca-key.pem CaCertRemotePath:/etc/docker/ca.pem ServerCertPath:/home/jenkins/minikube-integration/17857-208151/.minikube/machines/server.pem ServerKeyPath:/home/jenkins/minikube-integration/17857-208151/.minikube/machines/server-key.pem ClientKeyPath:/home/jenkins/minikube-integration/17857-208151/.minikube/certs/key.pem ServerCertRemotePath:/etc/docker/server.pem ServerKeyRemotePath:/etc/docker/server-key.pem ClientCertPath:/home/jenkins/minikube-integration/17857-208151/.minikube/certs/cert.pem ServerCertSANs:[] StorePath:/home/jenkins/minikube-integration/17857-208151/.minikube}
I1226 22:15:53.557110 233786 buildroot.go:174] setting up certificates
I1226 22:15:53.557123 233786 provision.go:83] configureAuth start
I1226 22:15:53.557135 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetMachineName
I1226 22:15:53.557497 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetIP
I1226 22:15:53.560240 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:53.560644 233786 main.go:141] libmachine: (test-preload-015503) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:a2:4a:01", ip: ""} in network mk-test-preload-015503: {Iface:virbr1 ExpiryTime:2023-12-26 23:13:57 +0000 UTC Type:0 Mac:52:54:00:a2:4a:01 Iaid: IPaddr:192.168.39.177 Prefix:24 Hostname:test-preload-015503 Clientid:01:52:54:00:a2:4a:01}
I1226 22:15:53.560677 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined IP address 192.168.39.177 and MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:53.560798 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHHostname
I1226 22:15:53.563370 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:53.563705 233786 main.go:141] libmachine: (test-preload-015503) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:a2:4a:01", ip: ""} in network mk-test-preload-015503: {Iface:virbr1 ExpiryTime:2023-12-26 23:13:57 +0000 UTC Type:0 Mac:52:54:00:a2:4a:01 Iaid: IPaddr:192.168.39.177 Prefix:24 Hostname:test-preload-015503 Clientid:01:52:54:00:a2:4a:01}
I1226 22:15:53.563730 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined IP address 192.168.39.177 and MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:53.563858 233786 provision.go:138] copyHostCerts
I1226 22:15:53.563926 233786 exec_runner.go:144] found /home/jenkins/minikube-integration/17857-208151/.minikube/cert.pem, removing ...
I1226 22:15:53.563941 233786 exec_runner.go:203] rm: /home/jenkins/minikube-integration/17857-208151/.minikube/cert.pem
I1226 22:15:53.564005 233786 exec_runner.go:151] cp: /home/jenkins/minikube-integration/17857-208151/.minikube/certs/cert.pem --> /home/jenkins/minikube-integration/17857-208151/.minikube/cert.pem (1123 bytes)
I1226 22:15:53.564113 233786 exec_runner.go:144] found /home/jenkins/minikube-integration/17857-208151/.minikube/key.pem, removing ...
I1226 22:15:53.564125 233786 exec_runner.go:203] rm: /home/jenkins/minikube-integration/17857-208151/.minikube/key.pem
I1226 22:15:53.564151 233786 exec_runner.go:151] cp: /home/jenkins/minikube-integration/17857-208151/.minikube/certs/key.pem --> /home/jenkins/minikube-integration/17857-208151/.minikube/key.pem (1679 bytes)
I1226 22:15:53.564208 233786 exec_runner.go:144] found /home/jenkins/minikube-integration/17857-208151/.minikube/ca.pem, removing ...
I1226 22:15:53.564215 233786 exec_runner.go:203] rm: /home/jenkins/minikube-integration/17857-208151/.minikube/ca.pem
I1226 22:15:53.564235 233786 exec_runner.go:151] cp: /home/jenkins/minikube-integration/17857-208151/.minikube/certs/ca.pem --> /home/jenkins/minikube-integration/17857-208151/.minikube/ca.pem (1082 bytes)
I1226 22:15:53.564299 233786 provision.go:112] generating server cert: /home/jenkins/minikube-integration/17857-208151/.minikube/machines/server.pem ca-key=/home/jenkins/minikube-integration/17857-208151/.minikube/certs/ca.pem private-key=/home/jenkins/minikube-integration/17857-208151/.minikube/certs/ca-key.pem org=jenkins.test-preload-015503 san=[192.168.39.177 192.168.39.177 localhost 127.0.0.1 minikube test-preload-015503]
I1226 22:15:53.639099 233786 provision.go:172] copyRemoteCerts
I1226 22:15:53.639158 233786 ssh_runner.go:195] Run: sudo mkdir -p /etc/docker /etc/docker /etc/docker
I1226 22:15:53.639184 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHHostname
I1226 22:15:53.642303 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:53.642688 233786 main.go:141] libmachine: (test-preload-015503) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:a2:4a:01", ip: ""} in network mk-test-preload-015503: {Iface:virbr1 ExpiryTime:2023-12-26 23:13:57 +0000 UTC Type:0 Mac:52:54:00:a2:4a:01 Iaid: IPaddr:192.168.39.177 Prefix:24 Hostname:test-preload-015503 Clientid:01:52:54:00:a2:4a:01}
I1226 22:15:53.642720 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined IP address 192.168.39.177 and MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:53.642920 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHPort
I1226 22:15:53.643114 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHKeyPath
I1226 22:15:53.643281 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHUsername
I1226 22:15:53.643441 233786 sshutil.go:53] new ssh client: &{IP:192.168.39.177 Port:22 SSHKeyPath:/home/jenkins/minikube-integration/17857-208151/.minikube/machines/test-preload-015503/id_rsa Username:docker}
I1226 22:15:53.729269 233786 ssh_runner.go:362] scp /home/jenkins/minikube-integration/17857-208151/.minikube/certs/ca.pem --> /etc/docker/ca.pem (1082 bytes)
I1226 22:15:53.752248 233786 ssh_runner.go:362] scp /home/jenkins/minikube-integration/17857-208151/.minikube/machines/server.pem --> /etc/docker/server.pem (1233 bytes)
I1226 22:15:53.774574 233786 ssh_runner.go:362] scp /home/jenkins/minikube-integration/17857-208151/.minikube/machines/server-key.pem --> /etc/docker/server-key.pem (1675 bytes)
I1226 22:15:53.796771 233786 provision.go:86] duration metric: configureAuth took 239.633748ms
I1226 22:15:53.796798 233786 buildroot.go:189] setting minikube options for container-runtime
I1226 22:15:53.796961 233786 config.go:182] Loaded profile config "test-preload-015503": Driver=kvm2, ContainerRuntime=docker, KubernetesVersion=v1.24.4
I1226 22:15:53.796984 233786 main.go:141] libmachine: (test-preload-015503) Calling .DriverName
I1226 22:15:53.797284 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHHostname
I1226 22:15:53.799979 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:53.800333 233786 main.go:141] libmachine: (test-preload-015503) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:a2:4a:01", ip: ""} in network mk-test-preload-015503: {Iface:virbr1 ExpiryTime:2023-12-26 23:13:57 +0000 UTC Type:0 Mac:52:54:00:a2:4a:01 Iaid: IPaddr:192.168.39.177 Prefix:24 Hostname:test-preload-015503 Clientid:01:52:54:00:a2:4a:01}
I1226 22:15:53.800364 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined IP address 192.168.39.177 and MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:53.800542 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHPort
I1226 22:15:53.800733 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHKeyPath
I1226 22:15:53.800910 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHKeyPath
I1226 22:15:53.801056 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHUsername
I1226 22:15:53.801231 233786 main.go:141] libmachine: Using SSH client type: native
I1226 22:15:53.801644 233786 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x809380] 0x80c060 <nil> [] 0s} 192.168.39.177 22 <nil> <nil>}
I1226 22:15:53.801663 233786 main.go:141] libmachine: About to run SSH command:
df --output=fstype / | tail -n 1
I1226 22:15:53.913477 233786 main.go:141] libmachine: SSH cmd err, output: <nil>: tmpfs
I1226 22:15:53.913500 233786 buildroot.go:70] root file system type: tmpfs
I1226 22:15:53.913640 233786 provision.go:309] Updating docker unit: /lib/systemd/system/docker.service ...
I1226 22:15:53.913667 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHHostname
I1226 22:15:53.916581 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:53.916958 233786 main.go:141] libmachine: (test-preload-015503) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:a2:4a:01", ip: ""} in network mk-test-preload-015503: {Iface:virbr1 ExpiryTime:2023-12-26 23:13:57 +0000 UTC Type:0 Mac:52:54:00:a2:4a:01 Iaid: IPaddr:192.168.39.177 Prefix:24 Hostname:test-preload-015503 Clientid:01:52:54:00:a2:4a:01}
I1226 22:15:53.916990 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined IP address 192.168.39.177 and MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:53.917101 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHPort
I1226 22:15:53.917271 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHKeyPath
I1226 22:15:53.917466 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHKeyPath
I1226 22:15:53.917633 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHUsername
I1226 22:15:53.917808 233786 main.go:141] libmachine: Using SSH client type: native
I1226 22:15:53.918104 233786 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x809380] 0x80c060 <nil> [] 0s} 192.168.39.177 22 <nil> <nil>}
I1226 22:15:53.918162 233786 main.go:141] libmachine: About to run SSH command:
sudo mkdir -p /lib/systemd/system && printf %s "[Unit]
Description=Docker Application Container Engine
Documentation=https://docs.docker.com
After=network.target minikube-automount.service docker.socket
Requires= minikube-automount.service docker.socket
StartLimitBurst=3
StartLimitIntervalSec=60
[Service]
Type=notify
Restart=on-failure
# This file is a systemd drop-in unit that inherits from the base dockerd configuration.
# The base configuration already specifies an 'ExecStart=...' command. The first directive
# here is to clear out that command inherited from the base configuration. Without this,
# the command from the base configuration and the command specified here are treated as
# a sequence of commands, which is not the desired behavior, nor is it valid -- systemd
# will catch this invalid input and refuse to start the service with an error like:
# Service has more than one ExecStart= setting, which is only allowed for Type=oneshot services.
# NOTE: default-ulimit=nofile is set to an arbitrary number for consistency with other
# container runtimes. If left unlimited, it may result in OOM issues with MySQL.
ExecStart=
ExecStart=/usr/bin/dockerd -H tcp://0.0.0.0:2376 -H unix:///var/run/docker.sock --default-ulimit=nofile=1048576:1048576 --tlsverify --tlscacert /etc/docker/ca.pem --tlscert /etc/docker/server.pem --tlskey /etc/docker/server-key.pem --label provider=kvm2 --insecure-registry 10.96.0.0/12
ExecReload=/bin/kill -s HUP \$MAINPID
# Having non-zero Limit*s causes performance problems due to accounting overhead
# in the kernel. We recommend using cgroups to do container-local accounting.
LimitNOFILE=infinity
LimitNPROC=infinity
LimitCORE=infinity
# Uncomment TasksMax if your systemd version supports it.
# Only systemd 226 and above support this version.
TasksMax=infinity
TimeoutStartSec=0
# set delegate yes so that systemd does not reset the cgroups of docker containers
Delegate=yes
# kill only the docker process, not all processes in the cgroup
KillMode=process
[Install]
WantedBy=multi-user.target
" | sudo tee /lib/systemd/system/docker.service.new
I1226 22:15:54.041103 233786 main.go:141] libmachine: SSH cmd err, output: <nil>: [Unit]
Description=Docker Application Container Engine
Documentation=https://docs.docker.com
After=network.target minikube-automount.service docker.socket
Requires= minikube-automount.service docker.socket
StartLimitBurst=3
StartLimitIntervalSec=60
[Service]
Type=notify
Restart=on-failure
# This file is a systemd drop-in unit that inherits from the base dockerd configuration.
# The base configuration already specifies an 'ExecStart=...' command. The first directive
# here is to clear out that command inherited from the base configuration. Without this,
# the command from the base configuration and the command specified here are treated as
# a sequence of commands, which is not the desired behavior, nor is it valid -- systemd
# will catch this invalid input and refuse to start the service with an error like:
# Service has more than one ExecStart= setting, which is only allowed for Type=oneshot services.
# NOTE: default-ulimit=nofile is set to an arbitrary number for consistency with other
# container runtimes. If left unlimited, it may result in OOM issues with MySQL.
ExecStart=
ExecStart=/usr/bin/dockerd -H tcp://0.0.0.0:2376 -H unix:///var/run/docker.sock --default-ulimit=nofile=1048576:1048576 --tlsverify --tlscacert /etc/docker/ca.pem --tlscert /etc/docker/server.pem --tlskey /etc/docker/server-key.pem --label provider=kvm2 --insecure-registry 10.96.0.0/12
ExecReload=/bin/kill -s HUP $MAINPID
# Having non-zero Limit*s causes performance problems due to accounting overhead
# in the kernel. We recommend using cgroups to do container-local accounting.
LimitNOFILE=infinity
LimitNPROC=infinity
LimitCORE=infinity
# Uncomment TasksMax if your systemd version supports it.
# Only systemd 226 and above support this version.
TasksMax=infinity
TimeoutStartSec=0
# set delegate yes so that systemd does not reset the cgroups of docker containers
Delegate=yes
# kill only the docker process, not all processes in the cgroup
KillMode=process
[Install]
WantedBy=multi-user.target
I1226 22:15:54.041136 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHHostname
I1226 22:15:54.043637 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:54.044005 233786 main.go:141] libmachine: (test-preload-015503) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:a2:4a:01", ip: ""} in network mk-test-preload-015503: {Iface:virbr1 ExpiryTime:2023-12-26 23:13:57 +0000 UTC Type:0 Mac:52:54:00:a2:4a:01 Iaid: IPaddr:192.168.39.177 Prefix:24 Hostname:test-preload-015503 Clientid:01:52:54:00:a2:4a:01}
I1226 22:15:54.044039 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined IP address 192.168.39.177 and MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:54.044195 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHPort
I1226 22:15:54.044391 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHKeyPath
I1226 22:15:54.044580 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHKeyPath
I1226 22:15:54.044730 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHUsername
I1226 22:15:54.044863 233786 main.go:141] libmachine: Using SSH client type: native
I1226 22:15:54.045200 233786 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x809380] 0x80c060 <nil> [] 0s} 192.168.39.177 22 <nil> <nil>}
I1226 22:15:54.045225 233786 main.go:141] libmachine: About to run SSH command:
sudo diff -u /lib/systemd/system/docker.service /lib/systemd/system/docker.service.new || { sudo mv /lib/systemd/system/docker.service.new /lib/systemd/system/docker.service; sudo systemctl -f daemon-reload && sudo systemctl -f enable docker && sudo systemctl -f restart docker; }
I1226 22:15:54.887751 233786 main.go:141] libmachine: SSH cmd err, output: <nil>: diff: can't stat '/lib/systemd/system/docker.service': No such file or directory
Created symlink /etc/systemd/system/multi-user.target.wants/docker.service → /usr/lib/systemd/system/docker.service.
I1226 22:15:54.887792 233786 machine.go:91] provisioned docker machine in 1.583829885s
I1226 22:15:54.887811 233786 start.go:300] post-start starting for "test-preload-015503" (driver="kvm2")
I1226 22:15:54.887825 233786 start.go:329] 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]
I1226 22:15:54.887850 233786 main.go:141] libmachine: (test-preload-015503) Calling .DriverName
I1226 22:15:54.888200 233786 ssh_runner.go:195] Run: sudo mkdir -p /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
I1226 22:15:54.888236 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHHostname
I1226 22:15:54.890444 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:54.890753 233786 main.go:141] libmachine: (test-preload-015503) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:a2:4a:01", ip: ""} in network mk-test-preload-015503: {Iface:virbr1 ExpiryTime:2023-12-26 23:13:57 +0000 UTC Type:0 Mac:52:54:00:a2:4a:01 Iaid: IPaddr:192.168.39.177 Prefix:24 Hostname:test-preload-015503 Clientid:01:52:54:00:a2:4a:01}
I1226 22:15:54.890788 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined IP address 192.168.39.177 and MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:54.890903 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHPort
I1226 22:15:54.891109 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHKeyPath
I1226 22:15:54.891295 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHUsername
I1226 22:15:54.891461 233786 sshutil.go:53] new ssh client: &{IP:192.168.39.177 Port:22 SSHKeyPath:/home/jenkins/minikube-integration/17857-208151/.minikube/machines/test-preload-015503/id_rsa Username:docker}
I1226 22:15:54.978970 233786 ssh_runner.go:195] Run: cat /etc/os-release
I1226 22:15:54.983370 233786 info.go:137] Remote host: Buildroot 2021.02.12
I1226 22:15:54.983400 233786 filesync.go:126] Scanning /home/jenkins/minikube-integration/17857-208151/.minikube/addons for local assets ...
I1226 22:15:54.983532 233786 filesync.go:126] Scanning /home/jenkins/minikube-integration/17857-208151/.minikube/files for local assets ...
I1226 22:15:54.983615 233786 filesync.go:149] local asset: /home/jenkins/minikube-integration/17857-208151/.minikube/files/etc/ssl/certs/2153372.pem -> 2153372.pem in /etc/ssl/certs
I1226 22:15:54.983697 233786 ssh_runner.go:195] Run: sudo mkdir -p /etc/ssl/certs
I1226 22:15:54.992682 233786 ssh_runner.go:362] scp /home/jenkins/minikube-integration/17857-208151/.minikube/files/etc/ssl/certs/2153372.pem --> /etc/ssl/certs/2153372.pem (1708 bytes)
I1226 22:15:55.014073 233786 start.go:303] post-start completed in 126.243244ms
I1226 22:15:55.014112 233786 fix.go:56] fixHost completed within 20.396021231s
I1226 22:15:55.014141 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHHostname
I1226 22:15:55.016462 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:55.016869 233786 main.go:141] libmachine: (test-preload-015503) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:a2:4a:01", ip: ""} in network mk-test-preload-015503: {Iface:virbr1 ExpiryTime:2023-12-26 23:13:57 +0000 UTC Type:0 Mac:52:54:00:a2:4a:01 Iaid: IPaddr:192.168.39.177 Prefix:24 Hostname:test-preload-015503 Clientid:01:52:54:00:a2:4a:01}
I1226 22:15:55.016902 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined IP address 192.168.39.177 and MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:55.017038 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHPort
I1226 22:15:55.017253 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHKeyPath
I1226 22:15:55.017450 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHKeyPath
I1226 22:15:55.017613 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHUsername
I1226 22:15:55.017781 233786 main.go:141] libmachine: Using SSH client type: native
I1226 22:15:55.018094 233786 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x809380] 0x80c060 <nil> [] 0s} 192.168.39.177 22 <nil> <nil>}
I1226 22:15:55.018106 233786 main.go:141] libmachine: About to run SSH command:
date +%s.%N
I1226 22:15:55.129020 233786 main.go:141] libmachine: SSH cmd err, output: <nil>: 1703628955.075345211
I1226 22:15:55.129048 233786 fix.go:206] guest clock: 1703628955.075345211
I1226 22:15:55.129059 233786 fix.go:219] Guest: 2023-12-26 22:15:55.075345211 +0000 UTC Remote: 2023-12-26 22:15:55.014117039 +0000 UTC m=+24.337859015 (delta=61.228172ms)
I1226 22:15:55.129086 233786 fix.go:190] guest clock delta is within tolerance: 61.228172ms
I1226 22:15:55.129092 233786 start.go:83] releasing machines lock for "test-preload-015503", held for 20.511016801s
I1226 22:15:55.129120 233786 main.go:141] libmachine: (test-preload-015503) Calling .DriverName
I1226 22:15:55.129433 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetIP
I1226 22:15:55.132032 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:55.132495 233786 main.go:141] libmachine: (test-preload-015503) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:a2:4a:01", ip: ""} in network mk-test-preload-015503: {Iface:virbr1 ExpiryTime:2023-12-26 23:13:57 +0000 UTC Type:0 Mac:52:54:00:a2:4a:01 Iaid: IPaddr:192.168.39.177 Prefix:24 Hostname:test-preload-015503 Clientid:01:52:54:00:a2:4a:01}
I1226 22:15:55.132528 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined IP address 192.168.39.177 and MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:55.132645 233786 main.go:141] libmachine: (test-preload-015503) Calling .DriverName
I1226 22:15:55.133163 233786 main.go:141] libmachine: (test-preload-015503) Calling .DriverName
I1226 22:15:55.133359 233786 main.go:141] libmachine: (test-preload-015503) Calling .DriverName
I1226 22:15:55.133477 233786 ssh_runner.go:195] Run: curl -sS -m 2 https://registry.k8s.io/
I1226 22:15:55.133527 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHHostname
I1226 22:15:55.133568 233786 ssh_runner.go:195] Run: cat /version.json
I1226 22:15:55.133594 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHHostname
I1226 22:15:55.136191 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:55.136254 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:55.136571 233786 main.go:141] libmachine: (test-preload-015503) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:a2:4a:01", ip: ""} in network mk-test-preload-015503: {Iface:virbr1 ExpiryTime:2023-12-26 23:13:57 +0000 UTC Type:0 Mac:52:54:00:a2:4a:01 Iaid: IPaddr:192.168.39.177 Prefix:24 Hostname:test-preload-015503 Clientid:01:52:54:00:a2:4a:01}
I1226 22:15:55.136606 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined IP address 192.168.39.177 and MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:55.136637 233786 main.go:141] libmachine: (test-preload-015503) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:a2:4a:01", ip: ""} in network mk-test-preload-015503: {Iface:virbr1 ExpiryTime:2023-12-26 23:13:57 +0000 UTC Type:0 Mac:52:54:00:a2:4a:01 Iaid: IPaddr:192.168.39.177 Prefix:24 Hostname:test-preload-015503 Clientid:01:52:54:00:a2:4a:01}
I1226 22:15:55.136655 233786 main.go:141] libmachine: (test-preload-015503) DBG | domain test-preload-015503 has defined IP address 192.168.39.177 and MAC address 52:54:00:a2:4a:01 in network mk-test-preload-015503
I1226 22:15:55.136727 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHPort
I1226 22:15:55.136836 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHPort
I1226 22:15:55.136914 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHKeyPath
I1226 22:15:55.137074 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHKeyPath
I1226 22:15:55.137076 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHUsername
I1226 22:15:55.137245 233786 main.go:141] libmachine: (test-preload-015503) Calling .GetSSHUsername
I1226 22:15:55.137258 233786 sshutil.go:53] new ssh client: &{IP:192.168.39.177 Port:22 SSHKeyPath:/home/jenkins/minikube-integration/17857-208151/.minikube/machines/test-preload-015503/id_rsa Username:docker}
I1226 22:15:55.137393 233786 sshutil.go:53] new ssh client: &{IP:192.168.39.177 Port:22 SSHKeyPath:/home/jenkins/minikube-integration/17857-208151/.minikube/machines/test-preload-015503/id_rsa Username:docker}
I1226 22:15:55.217060 233786 ssh_runner.go:195] Run: systemctl --version
I1226 22:15:55.244335 233786 ssh_runner.go:195] Run: sh -c "stat /etc/cni/net.d/*loopback.conf*"
W1226 22:15:55.249932 233786 cni.go:209] loopback cni configuration skipped: "/etc/cni/net.d/*loopback.conf*" not found
I1226 22:15:55.249990 233786 ssh_runner.go:195] Run: sudo find /etc/cni/net.d -maxdepth 1 -type f ( ( -name *bridge* -or -name *podman* ) -and -not -name *.mk_disabled ) -printf "%p, " -exec sh -c "sudo mv {} {}.mk_disabled" ;
I1226 22:15:55.265496 233786 cni.go:262] disabled [/etc/cni/net.d/87-podman-bridge.conflist] bridge cni config(s)
I1226 22:15:55.265522 233786 start.go:475] detecting cgroup driver to use...
I1226 22:15:55.265637 233786 ssh_runner.go:195] Run: /bin/bash -c "sudo mkdir -p /etc && printf %s "runtime-endpoint: unix:///run/containerd/containerd.sock
" | sudo tee /etc/crictl.yaml"
I1226 22:15:55.282029 233786 ssh_runner.go:195] Run: sh -c "sudo sed -i -r 's|^( *)sandbox_image = .*$|\1sandbox_image = "registry.k8s.io/pause:3.7"|' /etc/containerd/config.toml"
I1226 22:15:55.291973 233786 ssh_runner.go:195] Run: sh -c "sudo sed -i -r 's|^( *)restrict_oom_score_adj = .*$|\1restrict_oom_score_adj = false|' /etc/containerd/config.toml"
I1226 22:15:55.301935 233786 containerd.go:145] configuring containerd to use "cgroupfs" as cgroup driver...
I1226 22:15:55.301986 233786 ssh_runner.go:195] Run: sh -c "sudo sed -i -r 's|^( *)SystemdCgroup = .*$|\1SystemdCgroup = false|g' /etc/containerd/config.toml"
I1226 22:15:55.312081 233786 ssh_runner.go:195] Run: sh -c "sudo sed -i 's|"io.containerd.runtime.v1.linux"|"io.containerd.runc.v2"|g' /etc/containerd/config.toml"
I1226 22:15:55.322421 233786 ssh_runner.go:195] Run: sh -c "sudo sed -i '/systemd_cgroup/d' /etc/containerd/config.toml"
I1226 22:15:55.332058 233786 ssh_runner.go:195] Run: sh -c "sudo sed -i 's|"io.containerd.runc.v1"|"io.containerd.runc.v2"|g' /etc/containerd/config.toml"
I1226 22:15:55.341988 233786 ssh_runner.go:195] Run: sh -c "sudo rm -rf /etc/cni/net.mk"
I1226 22:15:55.352209 233786 ssh_runner.go:195] Run: sh -c "sudo sed -i -r 's|^( *)conf_dir = .*$|\1conf_dir = "/etc/cni/net.d"|g' /etc/containerd/config.toml"
I1226 22:15:55.362136 233786 ssh_runner.go:195] Run: sudo sysctl net.bridge.bridge-nf-call-iptables
I1226 22:15:55.371519 233786 ssh_runner.go:195] Run: sudo sh -c "echo 1 > /proc/sys/net/ipv4/ip_forward"
I1226 22:15:55.380681 233786 ssh_runner.go:195] Run: sudo systemctl daemon-reload
I1226 22:15:55.481733 233786 ssh_runner.go:195] Run: sudo systemctl restart containerd
I1226 22:15:55.500789 233786 start.go:475] detecting cgroup driver to use...
I1226 22:15:55.500884 233786 ssh_runner.go:195] Run: sudo systemctl cat docker.service
I1226 22:15:55.514262 233786 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service containerd
I1226 22:15:55.531225 233786 ssh_runner.go:195] Run: sudo systemctl stop -f containerd
I1226 22:15:55.548885 233786 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service containerd
I1226 22:15:55.560802 233786 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service crio
I1226 22:15:55.572572 233786 ssh_runner.go:195] Run: sudo systemctl stop -f crio
I1226 22:15:55.599774 233786 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service crio
I1226 22:15:55.612215 233786 ssh_runner.go:195] Run: /bin/bash -c "sudo mkdir -p /etc && printf %s "runtime-endpoint: unix:///var/run/cri-dockerd.sock
" | sudo tee /etc/crictl.yaml"
I1226 22:15:55.628914 233786 ssh_runner.go:195] Run: which cri-dockerd
I1226 22:15:55.632642 233786 ssh_runner.go:195] Run: sudo mkdir -p /etc/systemd/system/cri-docker.service.d
I1226 22:15:55.641646 233786 ssh_runner.go:362] scp memory --> /etc/systemd/system/cri-docker.service.d/10-cni.conf (189 bytes)
I1226 22:15:55.657319 233786 ssh_runner.go:195] Run: sudo systemctl unmask docker.service
I1226 22:15:55.764775 233786 ssh_runner.go:195] Run: sudo systemctl enable docker.socket
I1226 22:15:55.871777 233786 docker.go:560] configuring docker to use "cgroupfs" as cgroup driver...
I1226 22:15:55.871953 233786 ssh_runner.go:362] scp memory --> /etc/docker/daemon.json (130 bytes)
I1226 22:15:55.888381 233786 ssh_runner.go:195] Run: sudo systemctl daemon-reload
I1226 22:15:55.987803 233786 ssh_runner.go:195] Run: sudo systemctl restart docker
I1226 22:15:57.432518 233786 ssh_runner.go:235] Completed: sudo systemctl restart docker: (1.444663451s)
I1226 22:15:57.432610 233786 ssh_runner.go:195] Run: sudo systemctl enable cri-docker.socket
I1226 22:15:57.534128 233786 ssh_runner.go:195] Run: sudo systemctl unmask cri-docker.socket
I1226 22:15:57.651811 233786 ssh_runner.go:195] Run: sudo systemctl enable cri-docker.socket
I1226 22:15:57.762100 233786 ssh_runner.go:195] Run: sudo systemctl daemon-reload
I1226 22:15:57.868047 233786 ssh_runner.go:195] Run: sudo systemctl restart cri-docker.socket
I1226 22:15:57.881263 233786 ssh_runner.go:195] Run: sudo journalctl --no-pager -u cri-docker.socket
I1226 22:15:57.894118 233786 out.go:177]
W1226 22:15:57.895558 233786 out.go:239] X Exiting due to RUNTIME_ENABLE: Failed to enable container runtime: sudo systemctl restart cri-docker.socket: Process exited with status 1
stdout:
stderr:
Job failed. See "journalctl -xe" for details.
sudo journalctl --no-pager -u cri-docker.socket:
-- stdout --
-- Journal begins at Tue 2023-12-26 22:15:46 UTC, ends at Tue 2023-12-26 22:15:57 UTC. --
Dec 26 22:15:47 minikube systemd[1]: Starting CRI Docker Socket for the API.
Dec 26 22:15:47 minikube systemd[1]: Listening on CRI Docker Socket for the API.
Dec 26 22:15:49 minikube systemd[1]: cri-docker.socket: Succeeded.
Dec 26 22:15:49 minikube systemd[1]: Closed CRI Docker Socket for the API.
Dec 26 22:15:49 minikube systemd[1]: Stopping CRI Docker Socket for the API.
Dec 26 22:15:49 minikube systemd[1]: Starting CRI Docker Socket for the API.
Dec 26 22:15:49 minikube systemd[1]: Listening on CRI Docker Socket for the API.
Dec 26 22:15:52 minikube systemd[1]: cri-docker.socket: Succeeded.
Dec 26 22:15:52 minikube systemd[1]: Closed CRI Docker Socket for the API.
Dec 26 22:15:52 minikube systemd[1]: Stopping CRI Docker Socket for the API.
Dec 26 22:15:52 minikube systemd[1]: Starting CRI Docker Socket for the API.
Dec 26 22:15:52 minikube systemd[1]: Listening on CRI Docker Socket for the API.
Dec 26 22:15:54 test-preload-015503 systemd[1]: cri-docker.socket: Succeeded.
Dec 26 22:15:54 test-preload-015503 systemd[1]: Closed CRI Docker Socket for the API.
Dec 26 22:15:54 test-preload-015503 systemd[1]: Stopping CRI Docker Socket for the API.
Dec 26 22:15:54 test-preload-015503 systemd[1]: Starting CRI Docker Socket for the API.
Dec 26 22:15:54 test-preload-015503 systemd[1]: Listening on CRI Docker Socket for the API.
Dec 26 22:15:57 test-preload-015503 systemd[1]: cri-docker.socket: Succeeded.
Dec 26 22:15:57 test-preload-015503 systemd[1]: Closed CRI Docker Socket for the API.
Dec 26 22:15:57 test-preload-015503 systemd[1]: Stopping CRI Docker Socket for the API.
Dec 26 22:15:57 test-preload-015503 systemd[1]: cri-docker.socket: Socket service cri-docker.service already active, refusing.
Dec 26 22:15:57 test-preload-015503 systemd[1]: Failed to listen on CRI Docker Socket for the API.
-- /stdout --
X Exiting due to RUNTIME_ENABLE: Failed to enable container runtime: sudo systemctl restart cri-docker.socket: Process exited with status 1
stdout:
stderr:
Job failed. See "journalctl -xe" for details.
sudo journalctl --no-pager -u cri-docker.socket:
-- stdout --
-- Journal begins at Tue 2023-12-26 22:15:46 UTC, ends at Tue 2023-12-26 22:15:57 UTC. --
Dec 26 22:15:47 minikube systemd[1]: Starting CRI Docker Socket for the API.
Dec 26 22:15:47 minikube systemd[1]: Listening on CRI Docker Socket for the API.
Dec 26 22:15:49 minikube systemd[1]: cri-docker.socket: Succeeded.
Dec 26 22:15:49 minikube systemd[1]: Closed CRI Docker Socket for the API.
Dec 26 22:15:49 minikube systemd[1]: Stopping CRI Docker Socket for the API.
Dec 26 22:15:49 minikube systemd[1]: Starting CRI Docker Socket for the API.
Dec 26 22:15:49 minikube systemd[1]: Listening on CRI Docker Socket for the API.
Dec 26 22:15:52 minikube systemd[1]: cri-docker.socket: Succeeded.
Dec 26 22:15:52 minikube systemd[1]: Closed CRI Docker Socket for the API.
Dec 26 22:15:52 minikube systemd[1]: Stopping CRI Docker Socket for the API.
Dec 26 22:15:52 minikube systemd[1]: Starting CRI Docker Socket for the API.
Dec 26 22:15:52 minikube systemd[1]: Listening on CRI Docker Socket for the API.
Dec 26 22:15:54 test-preload-015503 systemd[1]: cri-docker.socket: Succeeded.
Dec 26 22:15:54 test-preload-015503 systemd[1]: Closed CRI Docker Socket for the API.
Dec 26 22:15:54 test-preload-015503 systemd[1]: Stopping CRI Docker Socket for the API.
Dec 26 22:15:54 test-preload-015503 systemd[1]: Starting CRI Docker Socket for the API.
Dec 26 22:15:54 test-preload-015503 systemd[1]: Listening on CRI Docker Socket for the API.
Dec 26 22:15:57 test-preload-015503 systemd[1]: cri-docker.socket: Succeeded.
Dec 26 22:15:57 test-preload-015503 systemd[1]: Closed CRI Docker Socket for the API.
Dec 26 22:15:57 test-preload-015503 systemd[1]: Stopping CRI Docker Socket for the API.
Dec 26 22:15:57 test-preload-015503 systemd[1]: cri-docker.socket: Socket service cri-docker.service already active, refusing.
Dec 26 22:15:57 test-preload-015503 systemd[1]: Failed to listen on CRI Docker Socket for the API.
-- /stdout --
W1226 22:15:57.895579 233786 out.go:239] *
*
W1226 22:15:57.896343 233786 out.go:239] ╭─────────────────────────────────────────────────────────────────────────────────────────────╮
│ │
│ * If the above advice does not help, please let us know: │
│ https://github.com/kubernetes/minikube/issues/new/choose │
│ │
│ * Please run `minikube logs --file=logs.txt` and attach logs.txt to the GitHub issue. │
│ │
╰─────────────────────────────────────────────────────────────────────────────────────────────╯
╭─────────────────────────────────────────────────────────────────────────────────────────────╮
│ │
│ * If the above advice does not help, please let us know: │
│ https://github.com/kubernetes/minikube/issues/new/choose │
│ │
│ * Please run `minikube logs --file=logs.txt` and attach logs.txt to the GitHub issue. │
│ │
╰─────────────────────────────────────────────────────────────────────────────────────────────╯
I1226 22:15:57.898001 233786 out.go:177]
** /stderr **
preload_test.go:68: out/minikube-linux-amd64 start -p test-preload-015503 --memory=2200 --alsologtostderr -v=1 --wait=true --driver=kvm2 failed: exit status 90
panic.go:523: *** TestPreload FAILED at 2023-12-26 22:15:57.936679077 +0000 UTC m=+1891.151678298
helpers_test.go:222: -----------------------post-mortem--------------------------------
helpers_test.go:239: (dbg) Run: out/minikube-linux-amd64 status --format={{.Host}} -p test-preload-015503 -n test-preload-015503
helpers_test.go:239: (dbg) Non-zero exit: out/minikube-linux-amd64 status --format={{.Host}} -p test-preload-015503 -n test-preload-015503: exit status 6 (249.734479ms)
-- stdout --
Running
WARNING: Your kubectl is pointing to stale minikube-vm.
To fix the kubectl context, run `minikube update-context`
-- /stdout --
** stderr **
E1226 22:15:58.170489 233953 status.go:415] kubeconfig endpoint: extract IP: "test-preload-015503" does not appear in /home/jenkins/minikube-integration/17857-208151/kubeconfig
** /stderr **
helpers_test.go:239: status error: exit status 6 (may be ok)
helpers_test.go:241: "test-preload-015503" 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_test.go:175: Cleaning up "test-preload-015503" profile ...
helpers_test.go:178: (dbg) Run: out/minikube-linux-amd64 delete -p test-preload-015503
helpers_test.go:178: (dbg) Done: out/minikube-linux-amd64 delete -p test-preload-015503: (1.065292492s)
--- FAIL: TestPreload (137.95s)