=== RUN TestPreload
preload_test.go:44: (dbg) Run: out/minikube-linux-amd64 start -p test-preload-636951 --memory=2200 --alsologtostderr --wait=true --preload=false --driver=kvm2 --kubernetes-version=v1.24.4
E1102 19:30:41.823389 138893 cert_rotation.go:168] key failed with : open /home/jenkins/minikube-integration/17516-131686/.minikube/profiles/functional-634094/client.crt: no such file or directory
preload_test.go:44: (dbg) Done: out/minikube-linux-amd64 start -p test-preload-636951 --memory=2200 --alsologtostderr --wait=true --preload=false --driver=kvm2 --kubernetes-version=v1.24.4: (1m43.93439521s)
preload_test.go:52: (dbg) Run: out/minikube-linux-amd64 -p test-preload-636951 image pull gcr.io/k8s-minikube/busybox
preload_test.go:52: (dbg) Done: out/minikube-linux-amd64 -p test-preload-636951 image pull gcr.io/k8s-minikube/busybox: (1.251585385s)
preload_test.go:58: (dbg) Run: out/minikube-linux-amd64 stop -p test-preload-636951
preload_test.go:58: (dbg) Done: out/minikube-linux-amd64 stop -p test-preload-636951: (13.11971561s)
preload_test.go:66: (dbg) Run: out/minikube-linux-amd64 start -p test-preload-636951 --memory=2200 --alsologtostderr -v=1 --wait=true --driver=kvm2
E1102 19:32:04.870452 138893 cert_rotation.go:168] key failed with : open /home/jenkins/minikube-integration/17516-131686/.minikube/profiles/functional-634094/client.crt: no such file or directory
preload_test.go:66: (dbg) Non-zero exit: out/minikube-linux-amd64 start -p test-preload-636951 --memory=2200 --alsologtostderr -v=1 --wait=true --driver=kvm2 : exit status 90 (27.568036395s)
-- stdout --
* [test-preload-636951] minikube v1.32.0-beta.0 on Ubuntu 20.04 (kvm/amd64)
- MINIKUBE_LOCATION=17516
- MINIKUBE_SUPPRESS_DOCKER_PERFORMANCE=true
- KUBECONFIG=/home/jenkins/minikube-integration/17516-131686/kubeconfig
- MINIKUBE_HOME=/home/jenkins/minikube-integration/17516-131686/.minikube
- MINIKUBE_BIN=out/minikube-linux-amd64
- MINIKUBE_FORCE_SYSTEMD=
* Kubernetes 1.28.3 is now available. If you would like to upgrade, specify: --kubernetes-version=v1.28.3
* Using the kvm2 driver based on existing profile
* Starting control plane node test-preload-636951 in cluster test-preload-636951
* Downloading Kubernetes v1.24.4 preload ...
* Restarting existing kvm2 VM for "test-preload-636951" ...
-- /stdout --
** stderr **
I1102 19:32:03.810285 157504 out.go:296] Setting OutFile to fd 1 ...
I1102 19:32:03.810464 157504 out.go:343] TERM=,COLORTERM=, which probably does not support color
I1102 19:32:03.810476 157504 out.go:309] Setting ErrFile to fd 2...
I1102 19:32:03.810484 157504 out.go:343] TERM=,COLORTERM=, which probably does not support color
I1102 19:32:03.810950 157504 root.go:338] Updating PATH: /home/jenkins/minikube-integration/17516-131686/.minikube/bin
I1102 19:32:03.811554 157504 out.go:303] Setting JSON to false
I1102 19:32:03.812386 157504 start.go:128] hostinfo: {"hostname":"ubuntu-20-agent-3","uptime":11678,"bootTime":1698941846,"procs":200,"os":"linux","platform":"ubuntu","platformFamily":"debian","platformVersion":"20.04","kernelVersion":"5.15.0-1046-gcp","kernelArch":"x86_64","virtualizationSystem":"kvm","virtualizationRole":"guest","hostId":"591c9f12-2938-3743-e2bf-c56a050d43d1"}
I1102 19:32:03.812452 157504 start.go:138] virtualization: kvm guest
I1102 19:32:03.814851 157504 out.go:177] * [test-preload-636951] minikube v1.32.0-beta.0 on Ubuntu 20.04 (kvm/amd64)
I1102 19:32:03.816457 157504 out.go:177] - MINIKUBE_LOCATION=17516
I1102 19:32:03.816430 157504 notify.go:220] Checking for updates...
I1102 19:32:03.817841 157504 out.go:177] - MINIKUBE_SUPPRESS_DOCKER_PERFORMANCE=true
I1102 19:32:03.819385 157504 out.go:177] - KUBECONFIG=/home/jenkins/minikube-integration/17516-131686/kubeconfig
I1102 19:32:03.820960 157504 out.go:177] - MINIKUBE_HOME=/home/jenkins/minikube-integration/17516-131686/.minikube
I1102 19:32:03.822784 157504 out.go:177] - MINIKUBE_BIN=out/minikube-linux-amd64
I1102 19:32:03.824327 157504 out.go:177] - MINIKUBE_FORCE_SYSTEMD=
I1102 19:32:03.826309 157504 config.go:182] Loaded profile config "test-preload-636951": Driver=kvm2, ContainerRuntime=docker, KubernetesVersion=v1.24.4
I1102 19:32:03.826902 157504 main.go:141] libmachine: Found binary path at /home/jenkins/workspace/KVM_Linux_integration/out/docker-machine-driver-kvm2
I1102 19:32:03.826976 157504 main.go:141] libmachine: Launching plugin server for driver kvm2
I1102 19:32:03.841113 157504 main.go:141] libmachine: Plugin server listening at address 127.0.0.1:46281
I1102 19:32:03.841576 157504 main.go:141] libmachine: () Calling .GetVersion
I1102 19:32:03.842131 157504 main.go:141] libmachine: Using API Version 1
I1102 19:32:03.842151 157504 main.go:141] libmachine: () Calling .SetConfigRaw
I1102 19:32:03.842591 157504 main.go:141] libmachine: () Calling .GetMachineName
I1102 19:32:03.842803 157504 main.go:141] libmachine: (test-preload-636951) Calling .DriverName
I1102 19:32:03.844720 157504 out.go:177] * Kubernetes 1.28.3 is now available. If you would like to upgrade, specify: --kubernetes-version=v1.28.3
I1102 19:32:03.846232 157504 driver.go:378] Setting default libvirt URI to qemu:///system
I1102 19:32:03.846675 157504 main.go:141] libmachine: Found binary path at /home/jenkins/workspace/KVM_Linux_integration/out/docker-machine-driver-kvm2
I1102 19:32:03.846727 157504 main.go:141] libmachine: Launching plugin server for driver kvm2
I1102 19:32:03.860640 157504 main.go:141] libmachine: Plugin server listening at address 127.0.0.1:35545
I1102 19:32:03.861089 157504 main.go:141] libmachine: () Calling .GetVersion
I1102 19:32:03.861576 157504 main.go:141] libmachine: Using API Version 1
I1102 19:32:03.861598 157504 main.go:141] libmachine: () Calling .SetConfigRaw
I1102 19:32:03.861964 157504 main.go:141] libmachine: () Calling .GetMachineName
I1102 19:32:03.862184 157504 main.go:141] libmachine: (test-preload-636951) Calling .DriverName
I1102 19:32:03.896102 157504 out.go:177] * Using the kvm2 driver based on existing profile
I1102 19:32:03.897627 157504 start.go:298] selected driver: kvm2
I1102 19:32:03.897645 157504 start.go:902] validating driver "kvm2" against &{Name:test-preload-636951 KeepContext:false EmbedCerts:false MinikubeISO:https://storage.googleapis.com/minikube-builds/iso/17486/minikube-v1.32.0-1698773592-17486-amd64.iso KicBaseImage:gcr.io/k8s-minikube/kicbase-builds:v0.0.41-1698881667-17516@sha256:966390c8d9b756c6e7044095f0ca5e5551da4c170cb501439eea24d1ad19bb89 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-636951 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.48 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-hos
t 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:}
I1102 19:32:03.897749 157504 start.go:913] status for kvm2: {Installed:true Healthy:true Running:true NeedsImprovement:false Error:<nil> Reason: Fix: Doc: Version:}
I1102 19:32:03.898476 157504 install.go:52] acquiring lock: {Name:mk900956b073697a4aa6c80a27c6bb0742a99a53 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I1102 19:32:03.898556 157504 install.go:117] Validating docker-machine-driver-kvm2, PATH=/home/jenkins/minikube-integration/17516-131686/.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
I1102 19:32:03.913021 157504 install.go:137] /home/jenkins/workspace/KVM_Linux_integration/out/docker-machine-driver-kvm2 version is 1.32.0-beta.0
I1102 19:32:03.913432 157504 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]
I1102 19:32:03.913519 157504 cni.go:84] Creating CNI manager for ""
I1102 19:32:03.913546 157504 cni.go:158] "kvm2" driver + "docker" container runtime found on kubernetes v1.24+, recommending bridge
I1102 19:32:03.913561 157504 start_flags.go:323] config:
{Name:test-preload-636951 KeepContext:false EmbedCerts:false MinikubeISO:https://storage.googleapis.com/minikube-builds/iso/17486/minikube-v1.32.0-1698773592-17486-amd64.iso KicBaseImage:gcr.io/k8s-minikube/kicbase-builds:v0.0.41-1698881667-17516@sha256:966390c8d9b756c6e7044095f0ca5e5551da4c170cb501439eea24d1ad19bb89 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-636951 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.48 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 MountOpti
ons:[] MountPort:0 MountType:9p MountUID:docker BinaryMirror: DisableOptimizations:false DisableMetrics:false CustomQemuFirmwarePath: SocketVMnetClientPath: SocketVMnetPath: StaticIP: SSHAuthSock: SSHAgentPID:0 AutoPauseInterval:1m0s GPUs:}
I1102 19:32:03.913782 157504 iso.go:125] acquiring lock: {Name:mked7fa81fa67f718e06941e7c75292eb0397f3a Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I1102 19:32:03.915678 157504 out.go:177] * Starting control plane node test-preload-636951 in cluster test-preload-636951
I1102 19:32:03.917102 157504 preload.go:132] Checking if preload exists for k8s version v1.24.4 and runtime docker
I1102 19:32:03.936785 157504 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
I1102 19:32:03.936823 157504 cache.go:56] Caching tarball of preloaded images
I1102 19:32:03.936976 157504 preload.go:132] Checking if preload exists for k8s version v1.24.4 and runtime docker
I1102 19:32:03.938694 157504 out.go:177] * Downloading Kubernetes v1.24.4 preload ...
I1102 19:32:03.940005 157504 preload.go:238] getting checksum for preloaded-images-k8s-v18-v1.24.4-docker-overlay2-amd64.tar.lz4 ...
I1102 19:32:03.968502 157504 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/17516-131686/.minikube/cache/preloaded-tarball/preloaded-images-k8s-v18-v1.24.4-docker-overlay2-amd64.tar.lz4
I1102 19:32:06.897524 157504 preload.go:249] saving checksum for preloaded-images-k8s-v18-v1.24.4-docker-overlay2-amd64.tar.lz4 ...
I1102 19:32:06.897626 157504 preload.go:256] verifying checksum of /home/jenkins/minikube-integration/17516-131686/.minikube/cache/preloaded-tarball/preloaded-images-k8s-v18-v1.24.4-docker-overlay2-amd64.tar.lz4 ...
I1102 19:32:07.749601 157504 cache.go:59] Finished verifying existence of preloaded tar for v1.24.4 on docker
I1102 19:32:07.749779 157504 profile.go:148] Saving config to /home/jenkins/minikube-integration/17516-131686/.minikube/profiles/test-preload-636951/config.json ...
I1102 19:32:07.750011 157504 start.go:365] acquiring machines lock for test-preload-636951: {Name:mk4c51a933b06302b168b5d967554289048d4a57 Clock:{} Delay:500ms Timeout:13m0s Cancel:<nil>}
I1102 19:32:07.750081 157504 start.go:369] acquired machines lock for "test-preload-636951" in 43.852µs
I1102 19:32:07.750097 157504 start.go:96] Skipping create...Using existing machine configuration
I1102 19:32:07.750104 157504 fix.go:54] fixHost starting:
I1102 19:32:07.750387 157504 main.go:141] libmachine: Found binary path at /home/jenkins/workspace/KVM_Linux_integration/out/docker-machine-driver-kvm2
I1102 19:32:07.750424 157504 main.go:141] libmachine: Launching plugin server for driver kvm2
I1102 19:32:07.764667 157504 main.go:141] libmachine: Plugin server listening at address 127.0.0.1:40945
I1102 19:32:07.765110 157504 main.go:141] libmachine: () Calling .GetVersion
I1102 19:32:07.765577 157504 main.go:141] libmachine: Using API Version 1
I1102 19:32:07.765600 157504 main.go:141] libmachine: () Calling .SetConfigRaw
I1102 19:32:07.765954 157504 main.go:141] libmachine: () Calling .GetMachineName
I1102 19:32:07.766143 157504 main.go:141] libmachine: (test-preload-636951) Calling .DriverName
I1102 19:32:07.766324 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetState
I1102 19:32:07.767981 157504 fix.go:102] recreateIfNeeded on test-preload-636951: state=Stopped err=<nil>
I1102 19:32:07.768013 157504 main.go:141] libmachine: (test-preload-636951) Calling .DriverName
W1102 19:32:07.768216 157504 fix.go:128] unexpected machine state, will restart: <nil>
I1102 19:32:07.770183 157504 out.go:177] * Restarting existing kvm2 VM for "test-preload-636951" ...
I1102 19:32:07.771560 157504 main.go:141] libmachine: (test-preload-636951) Calling .Start
I1102 19:32:07.771747 157504 main.go:141] libmachine: (test-preload-636951) Ensuring networks are active...
I1102 19:32:07.772522 157504 main.go:141] libmachine: (test-preload-636951) Ensuring network default is active
I1102 19:32:07.772830 157504 main.go:141] libmachine: (test-preload-636951) Ensuring network mk-test-preload-636951 is active
I1102 19:32:07.773156 157504 main.go:141] libmachine: (test-preload-636951) Getting domain xml...
I1102 19:32:07.773883 157504 main.go:141] libmachine: (test-preload-636951) Creating domain...
I1102 19:32:08.983162 157504 main.go:141] libmachine: (test-preload-636951) Waiting to get IP...
I1102 19:32:08.984057 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:08.984420 157504 main.go:141] libmachine: (test-preload-636951) DBG | unable to find current IP address of domain test-preload-636951 in network mk-test-preload-636951
I1102 19:32:08.984502 157504 main.go:141] libmachine: (test-preload-636951) DBG | I1102 19:32:08.984410 157539 retry.go:31] will retry after 250.512097ms: waiting for machine to come up
I1102 19:32:09.237127 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:09.237580 157504 main.go:141] libmachine: (test-preload-636951) DBG | unable to find current IP address of domain test-preload-636951 in network mk-test-preload-636951
I1102 19:32:09.237609 157504 main.go:141] libmachine: (test-preload-636951) DBG | I1102 19:32:09.237522 157539 retry.go:31] will retry after 334.438815ms: waiting for machine to come up
I1102 19:32:09.574350 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:09.574737 157504 main.go:141] libmachine: (test-preload-636951) DBG | unable to find current IP address of domain test-preload-636951 in network mk-test-preload-636951
I1102 19:32:09.574765 157504 main.go:141] libmachine: (test-preload-636951) DBG | I1102 19:32:09.574669 157539 retry.go:31] will retry after 335.473673ms: waiting for machine to come up
I1102 19:32:09.912119 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:09.912559 157504 main.go:141] libmachine: (test-preload-636951) DBG | unable to find current IP address of domain test-preload-636951 in network mk-test-preload-636951
I1102 19:32:09.912583 157504 main.go:141] libmachine: (test-preload-636951) DBG | I1102 19:32:09.912513 157539 retry.go:31] will retry after 565.837673ms: waiting for machine to come up
I1102 19:32:10.480480 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:10.480923 157504 main.go:141] libmachine: (test-preload-636951) DBG | unable to find current IP address of domain test-preload-636951 in network mk-test-preload-636951
I1102 19:32:10.480955 157504 main.go:141] libmachine: (test-preload-636951) DBG | I1102 19:32:10.480852 157539 retry.go:31] will retry after 592.784919ms: waiting for machine to come up
I1102 19:32:11.075754 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:11.076305 157504 main.go:141] libmachine: (test-preload-636951) DBG | unable to find current IP address of domain test-preload-636951 in network mk-test-preload-636951
I1102 19:32:11.076342 157504 main.go:141] libmachine: (test-preload-636951) DBG | I1102 19:32:11.076257 157539 retry.go:31] will retry after 865.487851ms: waiting for machine to come up
I1102 19:32:11.943265 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:11.943707 157504 main.go:141] libmachine: (test-preload-636951) DBG | unable to find current IP address of domain test-preload-636951 in network mk-test-preload-636951
I1102 19:32:11.943737 157504 main.go:141] libmachine: (test-preload-636951) DBG | I1102 19:32:11.943595 157539 retry.go:31] will retry after 993.969883ms: waiting for machine to come up
I1102 19:32:12.939284 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:12.939759 157504 main.go:141] libmachine: (test-preload-636951) DBG | unable to find current IP address of domain test-preload-636951 in network mk-test-preload-636951
I1102 19:32:12.939813 157504 main.go:141] libmachine: (test-preload-636951) DBG | I1102 19:32:12.939707 157539 retry.go:31] will retry after 1.004224126s: waiting for machine to come up
I1102 19:32:13.945716 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:13.946111 157504 main.go:141] libmachine: (test-preload-636951) DBG | unable to find current IP address of domain test-preload-636951 in network mk-test-preload-636951
I1102 19:32:13.946141 157504 main.go:141] libmachine: (test-preload-636951) DBG | I1102 19:32:13.946072 157539 retry.go:31] will retry after 1.451265497s: waiting for machine to come up
I1102 19:32:15.399933 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:15.400341 157504 main.go:141] libmachine: (test-preload-636951) DBG | unable to find current IP address of domain test-preload-636951 in network mk-test-preload-636951
I1102 19:32:15.400373 157504 main.go:141] libmachine: (test-preload-636951) DBG | I1102 19:32:15.400321 157539 retry.go:31] will retry after 1.590678578s: waiting for machine to come up
I1102 19:32:16.992650 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:16.993069 157504 main.go:141] libmachine: (test-preload-636951) DBG | unable to find current IP address of domain test-preload-636951 in network mk-test-preload-636951
I1102 19:32:16.993102 157504 main.go:141] libmachine: (test-preload-636951) DBG | I1102 19:32:16.993013 157539 retry.go:31] will retry after 2.680405965s: waiting for machine to come up
I1102 19:32:19.675645 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:19.676004 157504 main.go:141] libmachine: (test-preload-636951) DBG | unable to find current IP address of domain test-preload-636951 in network mk-test-preload-636951
I1102 19:32:19.676037 157504 main.go:141] libmachine: (test-preload-636951) DBG | I1102 19:32:19.675940 157539 retry.go:31] will retry after 2.210052564s: waiting for machine to come up
I1102 19:32:21.889383 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:21.889787 157504 main.go:141] libmachine: (test-preload-636951) DBG | unable to find current IP address of domain test-preload-636951 in network mk-test-preload-636951
I1102 19:32:21.889812 157504 main.go:141] libmachine: (test-preload-636951) DBG | I1102 19:32:21.889744 157539 retry.go:31] will retry after 4.532561629s: waiting for machine to come up
I1102 19:32:26.426715 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:26.427134 157504 main.go:141] libmachine: (test-preload-636951) Found IP for machine: 192.168.39.48
I1102 19:32:26.427155 157504 main.go:141] libmachine: (test-preload-636951) Reserving static IP address...
I1102 19:32:26.427177 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has current primary IP address 192.168.39.48 and MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:26.427501 157504 main.go:141] libmachine: (test-preload-636951) DBG | found host DHCP lease matching {name: "test-preload-636951", mac: "52:54:00:12:6c:4a", ip: "192.168.39.48"} in network mk-test-preload-636951: {Iface:virbr1 ExpiryTime:2023-11-02 20:32:20 +0000 UTC Type:0 Mac:52:54:00:12:6c:4a Iaid: IPaddr:192.168.39.48 Prefix:24 Hostname:test-preload-636951 Clientid:01:52:54:00:12:6c:4a}
I1102 19:32:26.427519 157504 main.go:141] libmachine: (test-preload-636951) Reserved static IP address: 192.168.39.48
I1102 19:32:26.427535 157504 main.go:141] libmachine: (test-preload-636951) DBG | skip adding static IP to network mk-test-preload-636951 - found existing host DHCP lease matching {name: "test-preload-636951", mac: "52:54:00:12:6c:4a", ip: "192.168.39.48"}
I1102 19:32:26.427550 157504 main.go:141] libmachine: (test-preload-636951) Waiting for SSH to be available...
I1102 19:32:26.427566 157504 main.go:141] libmachine: (test-preload-636951) DBG | Getting to WaitForSSH function...
I1102 19:32:26.429638 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:26.429915 157504 main.go:141] libmachine: (test-preload-636951) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:12:6c:4a", ip: ""} in network mk-test-preload-636951: {Iface:virbr1 ExpiryTime:2023-11-02 20:32:20 +0000 UTC Type:0 Mac:52:54:00:12:6c:4a Iaid: IPaddr:192.168.39.48 Prefix:24 Hostname:test-preload-636951 Clientid:01:52:54:00:12:6c:4a}
I1102 19:32:26.429946 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined IP address 192.168.39.48 and MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:26.430062 157504 main.go:141] libmachine: (test-preload-636951) DBG | Using SSH client type: external
I1102 19:32:26.430091 157504 main.go:141] libmachine: (test-preload-636951) DBG | Using SSH private key: /home/jenkins/minikube-integration/17516-131686/.minikube/machines/test-preload-636951/id_rsa (-rw-------)
I1102 19:32:26.430127 157504 main.go:141] libmachine: (test-preload-636951) 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.48 -o IdentitiesOnly=yes -i /home/jenkins/minikube-integration/17516-131686/.minikube/machines/test-preload-636951/id_rsa -p 22] /usr/bin/ssh <nil>}
I1102 19:32:26.430142 157504 main.go:141] libmachine: (test-preload-636951) DBG | About to run SSH command:
I1102 19:32:26.430159 157504 main.go:141] libmachine: (test-preload-636951) DBG | exit 0
I1102 19:32:26.514284 157504 main.go:141] libmachine: (test-preload-636951) DBG | SSH cmd err, output: <nil>:
I1102 19:32:26.514653 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetConfigRaw
I1102 19:32:26.515429 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetIP
I1102 19:32:26.517861 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:26.518183 157504 main.go:141] libmachine: (test-preload-636951) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:12:6c:4a", ip: ""} in network mk-test-preload-636951: {Iface:virbr1 ExpiryTime:2023-11-02 20:32:20 +0000 UTC Type:0 Mac:52:54:00:12:6c:4a Iaid: IPaddr:192.168.39.48 Prefix:24 Hostname:test-preload-636951 Clientid:01:52:54:00:12:6c:4a}
I1102 19:32:26.518209 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined IP address 192.168.39.48 and MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:26.518511 157504 profile.go:148] Saving config to /home/jenkins/minikube-integration/17516-131686/.minikube/profiles/test-preload-636951/config.json ...
I1102 19:32:26.518675 157504 machine.go:88] provisioning docker machine ...
I1102 19:32:26.518693 157504 main.go:141] libmachine: (test-preload-636951) Calling .DriverName
I1102 19:32:26.518900 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetMachineName
I1102 19:32:26.519052 157504 buildroot.go:166] provisioning hostname "test-preload-636951"
I1102 19:32:26.519072 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetMachineName
I1102 19:32:26.519205 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHHostname
I1102 19:32:26.521209 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:26.521520 157504 main.go:141] libmachine: (test-preload-636951) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:12:6c:4a", ip: ""} in network mk-test-preload-636951: {Iface:virbr1 ExpiryTime:2023-11-02 20:32:20 +0000 UTC Type:0 Mac:52:54:00:12:6c:4a Iaid: IPaddr:192.168.39.48 Prefix:24 Hostname:test-preload-636951 Clientid:01:52:54:00:12:6c:4a}
I1102 19:32:26.521542 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined IP address 192.168.39.48 and MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:26.521667 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHPort
I1102 19:32:26.521832 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHKeyPath
I1102 19:32:26.522007 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHKeyPath
I1102 19:32:26.522153 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHUsername
I1102 19:32:26.522354 157504 main.go:141] libmachine: Using SSH client type: native
I1102 19:32:26.522699 157504 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x808a40] 0x80b720 <nil> [] 0s} 192.168.39.48 22 <nil> <nil>}
I1102 19:32:26.522716 157504 main.go:141] libmachine: About to run SSH command:
sudo hostname test-preload-636951 && echo "test-preload-636951" | sudo tee /etc/hostname
I1102 19:32:26.647281 157504 main.go:141] libmachine: SSH cmd err, output: <nil>: test-preload-636951
I1102 19:32:26.647318 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHHostname
I1102 19:32:26.649789 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:26.650059 157504 main.go:141] libmachine: (test-preload-636951) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:12:6c:4a", ip: ""} in network mk-test-preload-636951: {Iface:virbr1 ExpiryTime:2023-11-02 20:32:20 +0000 UTC Type:0 Mac:52:54:00:12:6c:4a Iaid: IPaddr:192.168.39.48 Prefix:24 Hostname:test-preload-636951 Clientid:01:52:54:00:12:6c:4a}
I1102 19:32:26.650085 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined IP address 192.168.39.48 and MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:26.650382 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHPort
I1102 19:32:26.650645 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHKeyPath
I1102 19:32:26.650787 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHKeyPath
I1102 19:32:26.650922 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHUsername
I1102 19:32:26.651057 157504 main.go:141] libmachine: Using SSH client type: native
I1102 19:32:26.651454 157504 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x808a40] 0x80b720 <nil> [] 0s} 192.168.39.48 22 <nil> <nil>}
I1102 19:32:26.651476 157504 main.go:141] libmachine: About to run SSH command:
if ! grep -xq '.*\stest-preload-636951' /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-636951/g' /etc/hosts;
else
echo '127.0.1.1 test-preload-636951' | sudo tee -a /etc/hosts;
fi
fi
I1102 19:32:26.770320 157504 main.go:141] libmachine: SSH cmd err, output: <nil>:
I1102 19:32:26.770357 157504 buildroot.go:172] set auth options {CertDir:/home/jenkins/minikube-integration/17516-131686/.minikube CaCertPath:/home/jenkins/minikube-integration/17516-131686/.minikube/certs/ca.pem CaPrivateKeyPath:/home/jenkins/minikube-integration/17516-131686/.minikube/certs/ca-key.pem CaCertRemotePath:/etc/docker/ca.pem ServerCertPath:/home/jenkins/minikube-integration/17516-131686/.minikube/machines/server.pem ServerKeyPath:/home/jenkins/minikube-integration/17516-131686/.minikube/machines/server-key.pem ClientKeyPath:/home/jenkins/minikube-integration/17516-131686/.minikube/certs/key.pem ServerCertRemotePath:/etc/docker/server.pem ServerKeyRemotePath:/etc/docker/server-key.pem ClientCertPath:/home/jenkins/minikube-integration/17516-131686/.minikube/certs/cert.pem ServerCertSANs:[] StorePath:/home/jenkins/minikube-integration/17516-131686/.minikube}
I1102 19:32:26.770394 157504 buildroot.go:174] setting up certificates
I1102 19:32:26.770406 157504 provision.go:83] configureAuth start
I1102 19:32:26.770417 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetMachineName
I1102 19:32:26.770715 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetIP
I1102 19:32:26.773339 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:26.773706 157504 main.go:141] libmachine: (test-preload-636951) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:12:6c:4a", ip: ""} in network mk-test-preload-636951: {Iface:virbr1 ExpiryTime:2023-11-02 20:32:20 +0000 UTC Type:0 Mac:52:54:00:12:6c:4a Iaid: IPaddr:192.168.39.48 Prefix:24 Hostname:test-preload-636951 Clientid:01:52:54:00:12:6c:4a}
I1102 19:32:26.773737 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined IP address 192.168.39.48 and MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:26.773870 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHHostname
I1102 19:32:26.776318 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:26.776660 157504 main.go:141] libmachine: (test-preload-636951) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:12:6c:4a", ip: ""} in network mk-test-preload-636951: {Iface:virbr1 ExpiryTime:2023-11-02 20:32:20 +0000 UTC Type:0 Mac:52:54:00:12:6c:4a Iaid: IPaddr:192.168.39.48 Prefix:24 Hostname:test-preload-636951 Clientid:01:52:54:00:12:6c:4a}
I1102 19:32:26.776694 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined IP address 192.168.39.48 and MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:26.776823 157504 provision.go:138] copyHostCerts
I1102 19:32:26.776890 157504 exec_runner.go:144] found /home/jenkins/minikube-integration/17516-131686/.minikube/key.pem, removing ...
I1102 19:32:26.776924 157504 exec_runner.go:203] rm: /home/jenkins/minikube-integration/17516-131686/.minikube/key.pem
I1102 19:32:26.777006 157504 exec_runner.go:151] cp: /home/jenkins/minikube-integration/17516-131686/.minikube/certs/key.pem --> /home/jenkins/minikube-integration/17516-131686/.minikube/key.pem (1679 bytes)
I1102 19:32:26.777146 157504 exec_runner.go:144] found /home/jenkins/minikube-integration/17516-131686/.minikube/ca.pem, removing ...
I1102 19:32:26.777164 157504 exec_runner.go:203] rm: /home/jenkins/minikube-integration/17516-131686/.minikube/ca.pem
I1102 19:32:26.777202 157504 exec_runner.go:151] cp: /home/jenkins/minikube-integration/17516-131686/.minikube/certs/ca.pem --> /home/jenkins/minikube-integration/17516-131686/.minikube/ca.pem (1078 bytes)
I1102 19:32:26.777301 157504 exec_runner.go:144] found /home/jenkins/minikube-integration/17516-131686/.minikube/cert.pem, removing ...
I1102 19:32:26.777312 157504 exec_runner.go:203] rm: /home/jenkins/minikube-integration/17516-131686/.minikube/cert.pem
I1102 19:32:26.777346 157504 exec_runner.go:151] cp: /home/jenkins/minikube-integration/17516-131686/.minikube/certs/cert.pem --> /home/jenkins/minikube-integration/17516-131686/.minikube/cert.pem (1123 bytes)
I1102 19:32:26.777434 157504 provision.go:112] generating server cert: /home/jenkins/minikube-integration/17516-131686/.minikube/machines/server.pem ca-key=/home/jenkins/minikube-integration/17516-131686/.minikube/certs/ca.pem private-key=/home/jenkins/minikube-integration/17516-131686/.minikube/certs/ca-key.pem org=jenkins.test-preload-636951 san=[192.168.39.48 192.168.39.48 localhost 127.0.0.1 minikube test-preload-636951]
I1102 19:32:26.902375 157504 provision.go:172] copyRemoteCerts
I1102 19:32:26.902433 157504 ssh_runner.go:195] Run: sudo mkdir -p /etc/docker /etc/docker /etc/docker
I1102 19:32:26.902466 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHHostname
I1102 19:32:26.905051 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:26.905389 157504 main.go:141] libmachine: (test-preload-636951) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:12:6c:4a", ip: ""} in network mk-test-preload-636951: {Iface:virbr1 ExpiryTime:2023-11-02 20:32:20 +0000 UTC Type:0 Mac:52:54:00:12:6c:4a Iaid: IPaddr:192.168.39.48 Prefix:24 Hostname:test-preload-636951 Clientid:01:52:54:00:12:6c:4a}
I1102 19:32:26.905418 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined IP address 192.168.39.48 and MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:26.905536 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHPort
I1102 19:32:26.905760 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHKeyPath
I1102 19:32:26.905927 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHUsername
I1102 19:32:26.906073 157504 sshutil.go:53] new ssh client: &{IP:192.168.39.48 Port:22 SSHKeyPath:/home/jenkins/minikube-integration/17516-131686/.minikube/machines/test-preload-636951/id_rsa Username:docker}
I1102 19:32:26.992082 157504 ssh_runner.go:362] scp /home/jenkins/minikube-integration/17516-131686/.minikube/certs/ca.pem --> /etc/docker/ca.pem (1078 bytes)
I1102 19:32:27.013971 157504 ssh_runner.go:362] scp /home/jenkins/minikube-integration/17516-131686/.minikube/machines/server.pem --> /etc/docker/server.pem (1233 bytes)
I1102 19:32:27.034974 157504 ssh_runner.go:362] scp /home/jenkins/minikube-integration/17516-131686/.minikube/machines/server-key.pem --> /etc/docker/server-key.pem (1675 bytes)
I1102 19:32:27.056237 157504 provision.go:86] duration metric: configureAuth took 285.820937ms
I1102 19:32:27.056260 157504 buildroot.go:189] setting minikube options for container-runtime
I1102 19:32:27.056441 157504 config.go:182] Loaded profile config "test-preload-636951": Driver=kvm2, ContainerRuntime=docker, KubernetesVersion=v1.24.4
I1102 19:32:27.056465 157504 main.go:141] libmachine: (test-preload-636951) Calling .DriverName
I1102 19:32:27.056748 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHHostname
I1102 19:32:27.059337 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:27.059682 157504 main.go:141] libmachine: (test-preload-636951) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:12:6c:4a", ip: ""} in network mk-test-preload-636951: {Iface:virbr1 ExpiryTime:2023-11-02 20:32:20 +0000 UTC Type:0 Mac:52:54:00:12:6c:4a Iaid: IPaddr:192.168.39.48 Prefix:24 Hostname:test-preload-636951 Clientid:01:52:54:00:12:6c:4a}
I1102 19:32:27.059714 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined IP address 192.168.39.48 and MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:27.059827 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHPort
I1102 19:32:27.060037 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHKeyPath
I1102 19:32:27.060191 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHKeyPath
I1102 19:32:27.060375 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHUsername
I1102 19:32:27.060553 157504 main.go:141] libmachine: Using SSH client type: native
I1102 19:32:27.060959 157504 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x808a40] 0x80b720 <nil> [] 0s} 192.168.39.48 22 <nil> <nil>}
I1102 19:32:27.060978 157504 main.go:141] libmachine: About to run SSH command:
df --output=fstype / | tail -n 1
I1102 19:32:27.171939 157504 main.go:141] libmachine: SSH cmd err, output: <nil>: tmpfs
I1102 19:32:27.171966 157504 buildroot.go:70] root file system type: tmpfs
I1102 19:32:27.172071 157504 provision.go:309] Updating docker unit: /lib/systemd/system/docker.service ...
I1102 19:32:27.172106 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHHostname
I1102 19:32:27.174689 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:27.175001 157504 main.go:141] libmachine: (test-preload-636951) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:12:6c:4a", ip: ""} in network mk-test-preload-636951: {Iface:virbr1 ExpiryTime:2023-11-02 20:32:20 +0000 UTC Type:0 Mac:52:54:00:12:6c:4a Iaid: IPaddr:192.168.39.48 Prefix:24 Hostname:test-preload-636951 Clientid:01:52:54:00:12:6c:4a}
I1102 19:32:27.175038 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined IP address 192.168.39.48 and MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:27.175184 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHPort
I1102 19:32:27.175390 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHKeyPath
I1102 19:32:27.175582 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHKeyPath
I1102 19:32:27.175734 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHUsername
I1102 19:32:27.175935 157504 main.go:141] libmachine: Using SSH client type: native
I1102 19:32:27.176301 157504 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x808a40] 0x80b720 <nil> [] 0s} 192.168.39.48 22 <nil> <nil>}
I1102 19:32:27.176398 157504 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
I1102 19:32:27.299092 157504 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
I1102 19:32:27.299130 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHHostname
I1102 19:32:27.301926 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:27.302330 157504 main.go:141] libmachine: (test-preload-636951) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:12:6c:4a", ip: ""} in network mk-test-preload-636951: {Iface:virbr1 ExpiryTime:2023-11-02 20:32:20 +0000 UTC Type:0 Mac:52:54:00:12:6c:4a Iaid: IPaddr:192.168.39.48 Prefix:24 Hostname:test-preload-636951 Clientid:01:52:54:00:12:6c:4a}
I1102 19:32:27.302363 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined IP address 192.168.39.48 and MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:27.302577 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHPort
I1102 19:32:27.302774 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHKeyPath
I1102 19:32:27.302942 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHKeyPath
I1102 19:32:27.303040 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHUsername
I1102 19:32:27.303208 157504 main.go:141] libmachine: Using SSH client type: native
I1102 19:32:27.303585 157504 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x808a40] 0x80b720 <nil> [] 0s} 192.168.39.48 22 <nil> <nil>}
I1102 19:32:27.303605 157504 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; }
I1102 19:32:28.274513 157504 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.
I1102 19:32:28.274546 157504 machine.go:91] provisioned docker machine in 1.755857039s
I1102 19:32:28.274563 157504 start.go:300] post-start starting for "test-preload-636951" (driver="kvm2")
I1102 19:32:28.274577 157504 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]
I1102 19:32:28.274605 157504 main.go:141] libmachine: (test-preload-636951) Calling .DriverName
I1102 19:32:28.275001 157504 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
I1102 19:32:28.275041 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHHostname
I1102 19:32:28.277680 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:28.277993 157504 main.go:141] libmachine: (test-preload-636951) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:12:6c:4a", ip: ""} in network mk-test-preload-636951: {Iface:virbr1 ExpiryTime:2023-11-02 20:32:20 +0000 UTC Type:0 Mac:52:54:00:12:6c:4a Iaid: IPaddr:192.168.39.48 Prefix:24 Hostname:test-preload-636951 Clientid:01:52:54:00:12:6c:4a}
I1102 19:32:28.278023 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined IP address 192.168.39.48 and MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:28.278129 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHPort
I1102 19:32:28.278361 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHKeyPath
I1102 19:32:28.278545 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHUsername
I1102 19:32:28.278711 157504 sshutil.go:53] new ssh client: &{IP:192.168.39.48 Port:22 SSHKeyPath:/home/jenkins/minikube-integration/17516-131686/.minikube/machines/test-preload-636951/id_rsa Username:docker}
I1102 19:32:28.364665 157504 ssh_runner.go:195] Run: cat /etc/os-release
I1102 19:32:28.369052 157504 info.go:137] Remote host: Buildroot 2021.02.12
I1102 19:32:28.369079 157504 filesync.go:126] Scanning /home/jenkins/minikube-integration/17516-131686/.minikube/addons for local assets ...
I1102 19:32:28.369177 157504 filesync.go:126] Scanning /home/jenkins/minikube-integration/17516-131686/.minikube/files for local assets ...
I1102 19:32:28.369292 157504 filesync.go:149] local asset: /home/jenkins/minikube-integration/17516-131686/.minikube/files/etc/ssl/certs/1388932.pem -> 1388932.pem in /etc/ssl/certs
I1102 19:32:28.369424 157504 ssh_runner.go:195] Run: sudo mkdir -p /etc/ssl/certs
I1102 19:32:28.378560 157504 ssh_runner.go:362] scp /home/jenkins/minikube-integration/17516-131686/.minikube/files/etc/ssl/certs/1388932.pem --> /etc/ssl/certs/1388932.pem (1708 bytes)
I1102 19:32:28.400521 157504 start.go:303] post-start completed in 125.940942ms
I1102 19:32:28.400546 157504 fix.go:56] fixHost completed within 20.650443265s
I1102 19:32:28.400568 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHHostname
I1102 19:32:28.403026 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:28.403364 157504 main.go:141] libmachine: (test-preload-636951) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:12:6c:4a", ip: ""} in network mk-test-preload-636951: {Iface:virbr1 ExpiryTime:2023-11-02 20:32:20 +0000 UTC Type:0 Mac:52:54:00:12:6c:4a Iaid: IPaddr:192.168.39.48 Prefix:24 Hostname:test-preload-636951 Clientid:01:52:54:00:12:6c:4a}
I1102 19:32:28.403388 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined IP address 192.168.39.48 and MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:28.403542 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHPort
I1102 19:32:28.403754 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHKeyPath
I1102 19:32:28.403912 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHKeyPath
I1102 19:32:28.404044 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHUsername
I1102 19:32:28.404195 157504 main.go:141] libmachine: Using SSH client type: native
I1102 19:32:28.404680 157504 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x808a40] 0x80b720 <nil> [] 0s} 192.168.39.48 22 <nil> <nil>}
I1102 19:32:28.404698 157504 main.go:141] libmachine: About to run SSH command:
date +%s.%N
I1102 19:32:28.515091 157504 main.go:141] libmachine: SSH cmd err, output: <nil>: 1698953548.464962943
I1102 19:32:28.515123 157504 fix.go:206] guest clock: 1698953548.464962943
I1102 19:32:28.515133 157504 fix.go:219] Guest: 2023-11-02 19:32:28.464962943 +0000 UTC Remote: 2023-11-02 19:32:28.400550463 +0000 UTC m=+24.640744546 (delta=64.41248ms)
I1102 19:32:28.515168 157504 fix.go:190] guest clock delta is within tolerance: 64.41248ms
I1102 19:32:28.515174 157504 start.go:83] releasing machines lock for "test-preload-636951", held for 20.765083515s
I1102 19:32:28.515195 157504 main.go:141] libmachine: (test-preload-636951) Calling .DriverName
I1102 19:32:28.515472 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetIP
I1102 19:32:28.517806 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:28.518242 157504 main.go:141] libmachine: (test-preload-636951) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:12:6c:4a", ip: ""} in network mk-test-preload-636951: {Iface:virbr1 ExpiryTime:2023-11-02 20:32:20 +0000 UTC Type:0 Mac:52:54:00:12:6c:4a Iaid: IPaddr:192.168.39.48 Prefix:24 Hostname:test-preload-636951 Clientid:01:52:54:00:12:6c:4a}
I1102 19:32:28.518297 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined IP address 192.168.39.48 and MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:28.518504 157504 main.go:141] libmachine: (test-preload-636951) Calling .DriverName
I1102 19:32:28.519013 157504 main.go:141] libmachine: (test-preload-636951) Calling .DriverName
I1102 19:32:28.519194 157504 main.go:141] libmachine: (test-preload-636951) Calling .DriverName
I1102 19:32:28.519306 157504 ssh_runner.go:195] Run: curl -sS -m 2 https://registry.k8s.io/
I1102 19:32:28.519359 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHHostname
I1102 19:32:28.519434 157504 ssh_runner.go:195] Run: cat /version.json
I1102 19:32:28.519462 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHHostname
I1102 19:32:28.521929 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:28.522171 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:28.522299 157504 main.go:141] libmachine: (test-preload-636951) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:12:6c:4a", ip: ""} in network mk-test-preload-636951: {Iface:virbr1 ExpiryTime:2023-11-02 20:32:20 +0000 UTC Type:0 Mac:52:54:00:12:6c:4a Iaid: IPaddr:192.168.39.48 Prefix:24 Hostname:test-preload-636951 Clientid:01:52:54:00:12:6c:4a}
I1102 19:32:28.522329 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined IP address 192.168.39.48 and MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:28.522473 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHPort
I1102 19:32:28.522601 157504 main.go:141] libmachine: (test-preload-636951) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:12:6c:4a", ip: ""} in network mk-test-preload-636951: {Iface:virbr1 ExpiryTime:2023-11-02 20:32:20 +0000 UTC Type:0 Mac:52:54:00:12:6c:4a Iaid: IPaddr:192.168.39.48 Prefix:24 Hostname:test-preload-636951 Clientid:01:52:54:00:12:6c:4a}
I1102 19:32:28.522627 157504 main.go:141] libmachine: (test-preload-636951) DBG | domain test-preload-636951 has defined IP address 192.168.39.48 and MAC address 52:54:00:12:6c:4a in network mk-test-preload-636951
I1102 19:32:28.522633 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHKeyPath
I1102 19:32:28.522766 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHUsername
I1102 19:32:28.522826 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHPort
I1102 19:32:28.522908 157504 sshutil.go:53] new ssh client: &{IP:192.168.39.48 Port:22 SSHKeyPath:/home/jenkins/minikube-integration/17516-131686/.minikube/machines/test-preload-636951/id_rsa Username:docker}
I1102 19:32:28.523009 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHKeyPath
I1102 19:32:28.523141 157504 main.go:141] libmachine: (test-preload-636951) Calling .GetSSHUsername
I1102 19:32:28.523310 157504 sshutil.go:53] new ssh client: &{IP:192.168.39.48 Port:22 SSHKeyPath:/home/jenkins/minikube-integration/17516-131686/.minikube/machines/test-preload-636951/id_rsa Username:docker}
I1102 19:32:28.625565 157504 ssh_runner.go:195] Run: systemctl --version
I1102 19:32:28.632158 157504 ssh_runner.go:195] Run: sh -c "stat /etc/cni/net.d/*loopback.conf*"
W1102 19:32:28.637939 157504 cni.go:209] loopback cni configuration skipped: "/etc/cni/net.d/*loopback.conf*" not found
I1102 19:32:28.638027 157504 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" ;
I1102 19:32:28.653754 157504 cni.go:262] disabled [/etc/cni/net.d/87-podman-bridge.conflist] bridge cni config(s)
I1102 19:32:28.653793 157504 start.go:472] detecting cgroup driver to use...
I1102 19:32:28.653972 157504 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"
I1102 19:32:28.674246 157504 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"
I1102 19:32:28.684002 157504 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"
I1102 19:32:28.694094 157504 containerd.go:145] configuring containerd to use "cgroupfs" as cgroup driver...
I1102 19:32:28.694156 157504 ssh_runner.go:195] Run: sh -c "sudo sed -i -r 's|^( *)SystemdCgroup = .*$|\1SystemdCgroup = false|g' /etc/containerd/config.toml"
I1102 19:32:28.704262 157504 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"
I1102 19:32:28.714241 157504 ssh_runner.go:195] Run: sh -c "sudo sed -i '/systemd_cgroup/d' /etc/containerd/config.toml"
I1102 19:32:28.724133 157504 ssh_runner.go:195] Run: sh -c "sudo sed -i 's|"io.containerd.runc.v1"|"io.containerd.runc.v2"|g' /etc/containerd/config.toml"
I1102 19:32:28.734338 157504 ssh_runner.go:195] Run: sh -c "sudo rm -rf /etc/cni/net.mk"
I1102 19:32:28.745131 157504 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"
I1102 19:32:28.755100 157504 ssh_runner.go:195] Run: sudo sysctl net.bridge.bridge-nf-call-iptables
I1102 19:32:28.763997 157504 ssh_runner.go:195] Run: sudo sh -c "echo 1 > /proc/sys/net/ipv4/ip_forward"
I1102 19:32:28.772730 157504 ssh_runner.go:195] Run: sudo systemctl daemon-reload
I1102 19:32:28.876670 157504 ssh_runner.go:195] Run: sudo systemctl restart containerd
I1102 19:32:28.894203 157504 start.go:472] detecting cgroup driver to use...
I1102 19:32:28.894317 157504 ssh_runner.go:195] Run: sudo systemctl cat docker.service
I1102 19:32:28.908851 157504 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service containerd
I1102 19:32:28.923671 157504 ssh_runner.go:195] Run: sudo systemctl stop -f containerd
I1102 19:32:28.941548 157504 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service containerd
I1102 19:32:28.954375 157504 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service crio
I1102 19:32:28.965747 157504 ssh_runner.go:195] Run: sudo systemctl stop -f crio
I1102 19:32:28.996326 157504 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service crio
I1102 19:32:29.008952 157504 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"
I1102 19:32:29.025807 157504 ssh_runner.go:195] Run: which cri-dockerd
I1102 19:32:29.029377 157504 ssh_runner.go:195] Run: sudo mkdir -p /etc/systemd/system/cri-docker.service.d
I1102 19:32:29.038154 157504 ssh_runner.go:362] scp memory --> /etc/systemd/system/cri-docker.service.d/10-cni.conf (189 bytes)
I1102 19:32:29.053266 157504 ssh_runner.go:195] Run: sudo systemctl unmask docker.service
I1102 19:32:29.158969 157504 ssh_runner.go:195] Run: sudo systemctl enable docker.socket
I1102 19:32:29.274026 157504 docker.go:560] configuring docker to use "cgroupfs" as cgroup driver...
I1102 19:32:29.274175 157504 ssh_runner.go:362] scp memory --> /etc/docker/daemon.json (130 bytes)
I1102 19:32:29.290532 157504 ssh_runner.go:195] Run: sudo systemctl daemon-reload
I1102 19:32:29.385695 157504 ssh_runner.go:195] Run: sudo systemctl restart docker
I1102 19:32:30.842764 157504 ssh_runner.go:235] Completed: sudo systemctl restart docker: (1.457029829s)
I1102 19:32:30.842828 157504 ssh_runner.go:195] Run: sudo systemctl enable cri-docker.socket
I1102 19:32:30.945870 157504 ssh_runner.go:195] Run: sudo systemctl unmask cri-docker.socket
I1102 19:32:31.057962 157504 ssh_runner.go:195] Run: sudo systemctl enable cri-docker.socket
I1102 19:32:31.168409 157504 ssh_runner.go:195] Run: sudo systemctl daemon-reload
I1102 19:32:31.278834 157504 ssh_runner.go:195] Run: sudo systemctl restart cri-docker.socket
I1102 19:32:31.296415 157504 out.go:177]
W1102 19:32:31.297929 157504 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.
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.
W1102 19:32:31.297947 157504 out.go:239] *
*
W1102 19:32:31.298865 157504 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. │
│ │
╰─────────────────────────────────────────────────────────────────────────────────────────────╯
I1102 19:32:31.300541 157504 out.go:177]
** /stderr **
preload_test.go:68: out/minikube-linux-amd64 start -p test-preload-636951 --memory=2200 --alsologtostderr -v=1 --wait=true --driver=kvm2 failed: exit status 90
panic.go:523: *** TestPreload FAILED at 2023-11-02 19:32:31.336389839 +0000 UTC m=+1837.414455877
helpers_test.go:222: -----------------------post-mortem--------------------------------
helpers_test.go:239: (dbg) Run: out/minikube-linux-amd64 status --format={{.Host}} -p test-preload-636951 -n test-preload-636951
helpers_test.go:239: (dbg) Non-zero exit: out/minikube-linux-amd64 status --format={{.Host}} -p test-preload-636951 -n test-preload-636951: exit status 6 (238.123192ms)
-- stdout --
Running
WARNING: Your kubectl is pointing to stale minikube-vm.
To fix the kubectl context, run `minikube update-context`
-- /stdout --
** stderr **
E1102 19:32:31.558733 157665 status.go:415] kubeconfig endpoint: extract IP: "test-preload-636951" does not appear in /home/jenkins/minikube-integration/17516-131686/kubeconfig
** /stderr **
helpers_test.go:239: status error: exit status 6 (may be ok)
helpers_test.go:241: "test-preload-636951" 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-636951" profile ...
helpers_test.go:178: (dbg) Run: out/minikube-linux-amd64 delete -p test-preload-636951
--- FAIL: TestPreload (147.04s)