=== RUN TestNetworkPlugins/group/kindnet/Start
net_test.go:112: (dbg) Run: out/minikube-linux-amd64 start -p kindnet-128972 --memory=3072 --alsologtostderr --wait=true --wait-timeout=15m --cni=kindnet --driver=kvm2
E1010 18:36:54.922466 389340 cert_rotation.go:171] "Unhandled Error" err="key failed with : open /home/jenkins/minikube-integration/19787-382081/.minikube/profiles/gvisor-970545/client.crt: no such file or directory" logger="UnhandledError"
E1010 18:36:57.820423 389340 cert_rotation.go:171] "Unhandled Error" err="key failed with : open /home/jenkins/minikube-integration/19787-382081/.minikube/profiles/addons-318022/client.crt: no such file or directory" logger="UnhandledError"
net_test.go:112: (dbg) Non-zero exit: out/minikube-linux-amd64 start -p kindnet-128972 --memory=3072 --alsologtostderr --wait=true --wait-timeout=15m --cni=kindnet --driver=kvm2 : exit status 90 (1m46.271442782s)
-- stdout --
* [kindnet-128972] minikube v1.34.0 on Ubuntu 20.04 (kvm/amd64)
- MINIKUBE_LOCATION=19787
- MINIKUBE_SUPPRESS_DOCKER_PERFORMANCE=true
- KUBECONFIG=/home/jenkins/minikube-integration/19787-382081/kubeconfig
- MINIKUBE_HOME=/home/jenkins/minikube-integration/19787-382081/.minikube
- MINIKUBE_BIN=out/minikube-linux-amd64
- MINIKUBE_FORCE_SYSTEMD=
* Using the kvm2 driver based on user configuration
* Starting "kindnet-128972" primary control-plane node in "kindnet-128972" cluster
* Creating kvm2 VM (CPUs=2, Memory=3072MB, Disk=20000MB) ...
-- /stdout --
** stderr **
I1010 18:36:52.392000 428417 out.go:345] Setting OutFile to fd 1 ...
I1010 18:36:52.392192 428417 out.go:392] TERM=,COLORTERM=, which probably does not support color
I1010 18:36:52.392216 428417 out.go:358] Setting ErrFile to fd 2...
I1010 18:36:52.392228 428417 out.go:392] TERM=,COLORTERM=, which probably does not support color
I1010 18:36:52.392410 428417 root.go:338] Updating PATH: /home/jenkins/minikube-integration/19787-382081/.minikube/bin
I1010 18:36:52.393044 428417 out.go:352] Setting JSON to false
I1010 18:36:52.394192 428417 start.go:129] hostinfo: {"hostname":"ubuntu-20-agent-8","uptime":8351,"bootTime":1728577061,"procs":215,"os":"linux","platform":"ubuntu","platformFamily":"debian","platformVersion":"20.04","kernelVersion":"5.15.0-1069-gcp","kernelArch":"x86_64","virtualizationSystem":"kvm","virtualizationRole":"guest","hostId":"591c9f12-2938-3743-e2bf-c56a050d43d1"}
I1010 18:36:52.394286 428417 start.go:139] virtualization: kvm guest
I1010 18:36:52.500845 428417 out.go:177] * [kindnet-128972] minikube v1.34.0 on Ubuntu 20.04 (kvm/amd64)
I1010 18:36:52.521765 428417 notify.go:220] Checking for updates...
I1010 18:36:52.604433 428417 out.go:177] - MINIKUBE_LOCATION=19787
I1010 18:36:52.606260 428417 out.go:177] - MINIKUBE_SUPPRESS_DOCKER_PERFORMANCE=true
I1010 18:36:52.607382 428417 out.go:177] - KUBECONFIG=/home/jenkins/minikube-integration/19787-382081/kubeconfig
I1010 18:36:52.608275 428417 out.go:177] - MINIKUBE_HOME=/home/jenkins/minikube-integration/19787-382081/.minikube
I1010 18:36:52.609447 428417 out.go:177] - MINIKUBE_BIN=out/minikube-linux-amd64
I1010 18:36:52.613394 428417 out.go:177] - MINIKUBE_FORCE_SYSTEMD=
I1010 18:36:52.615116 428417 config.go:182] Loaded profile config "NoKubernetes-579040": Driver=kvm2, ContainerRuntime=docker, KubernetesVersion=v0.0.0
I1010 18:36:52.615207 428417 config.go:182] Loaded profile config "auto-128972": Driver=kvm2, ContainerRuntime=docker, KubernetesVersion=v1.31.1
I1010 18:36:52.615328 428417 config.go:182] Loaded profile config "pause-788541": Driver=kvm2, ContainerRuntime=docker, KubernetesVersion=v1.31.1
I1010 18:36:52.615410 428417 driver.go:394] Setting default libvirt URI to qemu:///system
I1010 18:36:52.658899 428417 out.go:177] * Using the kvm2 driver based on user configuration
I1010 18:36:52.660225 428417 start.go:297] selected driver: kvm2
I1010 18:36:52.660244 428417 start.go:901] validating driver "kvm2" against <nil>
I1010 18:36:52.660261 428417 start.go:912] status for kvm2: {Installed:true Healthy:true Running:true NeedsImprovement:false Error:<nil> Reason: Fix: Doc: Version:}
I1010 18:36:52.661379 428417 install.go:52] acquiring lock: {Name:mk900956b073697a4aa6c80a27c6bb0742a99a53 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I1010 18:36:52.661476 428417 install.go:117] Validating docker-machine-driver-kvm2, PATH=/home/jenkins/minikube-integration/19787-382081/.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
I1010 18:36:52.684296 428417 install.go:137] /home/jenkins/workspace/KVM_Linux_integration/out/docker-machine-driver-kvm2 version is 1.34.0
I1010 18:36:52.684374 428417 start_flags.go:310] no existing cluster config was found, will generate one from the flags
I1010 18:36:52.684789 428417 start_flags.go:947] Waiting for all components: map[apiserver:true apps_running:true default_sa:true extra:true kubelet:true node_ready:true system_pods:true]
I1010 18:36:52.684950 428417 cni.go:84] Creating CNI manager for "kindnet"
I1010 18:36:52.684972 428417 start_flags.go:319] Found "CNI" CNI - setting NetworkPlugin=cni
I1010 18:36:52.685110 428417 start.go:340] cluster config:
{Name:kindnet-128972 KeepContext:false EmbedCerts:false MinikubeISO: KicBaseImage:gcr.io/k8s-minikube/kicbase-builds:v0.0.45-1728382586-19774@sha256:5d8c4f6d838467365e214e2194dd0153a763e3f78723b5f2a8e06ef7b47409ec Memory:3072 CPUs:2 DiskSize:20000 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:8443 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.31.1 ClusterName:kindnet-128972 Namespace:default APIServerHAVIP: 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:kindnet} Nodes:[{Name: IP: Port:8443 KubernetesVersion:v1.31.1 ContainerRuntime:docker ControlPlane:true Worker:true}] Addons:map[] 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:15m0s 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 MountOptions:[] MountPort:0 MountType:9p MountUID:docker BinaryMirror: DisableOptimizations:false DisableMetrics:false CustomQemuFirmwarePath: SocketVMnetClientPath: SocketVMnetPath: StaticIP: SSHA
uthSock: SSHAgentPID:0 GPUs: AutoPauseInterval:1m0s}
I1010 18:36:52.685294 428417 iso.go:125] acquiring lock: {Name:mkcbf496122f95a61f89dcfec7af26a1bba9372c Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I1010 18:36:52.774981 428417 out.go:177] * Starting "kindnet-128972" primary control-plane node in "kindnet-128972" cluster
I1010 18:36:52.776222 428417 preload.go:131] Checking if preload exists for k8s version v1.31.1 and runtime docker
I1010 18:36:52.776310 428417 preload.go:146] Found local preload: /home/jenkins/minikube-integration/19787-382081/.minikube/cache/preloaded-tarball/preloaded-images-k8s-v18-v1.31.1-docker-overlay2-amd64.tar.lz4
I1010 18:36:52.776326 428417 cache.go:56] Caching tarball of preloaded images
I1010 18:36:52.776492 428417 preload.go:172] Found /home/jenkins/minikube-integration/19787-382081/.minikube/cache/preloaded-tarball/preloaded-images-k8s-v18-v1.31.1-docker-overlay2-amd64.tar.lz4 in cache, skipping download
I1010 18:36:52.776510 428417 cache.go:59] Finished verifying existence of preloaded tar for v1.31.1 on docker
I1010 18:36:52.776670 428417 profile.go:143] Saving config to /home/jenkins/minikube-integration/19787-382081/.minikube/profiles/kindnet-128972/config.json ...
I1010 18:36:52.776696 428417 lock.go:35] WriteFile acquiring /home/jenkins/minikube-integration/19787-382081/.minikube/profiles/kindnet-128972/config.json: {Name:mk10b23331eb6d40b9c78d195f6f480a8db23e0b Clock:{} Delay:500ms Timeout:1m0s Cancel:<nil>}
I1010 18:36:52.776894 428417 start.go:360] acquireMachinesLock for kindnet-128972: {Name:mk6d008ab1718527f39f47804e96561f65350a97 Clock:{} Delay:500ms Timeout:13m0s Cancel:<nil>}
I1010 18:37:10.335341 428417 start.go:364] duration metric: took 17.558409379s to acquireMachinesLock for "kindnet-128972"
I1010 18:37:10.335397 428417 start.go:93] Provisioning new machine with config: &{Name:kindnet-128972 KeepContext:false EmbedCerts:false MinikubeISO:https://storage.googleapis.com/minikube-builds/iso/19774/minikube-v1.34.0-1728382514-19774-amd64.iso KicBaseImage:gcr.io/k8s-minikube/kicbase-builds:v0.0.45-1728382586-19774@sha256:5d8c4f6d838467365e214e2194dd0153a763e3f78723b5f2a8e06ef7b47409ec Memory:3072 CPUs:2 DiskSize:20000 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:8443 DockerOpt:[] DisableDriverMounts:false NFSShare:[] NFSSharesRoot:/nfsshares UUID: NoVTXCheck:false DNSProxy:false HostDNSResolver:true HostOnlyNicType:virtio NatNicType:virtio SSHIPAddress: SSHUser:root SSHKey: SSHPort:22 KubernetesConfig:{Kube
rnetesVersion:v1.31.1 ClusterName:kindnet-128972 Namespace:default APIServerHAVIP: 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:kindnet} Nodes:[{Name: IP: Port:8443 KubernetesVersion:v1.31.1 ContainerRuntime:docker ControlPlane:true Worker:true}] Addons:map[] 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:15m0s 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 MountOptions:[]
MountPort:0 MountType:9p MountUID:docker BinaryMirror: DisableOptimizations:false DisableMetrics:false CustomQemuFirmwarePath: SocketVMnetClientPath: SocketVMnetPath: StaticIP: SSHAuthSock: SSHAgentPID:0 GPUs: AutoPauseInterval:1m0s} &{Name: IP: Port:8443 KubernetesVersion:v1.31.1 ContainerRuntime:docker ControlPlane:true Worker:true}
I1010 18:37:10.335510 428417 start.go:125] createHost starting for "" (driver="kvm2")
I1010 18:37:10.337515 428417 out.go:235] * Creating kvm2 VM (CPUs=2, Memory=3072MB, Disk=20000MB) ...
I1010 18:37:10.337732 428417 main.go:141] libmachine: Found binary path at /home/jenkins/workspace/KVM_Linux_integration/out/docker-machine-driver-kvm2
I1010 18:37:10.337813 428417 main.go:141] libmachine: Launching plugin server for driver kvm2
I1010 18:37:10.355308 428417 main.go:141] libmachine: Plugin server listening at address 127.0.0.1:34861
I1010 18:37:10.355776 428417 main.go:141] libmachine: () Calling .GetVersion
I1010 18:37:10.356307 428417 main.go:141] libmachine: Using API Version 1
I1010 18:37:10.356327 428417 main.go:141] libmachine: () Calling .SetConfigRaw
I1010 18:37:10.356686 428417 main.go:141] libmachine: () Calling .GetMachineName
I1010 18:37:10.356878 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetMachineName
I1010 18:37:10.357004 428417 main.go:141] libmachine: (kindnet-128972) Calling .DriverName
I1010 18:37:10.357146 428417 start.go:159] libmachine.API.Create for "kindnet-128972" (driver="kvm2")
I1010 18:37:10.357179 428417 client.go:168] LocalClient.Create starting
I1010 18:37:10.357216 428417 main.go:141] libmachine: Reading certificate data from /home/jenkins/minikube-integration/19787-382081/.minikube/certs/ca.pem
I1010 18:37:10.357256 428417 main.go:141] libmachine: Decoding PEM data...
I1010 18:37:10.357280 428417 main.go:141] libmachine: Parsing certificate...
I1010 18:37:10.357357 428417 main.go:141] libmachine: Reading certificate data from /home/jenkins/minikube-integration/19787-382081/.minikube/certs/cert.pem
I1010 18:37:10.357393 428417 main.go:141] libmachine: Decoding PEM data...
I1010 18:37:10.357405 428417 main.go:141] libmachine: Parsing certificate...
I1010 18:37:10.357430 428417 main.go:141] libmachine: Running pre-create checks...
I1010 18:37:10.357442 428417 main.go:141] libmachine: (kindnet-128972) Calling .PreCreateCheck
I1010 18:37:10.357818 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetConfigRaw
I1010 18:37:10.358266 428417 main.go:141] libmachine: Creating machine...
I1010 18:37:10.358280 428417 main.go:141] libmachine: (kindnet-128972) Calling .Create
I1010 18:37:10.358447 428417 main.go:141] libmachine: (kindnet-128972) Creating KVM machine...
I1010 18:37:10.359662 428417 main.go:141] libmachine: (kindnet-128972) DBG | found existing default KVM network
I1010 18:37:10.360798 428417 main.go:141] libmachine: (kindnet-128972) DBG | I1010 18:37:10.360623 428966 network.go:211] skipping subnet 192.168.39.0/24 that is taken: &{IP:192.168.39.0 Netmask:255.255.255.0 Prefix:24 CIDR:192.168.39.0/24 Gateway:192.168.39.1 ClientMin:192.168.39.2 ClientMax:192.168.39.254 Broadcast:192.168.39.255 IsPrivate:true Interface:{IfaceName:virbr2 IfaceIPv4:192.168.39.1 IfaceMTU:1500 IfaceMAC:52:54:00:54:79:44} reservation:<nil>}
I1010 18:37:10.361583 428417 main.go:141] libmachine: (kindnet-128972) DBG | I1010 18:37:10.361504 428966 network.go:211] skipping subnet 192.168.50.0/24 that is taken: &{IP:192.168.50.0 Netmask:255.255.255.0 Prefix:24 CIDR:192.168.50.0/24 Gateway:192.168.50.1 ClientMin:192.168.50.2 ClientMax:192.168.50.254 Broadcast:192.168.50.255 IsPrivate:true Interface:{IfaceName:virbr3 IfaceIPv4:192.168.50.1 IfaceMTU:1500 IfaceMAC:52:54:00:3c:98:48} reservation:<nil>}
I1010 18:37:10.362848 428417 main.go:141] libmachine: (kindnet-128972) DBG | I1010 18:37:10.362755 428966 network.go:206] using free private subnet 192.168.61.0/24: &{IP:192.168.61.0 Netmask:255.255.255.0 Prefix:24 CIDR:192.168.61.0/24 Gateway:192.168.61.1 ClientMin:192.168.61.2 ClientMax:192.168.61.254 Broadcast:192.168.61.255 IsPrivate:true Interface:{IfaceName: IfaceIPv4: IfaceMTU:0 IfaceMAC:} reservation:0xc0002d2510}
I1010 18:37:10.362879 428417 main.go:141] libmachine: (kindnet-128972) DBG | created network xml:
I1010 18:37:10.362892 428417 main.go:141] libmachine: (kindnet-128972) DBG | <network>
I1010 18:37:10.362904 428417 main.go:141] libmachine: (kindnet-128972) DBG | <name>mk-kindnet-128972</name>
I1010 18:37:10.362920 428417 main.go:141] libmachine: (kindnet-128972) DBG | <dns enable='no'/>
I1010 18:37:10.362943 428417 main.go:141] libmachine: (kindnet-128972) DBG |
I1010 18:37:10.362958 428417 main.go:141] libmachine: (kindnet-128972) DBG | <ip address='192.168.61.1' netmask='255.255.255.0'>
I1010 18:37:10.362968 428417 main.go:141] libmachine: (kindnet-128972) DBG | <dhcp>
I1010 18:37:10.362979 428417 main.go:141] libmachine: (kindnet-128972) DBG | <range start='192.168.61.2' end='192.168.61.253'/>
I1010 18:37:10.362995 428417 main.go:141] libmachine: (kindnet-128972) DBG | </dhcp>
I1010 18:37:10.363007 428417 main.go:141] libmachine: (kindnet-128972) DBG | </ip>
I1010 18:37:10.363014 428417 main.go:141] libmachine: (kindnet-128972) DBG |
I1010 18:37:10.363026 428417 main.go:141] libmachine: (kindnet-128972) DBG | </network>
I1010 18:37:10.363036 428417 main.go:141] libmachine: (kindnet-128972) DBG |
I1010 18:37:10.368513 428417 main.go:141] libmachine: (kindnet-128972) DBG | trying to create private KVM network mk-kindnet-128972 192.168.61.0/24...
I1010 18:37:10.441095 428417 main.go:141] libmachine: (kindnet-128972) DBG | private KVM network mk-kindnet-128972 192.168.61.0/24 created
I1010 18:37:10.441147 428417 main.go:141] libmachine: (kindnet-128972) Setting up store path in /home/jenkins/minikube-integration/19787-382081/.minikube/machines/kindnet-128972 ...
I1010 18:37:10.441168 428417 main.go:141] libmachine: (kindnet-128972) DBG | I1010 18:37:10.441084 428966 common.go:145] Making disk image using store path: /home/jenkins/minikube-integration/19787-382081/.minikube
I1010 18:37:10.441186 428417 main.go:141] libmachine: (kindnet-128972) Building disk image from file:///home/jenkins/minikube-integration/19787-382081/.minikube/cache/iso/amd64/minikube-v1.34.0-1728382514-19774-amd64.iso
I1010 18:37:10.441296 428417 main.go:141] libmachine: (kindnet-128972) Downloading /home/jenkins/minikube-integration/19787-382081/.minikube/cache/boot2docker.iso from file:///home/jenkins/minikube-integration/19787-382081/.minikube/cache/iso/amd64/minikube-v1.34.0-1728382514-19774-amd64.iso...
I1010 18:37:10.722409 428417 main.go:141] libmachine: (kindnet-128972) DBG | I1010 18:37:10.722257 428966 common.go:152] Creating ssh key: /home/jenkins/minikube-integration/19787-382081/.minikube/machines/kindnet-128972/id_rsa...
I1010 18:37:10.885112 428417 main.go:141] libmachine: (kindnet-128972) DBG | I1010 18:37:10.884976 428966 common.go:158] Creating raw disk image: /home/jenkins/minikube-integration/19787-382081/.minikube/machines/kindnet-128972/kindnet-128972.rawdisk...
I1010 18:37:10.885145 428417 main.go:141] libmachine: (kindnet-128972) DBG | Writing magic tar header
I1010 18:37:10.885161 428417 main.go:141] libmachine: (kindnet-128972) DBG | Writing SSH key tar header
I1010 18:37:10.885173 428417 main.go:141] libmachine: (kindnet-128972) DBG | I1010 18:37:10.885124 428966 common.go:172] Fixing permissions on /home/jenkins/minikube-integration/19787-382081/.minikube/machines/kindnet-128972 ...
I1010 18:37:10.885275 428417 main.go:141] libmachine: (kindnet-128972) DBG | Checking permissions on dir: /home/jenkins/minikube-integration/19787-382081/.minikube/machines/kindnet-128972
I1010 18:37:10.885299 428417 main.go:141] libmachine: (kindnet-128972) DBG | Checking permissions on dir: /home/jenkins/minikube-integration/19787-382081/.minikube/machines
I1010 18:37:10.885308 428417 main.go:141] libmachine: (kindnet-128972) Setting executable bit set on /home/jenkins/minikube-integration/19787-382081/.minikube/machines/kindnet-128972 (perms=drwx------)
I1010 18:37:10.885318 428417 main.go:141] libmachine: (kindnet-128972) Setting executable bit set on /home/jenkins/minikube-integration/19787-382081/.minikube/machines (perms=drwxr-xr-x)
I1010 18:37:10.885325 428417 main.go:141] libmachine: (kindnet-128972) Setting executable bit set on /home/jenkins/minikube-integration/19787-382081/.minikube (perms=drwxr-xr-x)
I1010 18:37:10.885332 428417 main.go:141] libmachine: (kindnet-128972) DBG | Checking permissions on dir: /home/jenkins/minikube-integration/19787-382081/.minikube
I1010 18:37:10.885343 428417 main.go:141] libmachine: (kindnet-128972) Setting executable bit set on /home/jenkins/minikube-integration/19787-382081 (perms=drwxrwxr-x)
I1010 18:37:10.885353 428417 main.go:141] libmachine: (kindnet-128972) Setting executable bit set on /home/jenkins/minikube-integration (perms=drwxrwxr-x)
I1010 18:37:10.885358 428417 main.go:141] libmachine: (kindnet-128972) Setting executable bit set on /home/jenkins (perms=drwxr-xr-x)
I1010 18:37:10.885366 428417 main.go:141] libmachine: (kindnet-128972) DBG | Checking permissions on dir: /home/jenkins/minikube-integration/19787-382081
I1010 18:37:10.885372 428417 main.go:141] libmachine: (kindnet-128972) Creating domain...
I1010 18:37:10.885382 428417 main.go:141] libmachine: (kindnet-128972) DBG | Checking permissions on dir: /home/jenkins/minikube-integration
I1010 18:37:10.885389 428417 main.go:141] libmachine: (kindnet-128972) DBG | Checking permissions on dir: /home/jenkins
I1010 18:37:10.885395 428417 main.go:141] libmachine: (kindnet-128972) DBG | Checking permissions on dir: /home
I1010 18:37:10.885401 428417 main.go:141] libmachine: (kindnet-128972) DBG | Skipping /home - not owner
I1010 18:37:10.886561 428417 main.go:141] libmachine: (kindnet-128972) define libvirt domain using xml:
I1010 18:37:10.886576 428417 main.go:141] libmachine: (kindnet-128972) <domain type='kvm'>
I1010 18:37:10.886582 428417 main.go:141] libmachine: (kindnet-128972) <name>kindnet-128972</name>
I1010 18:37:10.886587 428417 main.go:141] libmachine: (kindnet-128972) <memory unit='MiB'>3072</memory>
I1010 18:37:10.886592 428417 main.go:141] libmachine: (kindnet-128972) <vcpu>2</vcpu>
I1010 18:37:10.886595 428417 main.go:141] libmachine: (kindnet-128972) <features>
I1010 18:37:10.886600 428417 main.go:141] libmachine: (kindnet-128972) <acpi/>
I1010 18:37:10.886610 428417 main.go:141] libmachine: (kindnet-128972) <apic/>
I1010 18:37:10.886615 428417 main.go:141] libmachine: (kindnet-128972) <pae/>
I1010 18:37:10.886618 428417 main.go:141] libmachine: (kindnet-128972)
I1010 18:37:10.886623 428417 main.go:141] libmachine: (kindnet-128972) </features>
I1010 18:37:10.886627 428417 main.go:141] libmachine: (kindnet-128972) <cpu mode='host-passthrough'>
I1010 18:37:10.886632 428417 main.go:141] libmachine: (kindnet-128972)
I1010 18:37:10.886637 428417 main.go:141] libmachine: (kindnet-128972) </cpu>
I1010 18:37:10.886644 428417 main.go:141] libmachine: (kindnet-128972) <os>
I1010 18:37:10.886661 428417 main.go:141] libmachine: (kindnet-128972) <type>hvm</type>
I1010 18:37:10.886672 428417 main.go:141] libmachine: (kindnet-128972) <boot dev='cdrom'/>
I1010 18:37:10.886681 428417 main.go:141] libmachine: (kindnet-128972) <boot dev='hd'/>
I1010 18:37:10.886697 428417 main.go:141] libmachine: (kindnet-128972) <bootmenu enable='no'/>
I1010 18:37:10.886708 428417 main.go:141] libmachine: (kindnet-128972) </os>
I1010 18:37:10.886713 428417 main.go:141] libmachine: (kindnet-128972) <devices>
I1010 18:37:10.886718 428417 main.go:141] libmachine: (kindnet-128972) <disk type='file' device='cdrom'>
I1010 18:37:10.886745 428417 main.go:141] libmachine: (kindnet-128972) <source file='/home/jenkins/minikube-integration/19787-382081/.minikube/machines/kindnet-128972/boot2docker.iso'/>
I1010 18:37:10.886761 428417 main.go:141] libmachine: (kindnet-128972) <target dev='hdc' bus='scsi'/>
I1010 18:37:10.886770 428417 main.go:141] libmachine: (kindnet-128972) <readonly/>
I1010 18:37:10.886774 428417 main.go:141] libmachine: (kindnet-128972) </disk>
I1010 18:37:10.886779 428417 main.go:141] libmachine: (kindnet-128972) <disk type='file' device='disk'>
I1010 18:37:10.886788 428417 main.go:141] libmachine: (kindnet-128972) <driver name='qemu' type='raw' cache='default' io='threads' />
I1010 18:37:10.886795 428417 main.go:141] libmachine: (kindnet-128972) <source file='/home/jenkins/minikube-integration/19787-382081/.minikube/machines/kindnet-128972/kindnet-128972.rawdisk'/>
I1010 18:37:10.886804 428417 main.go:141] libmachine: (kindnet-128972) <target dev='hda' bus='virtio'/>
I1010 18:37:10.886809 428417 main.go:141] libmachine: (kindnet-128972) </disk>
I1010 18:37:10.886815 428417 main.go:141] libmachine: (kindnet-128972) <interface type='network'>
I1010 18:37:10.886821 428417 main.go:141] libmachine: (kindnet-128972) <source network='mk-kindnet-128972'/>
I1010 18:37:10.886827 428417 main.go:141] libmachine: (kindnet-128972) <model type='virtio'/>
I1010 18:37:10.886832 428417 main.go:141] libmachine: (kindnet-128972) </interface>
I1010 18:37:10.886837 428417 main.go:141] libmachine: (kindnet-128972) <interface type='network'>
I1010 18:37:10.886845 428417 main.go:141] libmachine: (kindnet-128972) <source network='default'/>
I1010 18:37:10.886849 428417 main.go:141] libmachine: (kindnet-128972) <model type='virtio'/>
I1010 18:37:10.886854 428417 main.go:141] libmachine: (kindnet-128972) </interface>
I1010 18:37:10.886857 428417 main.go:141] libmachine: (kindnet-128972) <serial type='pty'>
I1010 18:37:10.886862 428417 main.go:141] libmachine: (kindnet-128972) <target port='0'/>
I1010 18:37:10.886866 428417 main.go:141] libmachine: (kindnet-128972) </serial>
I1010 18:37:10.886871 428417 main.go:141] libmachine: (kindnet-128972) <console type='pty'>
I1010 18:37:10.886875 428417 main.go:141] libmachine: (kindnet-128972) <target type='serial' port='0'/>
I1010 18:37:10.886879 428417 main.go:141] libmachine: (kindnet-128972) </console>
I1010 18:37:10.886885 428417 main.go:141] libmachine: (kindnet-128972) <rng model='virtio'>
I1010 18:37:10.886891 428417 main.go:141] libmachine: (kindnet-128972) <backend model='random'>/dev/random</backend>
I1010 18:37:10.886900 428417 main.go:141] libmachine: (kindnet-128972) </rng>
I1010 18:37:10.886932 428417 main.go:141] libmachine: (kindnet-128972)
I1010 18:37:10.886951 428417 main.go:141] libmachine: (kindnet-128972)
I1010 18:37:10.886965 428417 main.go:141] libmachine: (kindnet-128972) </devices>
I1010 18:37:10.886975 428417 main.go:141] libmachine: (kindnet-128972) </domain>
I1010 18:37:10.887006 428417 main.go:141] libmachine: (kindnet-128972)
I1010 18:37:10.891443 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined MAC address 52:54:00:a3:b7:da in network default
I1010 18:37:10.892037 428417 main.go:141] libmachine: (kindnet-128972) Ensuring networks are active...
I1010 18:37:10.892081 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:10.892734 428417 main.go:141] libmachine: (kindnet-128972) Ensuring network default is active
I1010 18:37:10.893178 428417 main.go:141] libmachine: (kindnet-128972) Ensuring network mk-kindnet-128972 is active
I1010 18:37:10.893645 428417 main.go:141] libmachine: (kindnet-128972) Getting domain xml...
I1010 18:37:10.894396 428417 main.go:141] libmachine: (kindnet-128972) Creating domain...
I1010 18:37:12.254080 428417 main.go:141] libmachine: (kindnet-128972) Waiting to get IP...
I1010 18:37:12.254991 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:12.255461 428417 main.go:141] libmachine: (kindnet-128972) DBG | unable to find current IP address of domain kindnet-128972 in network mk-kindnet-128972
I1010 18:37:12.255491 428417 main.go:141] libmachine: (kindnet-128972) DBG | I1010 18:37:12.255443 428966 retry.go:31] will retry after 262.307801ms: waiting for machine to come up
I1010 18:37:12.518825 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:12.519349 428417 main.go:141] libmachine: (kindnet-128972) DBG | unable to find current IP address of domain kindnet-128972 in network mk-kindnet-128972
I1010 18:37:12.519371 428417 main.go:141] libmachine: (kindnet-128972) DBG | I1010 18:37:12.519318 428966 retry.go:31] will retry after 262.142401ms: waiting for machine to come up
I1010 18:37:12.782866 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:12.783479 428417 main.go:141] libmachine: (kindnet-128972) DBG | unable to find current IP address of domain kindnet-128972 in network mk-kindnet-128972
I1010 18:37:12.783505 428417 main.go:141] libmachine: (kindnet-128972) DBG | I1010 18:37:12.783418 428966 retry.go:31] will retry after 442.410396ms: waiting for machine to come up
I1010 18:37:13.227122 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:13.227639 428417 main.go:141] libmachine: (kindnet-128972) DBG | unable to find current IP address of domain kindnet-128972 in network mk-kindnet-128972
I1010 18:37:13.227690 428417 main.go:141] libmachine: (kindnet-128972) DBG | I1010 18:37:13.227594 428966 retry.go:31] will retry after 374.532691ms: waiting for machine to come up
I1010 18:37:13.604308 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:13.604769 428417 main.go:141] libmachine: (kindnet-128972) DBG | unable to find current IP address of domain kindnet-128972 in network mk-kindnet-128972
I1010 18:37:13.604812 428417 main.go:141] libmachine: (kindnet-128972) DBG | I1010 18:37:13.604728 428966 retry.go:31] will retry after 653.305048ms: waiting for machine to come up
I1010 18:37:14.259506 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:14.260023 428417 main.go:141] libmachine: (kindnet-128972) DBG | unable to find current IP address of domain kindnet-128972 in network mk-kindnet-128972
I1010 18:37:14.260050 428417 main.go:141] libmachine: (kindnet-128972) DBG | I1010 18:37:14.259971 428966 retry.go:31] will retry after 631.474742ms: waiting for machine to come up
I1010 18:37:14.892433 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:14.892951 428417 main.go:141] libmachine: (kindnet-128972) DBG | unable to find current IP address of domain kindnet-128972 in network mk-kindnet-128972
I1010 18:37:14.892976 428417 main.go:141] libmachine: (kindnet-128972) DBG | I1010 18:37:14.892899 428966 retry.go:31] will retry after 813.606073ms: waiting for machine to come up
I1010 18:37:15.708286 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:15.708897 428417 main.go:141] libmachine: (kindnet-128972) DBG | unable to find current IP address of domain kindnet-128972 in network mk-kindnet-128972
I1010 18:37:15.708919 428417 main.go:141] libmachine: (kindnet-128972) DBG | I1010 18:37:15.708822 428966 retry.go:31] will retry after 1.444679101s: waiting for machine to come up
I1010 18:37:17.155649 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:17.156145 428417 main.go:141] libmachine: (kindnet-128972) DBG | unable to find current IP address of domain kindnet-128972 in network mk-kindnet-128972
I1010 18:37:17.156208 428417 main.go:141] libmachine: (kindnet-128972) DBG | I1010 18:37:17.156123 428966 retry.go:31] will retry after 1.207654744s: waiting for machine to come up
I1010 18:37:18.365925 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:18.366329 428417 main.go:141] libmachine: (kindnet-128972) DBG | unable to find current IP address of domain kindnet-128972 in network mk-kindnet-128972
I1010 18:37:18.366351 428417 main.go:141] libmachine: (kindnet-128972) DBG | I1010 18:37:18.366301 428966 retry.go:31] will retry after 1.604275352s: waiting for machine to come up
I1010 18:37:19.973163 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:19.973674 428417 main.go:141] libmachine: (kindnet-128972) DBG | unable to find current IP address of domain kindnet-128972 in network mk-kindnet-128972
I1010 18:37:19.973705 428417 main.go:141] libmachine: (kindnet-128972) DBG | I1010 18:37:19.973619 428966 retry.go:31] will retry after 2.302154253s: waiting for machine to come up
I1010 18:37:22.276821 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:22.277246 428417 main.go:141] libmachine: (kindnet-128972) DBG | unable to find current IP address of domain kindnet-128972 in network mk-kindnet-128972
I1010 18:37:22.277267 428417 main.go:141] libmachine: (kindnet-128972) DBG | I1010 18:37:22.277202 428966 retry.go:31] will retry after 2.204694519s: waiting for machine to come up
I1010 18:37:24.483716 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:24.484098 428417 main.go:141] libmachine: (kindnet-128972) DBG | unable to find current IP address of domain kindnet-128972 in network mk-kindnet-128972
I1010 18:37:24.484128 428417 main.go:141] libmachine: (kindnet-128972) DBG | I1010 18:37:24.484052 428966 retry.go:31] will retry after 3.270979724s: waiting for machine to come up
I1010 18:37:27.757755 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:27.758267 428417 main.go:141] libmachine: (kindnet-128972) DBG | unable to find current IP address of domain kindnet-128972 in network mk-kindnet-128972
I1010 18:37:27.758290 428417 main.go:141] libmachine: (kindnet-128972) DBG | I1010 18:37:27.758232 428966 retry.go:31] will retry after 5.543391519s: waiting for machine to come up
I1010 18:37:33.303746 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:33.304227 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has current primary IP address 192.168.61.214 and MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:33.304249 428417 main.go:141] libmachine: (kindnet-128972) Found IP for machine: 192.168.61.214
I1010 18:37:33.304263 428417 main.go:141] libmachine: (kindnet-128972) Reserving static IP address...
I1010 18:37:33.304764 428417 main.go:141] libmachine: (kindnet-128972) DBG | unable to find host DHCP lease matching {name: "kindnet-128972", mac: "52:54:00:f4:2b:d1", ip: "192.168.61.214"} in network mk-kindnet-128972
I1010 18:37:33.380999 428417 main.go:141] libmachine: (kindnet-128972) DBG | Getting to WaitForSSH function...
I1010 18:37:33.381035 428417 main.go:141] libmachine: (kindnet-128972) Reserved static IP address: 192.168.61.214
I1010 18:37:33.381048 428417 main.go:141] libmachine: (kindnet-128972) Waiting for SSH to be available...
I1010 18:37:33.383902 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:33.384377 428417 main.go:141] libmachine: (kindnet-128972) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:f4:2b:d1", ip: ""} in network mk-kindnet-128972: {Iface:virbr1 ExpiryTime:2024-10-10 19:37:24 +0000 UTC Type:0 Mac:52:54:00:f4:2b:d1 Iaid: IPaddr:192.168.61.214 Prefix:24 Hostname:minikube Clientid:01:52:54:00:f4:2b:d1}
I1010 18:37:33.384407 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined IP address 192.168.61.214 and MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:33.384540 428417 main.go:141] libmachine: (kindnet-128972) DBG | Using SSH client type: external
I1010 18:37:33.384564 428417 main.go:141] libmachine: (kindnet-128972) DBG | Using SSH private key: /home/jenkins/minikube-integration/19787-382081/.minikube/machines/kindnet-128972/id_rsa (-rw-------)
I1010 18:37:33.384600 428417 main.go:141] libmachine: (kindnet-128972) 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.61.214 -o IdentitiesOnly=yes -i /home/jenkins/minikube-integration/19787-382081/.minikube/machines/kindnet-128972/id_rsa -p 22] /usr/bin/ssh <nil>}
I1010 18:37:33.384610 428417 main.go:141] libmachine: (kindnet-128972) DBG | About to run SSH command:
I1010 18:37:33.384628 428417 main.go:141] libmachine: (kindnet-128972) DBG | exit 0
I1010 18:37:33.510681 428417 main.go:141] libmachine: (kindnet-128972) DBG | SSH cmd err, output: <nil>:
I1010 18:37:33.510968 428417 main.go:141] libmachine: (kindnet-128972) KVM machine creation complete!
I1010 18:37:33.511289 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetConfigRaw
I1010 18:37:33.511871 428417 main.go:141] libmachine: (kindnet-128972) Calling .DriverName
I1010 18:37:33.512052 428417 main.go:141] libmachine: (kindnet-128972) Calling .DriverName
I1010 18:37:33.512217 428417 main.go:141] libmachine: Waiting for machine to be running, this may take a few minutes...
I1010 18:37:33.512231 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetState
I1010 18:37:33.513439 428417 main.go:141] libmachine: Detecting operating system of created instance...
I1010 18:37:33.513458 428417 main.go:141] libmachine: Waiting for SSH to be available...
I1010 18:37:33.513463 428417 main.go:141] libmachine: Getting to WaitForSSH function...
I1010 18:37:33.513468 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHHostname
I1010 18:37:33.515850 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:33.516196 428417 main.go:141] libmachine: (kindnet-128972) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:f4:2b:d1", ip: ""} in network mk-kindnet-128972: {Iface:virbr1 ExpiryTime:2024-10-10 19:37:24 +0000 UTC Type:0 Mac:52:54:00:f4:2b:d1 Iaid: IPaddr:192.168.61.214 Prefix:24 Hostname:kindnet-128972 Clientid:01:52:54:00:f4:2b:d1}
I1010 18:37:33.516230 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined IP address 192.168.61.214 and MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:33.516365 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHPort
I1010 18:37:33.516549 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHKeyPath
I1010 18:37:33.516682 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHKeyPath
I1010 18:37:33.516797 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHUsername
I1010 18:37:33.516936 428417 main.go:141] libmachine: Using SSH client type: native
I1010 18:37:33.517141 428417 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x8651c0] 0x867ea0 <nil> [] 0s} 192.168.61.214 22 <nil> <nil>}
I1010 18:37:33.517161 428417 main.go:141] libmachine: About to run SSH command:
exit 0
I1010 18:37:33.625655 428417 main.go:141] libmachine: SSH cmd err, output: <nil>:
I1010 18:37:33.625682 428417 main.go:141] libmachine: Detecting the provisioner...
I1010 18:37:33.625689 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHHostname
I1010 18:37:33.628438 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:33.628743 428417 main.go:141] libmachine: (kindnet-128972) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:f4:2b:d1", ip: ""} in network mk-kindnet-128972: {Iface:virbr1 ExpiryTime:2024-10-10 19:37:24 +0000 UTC Type:0 Mac:52:54:00:f4:2b:d1 Iaid: IPaddr:192.168.61.214 Prefix:24 Hostname:kindnet-128972 Clientid:01:52:54:00:f4:2b:d1}
I1010 18:37:33.628773 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined IP address 192.168.61.214 and MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:33.628899 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHPort
I1010 18:37:33.629106 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHKeyPath
I1010 18:37:33.629228 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHKeyPath
I1010 18:37:33.629391 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHUsername
I1010 18:37:33.629560 428417 main.go:141] libmachine: Using SSH client type: native
I1010 18:37:33.629787 428417 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x8651c0] 0x867ea0 <nil> [] 0s} 192.168.61.214 22 <nil> <nil>}
I1010 18:37:33.629803 428417 main.go:141] libmachine: About to run SSH command:
cat /etc/os-release
I1010 18:37:33.742991 428417 main.go:141] libmachine: SSH cmd err, output: <nil>: NAME=Buildroot
VERSION=2023.02.9-dirty
ID=buildroot
VERSION_ID=2023.02.9
PRETTY_NAME="Buildroot 2023.02.9"
I1010 18:37:33.743100 428417 main.go:141] libmachine: found compatible host: buildroot
I1010 18:37:33.743118 428417 main.go:141] libmachine: Provisioning with buildroot...
I1010 18:37:33.743137 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetMachineName
I1010 18:37:33.743389 428417 buildroot.go:166] provisioning hostname "kindnet-128972"
I1010 18:37:33.743412 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetMachineName
I1010 18:37:33.743811 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHHostname
I1010 18:37:33.746407 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:33.746822 428417 main.go:141] libmachine: (kindnet-128972) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:f4:2b:d1", ip: ""} in network mk-kindnet-128972: {Iface:virbr1 ExpiryTime:2024-10-10 19:37:24 +0000 UTC Type:0 Mac:52:54:00:f4:2b:d1 Iaid: IPaddr:192.168.61.214 Prefix:24 Hostname:kindnet-128972 Clientid:01:52:54:00:f4:2b:d1}
I1010 18:37:33.746846 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined IP address 192.168.61.214 and MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:33.747032 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHPort
I1010 18:37:33.747208 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHKeyPath
I1010 18:37:33.747326 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHKeyPath
I1010 18:37:33.747422 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHUsername
I1010 18:37:33.747616 428417 main.go:141] libmachine: Using SSH client type: native
I1010 18:37:33.747820 428417 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x8651c0] 0x867ea0 <nil> [] 0s} 192.168.61.214 22 <nil> <nil>}
I1010 18:37:33.747833 428417 main.go:141] libmachine: About to run SSH command:
sudo hostname kindnet-128972 && echo "kindnet-128972" | sudo tee /etc/hostname
I1010 18:37:33.870883 428417 main.go:141] libmachine: SSH cmd err, output: <nil>: kindnet-128972
I1010 18:37:33.870910 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHHostname
I1010 18:37:33.873617 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:33.873938 428417 main.go:141] libmachine: (kindnet-128972) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:f4:2b:d1", ip: ""} in network mk-kindnet-128972: {Iface:virbr1 ExpiryTime:2024-10-10 19:37:24 +0000 UTC Type:0 Mac:52:54:00:f4:2b:d1 Iaid: IPaddr:192.168.61.214 Prefix:24 Hostname:kindnet-128972 Clientid:01:52:54:00:f4:2b:d1}
I1010 18:37:33.873964 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined IP address 192.168.61.214 and MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:33.874130 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHPort
I1010 18:37:33.874335 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHKeyPath
I1010 18:37:33.874495 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHKeyPath
I1010 18:37:33.874629 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHUsername
I1010 18:37:33.874813 428417 main.go:141] libmachine: Using SSH client type: native
I1010 18:37:33.874990 428417 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x8651c0] 0x867ea0 <nil> [] 0s} 192.168.61.214 22 <nil> <nil>}
I1010 18:37:33.875006 428417 main.go:141] libmachine: About to run SSH command:
if ! grep -xq '.*\skindnet-128972' /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 kindnet-128972/g' /etc/hosts;
else
echo '127.0.1.1 kindnet-128972' | sudo tee -a /etc/hosts;
fi
fi
I1010 18:37:33.994991 428417 main.go:141] libmachine: SSH cmd err, output: <nil>:
I1010 18:37:33.995027 428417 buildroot.go:172] set auth options {CertDir:/home/jenkins/minikube-integration/19787-382081/.minikube CaCertPath:/home/jenkins/minikube-integration/19787-382081/.minikube/certs/ca.pem CaPrivateKeyPath:/home/jenkins/minikube-integration/19787-382081/.minikube/certs/ca-key.pem CaCertRemotePath:/etc/docker/ca.pem ServerCertPath:/home/jenkins/minikube-integration/19787-382081/.minikube/machines/server.pem ServerKeyPath:/home/jenkins/minikube-integration/19787-382081/.minikube/machines/server-key.pem ClientKeyPath:/home/jenkins/minikube-integration/19787-382081/.minikube/certs/key.pem ServerCertRemotePath:/etc/docker/server.pem ServerKeyRemotePath:/etc/docker/server-key.pem ClientCertPath:/home/jenkins/minikube-integration/19787-382081/.minikube/certs/cert.pem ServerCertSANs:[] StorePath:/home/jenkins/minikube-integration/19787-382081/.minikube}
I1010 18:37:33.995086 428417 buildroot.go:174] setting up certificates
I1010 18:37:33.995102 428417 provision.go:84] configureAuth start
I1010 18:37:33.995122 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetMachineName
I1010 18:37:33.995402 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetIP
I1010 18:37:33.998313 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:33.998628 428417 main.go:141] libmachine: (kindnet-128972) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:f4:2b:d1", ip: ""} in network mk-kindnet-128972: {Iface:virbr1 ExpiryTime:2024-10-10 19:37:24 +0000 UTC Type:0 Mac:52:54:00:f4:2b:d1 Iaid: IPaddr:192.168.61.214 Prefix:24 Hostname:kindnet-128972 Clientid:01:52:54:00:f4:2b:d1}
I1010 18:37:33.998659 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined IP address 192.168.61.214 and MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:33.998864 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHHostname
I1010 18:37:34.001237 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:34.001615 428417 main.go:141] libmachine: (kindnet-128972) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:f4:2b:d1", ip: ""} in network mk-kindnet-128972: {Iface:virbr1 ExpiryTime:2024-10-10 19:37:24 +0000 UTC Type:0 Mac:52:54:00:f4:2b:d1 Iaid: IPaddr:192.168.61.214 Prefix:24 Hostname:kindnet-128972 Clientid:01:52:54:00:f4:2b:d1}
I1010 18:37:34.001668 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined IP address 192.168.61.214 and MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:34.001800 428417 provision.go:143] copyHostCerts
I1010 18:37:34.001866 428417 exec_runner.go:144] found /home/jenkins/minikube-integration/19787-382081/.minikube/ca.pem, removing ...
I1010 18:37:34.001877 428417 exec_runner.go:203] rm: /home/jenkins/minikube-integration/19787-382081/.minikube/ca.pem
I1010 18:37:34.001930 428417 exec_runner.go:151] cp: /home/jenkins/minikube-integration/19787-382081/.minikube/certs/ca.pem --> /home/jenkins/minikube-integration/19787-382081/.minikube/ca.pem (1078 bytes)
I1010 18:37:34.002029 428417 exec_runner.go:144] found /home/jenkins/minikube-integration/19787-382081/.minikube/cert.pem, removing ...
I1010 18:37:34.002037 428417 exec_runner.go:203] rm: /home/jenkins/minikube-integration/19787-382081/.minikube/cert.pem
I1010 18:37:34.002057 428417 exec_runner.go:151] cp: /home/jenkins/minikube-integration/19787-382081/.minikube/certs/cert.pem --> /home/jenkins/minikube-integration/19787-382081/.minikube/cert.pem (1123 bytes)
I1010 18:37:34.002120 428417 exec_runner.go:144] found /home/jenkins/minikube-integration/19787-382081/.minikube/key.pem, removing ...
I1010 18:37:34.002127 428417 exec_runner.go:203] rm: /home/jenkins/minikube-integration/19787-382081/.minikube/key.pem
I1010 18:37:34.002146 428417 exec_runner.go:151] cp: /home/jenkins/minikube-integration/19787-382081/.minikube/certs/key.pem --> /home/jenkins/minikube-integration/19787-382081/.minikube/key.pem (1679 bytes)
I1010 18:37:34.002212 428417 provision.go:117] generating server cert: /home/jenkins/minikube-integration/19787-382081/.minikube/machines/server.pem ca-key=/home/jenkins/minikube-integration/19787-382081/.minikube/certs/ca.pem private-key=/home/jenkins/minikube-integration/19787-382081/.minikube/certs/ca-key.pem org=jenkins.kindnet-128972 san=[127.0.0.1 192.168.61.214 kindnet-128972 localhost minikube]
I1010 18:37:34.179662 428417 provision.go:177] copyRemoteCerts
I1010 18:37:34.179716 428417 ssh_runner.go:195] Run: sudo mkdir -p /etc/docker /etc/docker /etc/docker
I1010 18:37:34.179742 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHHostname
I1010 18:37:34.182221 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:34.182554 428417 main.go:141] libmachine: (kindnet-128972) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:f4:2b:d1", ip: ""} in network mk-kindnet-128972: {Iface:virbr1 ExpiryTime:2024-10-10 19:37:24 +0000 UTC Type:0 Mac:52:54:00:f4:2b:d1 Iaid: IPaddr:192.168.61.214 Prefix:24 Hostname:kindnet-128972 Clientid:01:52:54:00:f4:2b:d1}
I1010 18:37:34.182589 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined IP address 192.168.61.214 and MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:34.182785 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHPort
I1010 18:37:34.182966 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHKeyPath
I1010 18:37:34.183129 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHUsername
I1010 18:37:34.183226 428417 sshutil.go:53] new ssh client: &{IP:192.168.61.214 Port:22 SSHKeyPath:/home/jenkins/minikube-integration/19787-382081/.minikube/machines/kindnet-128972/id_rsa Username:docker}
I1010 18:37:34.268018 428417 ssh_runner.go:362] scp /home/jenkins/minikube-integration/19787-382081/.minikube/certs/ca.pem --> /etc/docker/ca.pem (1078 bytes)
I1010 18:37:34.289746 428417 ssh_runner.go:362] scp /home/jenkins/minikube-integration/19787-382081/.minikube/machines/server.pem --> /etc/docker/server.pem (1212 bytes)
I1010 18:37:34.310791 428417 ssh_runner.go:362] scp /home/jenkins/minikube-integration/19787-382081/.minikube/machines/server-key.pem --> /etc/docker/server-key.pem (1675 bytes)
I1010 18:37:34.331955 428417 provision.go:87] duration metric: took 336.834069ms to configureAuth
I1010 18:37:34.331988 428417 buildroot.go:189] setting minikube options for container-runtime
I1010 18:37:34.332186 428417 config.go:182] Loaded profile config "kindnet-128972": Driver=kvm2, ContainerRuntime=docker, KubernetesVersion=v1.31.1
I1010 18:37:34.332216 428417 main.go:141] libmachine: (kindnet-128972) Calling .DriverName
I1010 18:37:34.332515 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHHostname
I1010 18:37:34.335381 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:34.335761 428417 main.go:141] libmachine: (kindnet-128972) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:f4:2b:d1", ip: ""} in network mk-kindnet-128972: {Iface:virbr1 ExpiryTime:2024-10-10 19:37:24 +0000 UTC Type:0 Mac:52:54:00:f4:2b:d1 Iaid: IPaddr:192.168.61.214 Prefix:24 Hostname:kindnet-128972 Clientid:01:52:54:00:f4:2b:d1}
I1010 18:37:34.335794 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined IP address 192.168.61.214 and MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:34.335955 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHPort
I1010 18:37:34.336139 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHKeyPath
I1010 18:37:34.336277 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHKeyPath
I1010 18:37:34.336433 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHUsername
I1010 18:37:34.336582 428417 main.go:141] libmachine: Using SSH client type: native
I1010 18:37:34.336777 428417 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x8651c0] 0x867ea0 <nil> [] 0s} 192.168.61.214 22 <nil> <nil>}
I1010 18:37:34.336791 428417 main.go:141] libmachine: About to run SSH command:
df --output=fstype / | tail -n 1
I1010 18:37:34.447514 428417 main.go:141] libmachine: SSH cmd err, output: <nil>: tmpfs
I1010 18:37:34.447540 428417 buildroot.go:70] root file system type: tmpfs
I1010 18:37:34.447652 428417 provision.go:314] Updating docker unit: /lib/systemd/system/docker.service ...
I1010 18:37:34.447673 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHHostname
I1010 18:37:34.450247 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:34.450586 428417 main.go:141] libmachine: (kindnet-128972) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:f4:2b:d1", ip: ""} in network mk-kindnet-128972: {Iface:virbr1 ExpiryTime:2024-10-10 19:37:24 +0000 UTC Type:0 Mac:52:54:00:f4:2b:d1 Iaid: IPaddr:192.168.61.214 Prefix:24 Hostname:kindnet-128972 Clientid:01:52:54:00:f4:2b:d1}
I1010 18:37:34.450619 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined IP address 192.168.61.214 and MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:34.450794 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHPort
I1010 18:37:34.450985 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHKeyPath
I1010 18:37:34.451139 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHKeyPath
I1010 18:37:34.451290 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHUsername
I1010 18:37:34.451469 428417 main.go:141] libmachine: Using SSH client type: native
I1010 18:37:34.451648 428417 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x8651c0] 0x867ea0 <nil> [] 0s} 192.168.61.214 22 <nil> <nil>}
I1010 18:37:34.451753 428417 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
I1010 18:37:34.575688 428417 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
I1010 18:37:34.575733 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHHostname
I1010 18:37:34.578408 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:34.578717 428417 main.go:141] libmachine: (kindnet-128972) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:f4:2b:d1", ip: ""} in network mk-kindnet-128972: {Iface:virbr1 ExpiryTime:2024-10-10 19:37:24 +0000 UTC Type:0 Mac:52:54:00:f4:2b:d1 Iaid: IPaddr:192.168.61.214 Prefix:24 Hostname:kindnet-128972 Clientid:01:52:54:00:f4:2b:d1}
I1010 18:37:34.578763 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined IP address 192.168.61.214 and MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:34.578957 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHPort
I1010 18:37:34.579129 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHKeyPath
I1010 18:37:34.579252 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHKeyPath
I1010 18:37:34.579375 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHUsername
I1010 18:37:34.579502 428417 main.go:141] libmachine: Using SSH client type: native
I1010 18:37:34.579702 428417 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x8651c0] 0x867ea0 <nil> [] 0s} 192.168.61.214 22 <nil> <nil>}
I1010 18:37:34.579725 428417 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; }
I1010 18:37:36.288761 428417 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.
I1010 18:37:36.288800 428417 main.go:141] libmachine: Checking connection to Docker...
I1010 18:37:36.288815 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetURL
I1010 18:37:36.290219 428417 main.go:141] libmachine: (kindnet-128972) DBG | Using libvirt version 6000000
I1010 18:37:36.292433 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:36.292813 428417 main.go:141] libmachine: (kindnet-128972) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:f4:2b:d1", ip: ""} in network mk-kindnet-128972: {Iface:virbr1 ExpiryTime:2024-10-10 19:37:24 +0000 UTC Type:0 Mac:52:54:00:f4:2b:d1 Iaid: IPaddr:192.168.61.214 Prefix:24 Hostname:kindnet-128972 Clientid:01:52:54:00:f4:2b:d1}
I1010 18:37:36.292847 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined IP address 192.168.61.214 and MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:36.292978 428417 main.go:141] libmachine: Docker is up and running!
I1010 18:37:36.292994 428417 main.go:141] libmachine: Reticulating splines...
I1010 18:37:36.293002 428417 client.go:171] duration metric: took 25.935812691s to LocalClient.Create
I1010 18:37:36.293031 428417 start.go:167] duration metric: took 25.93588663s to libmachine.API.Create "kindnet-128972"
I1010 18:37:36.293041 428417 start.go:293] postStartSetup for "kindnet-128972" (driver="kvm2")
I1010 18:37:36.293049 428417 start.go:322] 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]
I1010 18:37:36.293065 428417 main.go:141] libmachine: (kindnet-128972) Calling .DriverName
I1010 18:37:36.293284 428417 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
I1010 18:37:36.293313 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHHostname
I1010 18:37:36.295388 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:36.295671 428417 main.go:141] libmachine: (kindnet-128972) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:f4:2b:d1", ip: ""} in network mk-kindnet-128972: {Iface:virbr1 ExpiryTime:2024-10-10 19:37:24 +0000 UTC Type:0 Mac:52:54:00:f4:2b:d1 Iaid: IPaddr:192.168.61.214 Prefix:24 Hostname:kindnet-128972 Clientid:01:52:54:00:f4:2b:d1}
I1010 18:37:36.295696 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined IP address 192.168.61.214 and MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:36.295850 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHPort
I1010 18:37:36.296003 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHKeyPath
I1010 18:37:36.296183 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHUsername
I1010 18:37:36.296309 428417 sshutil.go:53] new ssh client: &{IP:192.168.61.214 Port:22 SSHKeyPath:/home/jenkins/minikube-integration/19787-382081/.minikube/machines/kindnet-128972/id_rsa Username:docker}
I1010 18:37:36.380297 428417 ssh_runner.go:195] Run: cat /etc/os-release
I1010 18:37:36.384021 428417 info.go:137] Remote host: Buildroot 2023.02.9
I1010 18:37:36.384044 428417 filesync.go:126] Scanning /home/jenkins/minikube-integration/19787-382081/.minikube/addons for local assets ...
I1010 18:37:36.384106 428417 filesync.go:126] Scanning /home/jenkins/minikube-integration/19787-382081/.minikube/files for local assets ...
I1010 18:37:36.384233 428417 filesync.go:149] local asset: /home/jenkins/minikube-integration/19787-382081/.minikube/files/etc/ssl/certs/3893402.pem -> 3893402.pem in /etc/ssl/certs
I1010 18:37:36.384364 428417 ssh_runner.go:195] Run: sudo mkdir -p /etc/ssl/certs
I1010 18:37:36.392826 428417 ssh_runner.go:362] scp /home/jenkins/minikube-integration/19787-382081/.minikube/files/etc/ssl/certs/3893402.pem --> /etc/ssl/certs/3893402.pem (1708 bytes)
I1010 18:37:36.414061 428417 start.go:296] duration metric: took 121.008605ms for postStartSetup
I1010 18:37:36.414112 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetConfigRaw
I1010 18:37:36.414756 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetIP
I1010 18:37:36.417955 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:36.418409 428417 main.go:141] libmachine: (kindnet-128972) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:f4:2b:d1", ip: ""} in network mk-kindnet-128972: {Iface:virbr1 ExpiryTime:2024-10-10 19:37:24 +0000 UTC Type:0 Mac:52:54:00:f4:2b:d1 Iaid: IPaddr:192.168.61.214 Prefix:24 Hostname:kindnet-128972 Clientid:01:52:54:00:f4:2b:d1}
I1010 18:37:36.418436 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined IP address 192.168.61.214 and MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:36.418616 428417 profile.go:143] Saving config to /home/jenkins/minikube-integration/19787-382081/.minikube/profiles/kindnet-128972/config.json ...
I1010 18:37:36.418815 428417 start.go:128] duration metric: took 26.083290541s to createHost
I1010 18:37:36.418841 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHHostname
I1010 18:37:36.421126 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:36.421422 428417 main.go:141] libmachine: (kindnet-128972) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:f4:2b:d1", ip: ""} in network mk-kindnet-128972: {Iface:virbr1 ExpiryTime:2024-10-10 19:37:24 +0000 UTC Type:0 Mac:52:54:00:f4:2b:d1 Iaid: IPaddr:192.168.61.214 Prefix:24 Hostname:kindnet-128972 Clientid:01:52:54:00:f4:2b:d1}
I1010 18:37:36.421445 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined IP address 192.168.61.214 and MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:36.421564 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHPort
I1010 18:37:36.421766 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHKeyPath
I1010 18:37:36.421920 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHKeyPath
I1010 18:37:36.422069 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHUsername
I1010 18:37:36.422221 428417 main.go:141] libmachine: Using SSH client type: native
I1010 18:37:36.422382 428417 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x8651c0] 0x867ea0 <nil> [] 0s} 192.168.61.214 22 <nil> <nil>}
I1010 18:37:36.422391 428417 main.go:141] libmachine: About to run SSH command:
date +%s.%N
I1010 18:37:36.530959 428417 main.go:141] libmachine: SSH cmd err, output: <nil>: 1728585456.511597285
I1010 18:37:36.530986 428417 fix.go:216] guest clock: 1728585456.511597285
I1010 18:37:36.530996 428417 fix.go:229] Guest: 2024-10-10 18:37:36.511597285 +0000 UTC Remote: 2024-10-10 18:37:36.418828953 +0000 UTC m=+44.076678015 (delta=92.768332ms)
I1010 18:37:36.531021 428417 fix.go:200] guest clock delta is within tolerance: 92.768332ms
I1010 18:37:36.531028 428417 start.go:83] releasing machines lock for "kindnet-128972", held for 26.195654155s
I1010 18:37:36.531059 428417 main.go:141] libmachine: (kindnet-128972) Calling .DriverName
I1010 18:37:36.531345 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetIP
I1010 18:37:36.534427 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:36.534900 428417 main.go:141] libmachine: (kindnet-128972) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:f4:2b:d1", ip: ""} in network mk-kindnet-128972: {Iface:virbr1 ExpiryTime:2024-10-10 19:37:24 +0000 UTC Type:0 Mac:52:54:00:f4:2b:d1 Iaid: IPaddr:192.168.61.214 Prefix:24 Hostname:kindnet-128972 Clientid:01:52:54:00:f4:2b:d1}
I1010 18:37:36.534928 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined IP address 192.168.61.214 and MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:36.535108 428417 main.go:141] libmachine: (kindnet-128972) Calling .DriverName
I1010 18:37:36.535507 428417 main.go:141] libmachine: (kindnet-128972) Calling .DriverName
I1010 18:37:36.535726 428417 main.go:141] libmachine: (kindnet-128972) Calling .DriverName
I1010 18:37:36.535834 428417 ssh_runner.go:195] Run: curl -sS -m 2 https://registry.k8s.io/
I1010 18:37:36.535879 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHHostname
I1010 18:37:36.535986 428417 ssh_runner.go:195] Run: cat /version.json
I1010 18:37:36.536028 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHHostname
I1010 18:37:36.538563 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:36.538771 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:36.538911 428417 main.go:141] libmachine: (kindnet-128972) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:f4:2b:d1", ip: ""} in network mk-kindnet-128972: {Iface:virbr1 ExpiryTime:2024-10-10 19:37:24 +0000 UTC Type:0 Mac:52:54:00:f4:2b:d1 Iaid: IPaddr:192.168.61.214 Prefix:24 Hostname:kindnet-128972 Clientid:01:52:54:00:f4:2b:d1}
I1010 18:37:36.538943 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined IP address 192.168.61.214 and MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:36.539106 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHPort
I1010 18:37:36.539178 428417 main.go:141] libmachine: (kindnet-128972) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:f4:2b:d1", ip: ""} in network mk-kindnet-128972: {Iface:virbr1 ExpiryTime:2024-10-10 19:37:24 +0000 UTC Type:0 Mac:52:54:00:f4:2b:d1 Iaid: IPaddr:192.168.61.214 Prefix:24 Hostname:kindnet-128972 Clientid:01:52:54:00:f4:2b:d1}
I1010 18:37:36.539199 428417 main.go:141] libmachine: (kindnet-128972) DBG | domain kindnet-128972 has defined IP address 192.168.61.214 and MAC address 52:54:00:f4:2b:d1 in network mk-kindnet-128972
I1010 18:37:36.539291 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHKeyPath
I1010 18:37:36.539377 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHPort
I1010 18:37:36.539466 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHUsername
I1010 18:37:36.539540 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHKeyPath
I1010 18:37:36.539586 428417 sshutil.go:53] new ssh client: &{IP:192.168.61.214 Port:22 SSHKeyPath:/home/jenkins/minikube-integration/19787-382081/.minikube/machines/kindnet-128972/id_rsa Username:docker}
I1010 18:37:36.539656 428417 main.go:141] libmachine: (kindnet-128972) Calling .GetSSHUsername
I1010 18:37:36.539795 428417 sshutil.go:53] new ssh client: &{IP:192.168.61.214 Port:22 SSHKeyPath:/home/jenkins/minikube-integration/19787-382081/.minikube/machines/kindnet-128972/id_rsa Username:docker}
I1010 18:37:36.619330 428417 ssh_runner.go:195] Run: systemctl --version
I1010 18:37:36.661884 428417 ssh_runner.go:195] Run: sh -c "stat /etc/cni/net.d/*loopback.conf*"
W1010 18:37:36.667359 428417 cni.go:209] loopback cni configuration skipped: "/etc/cni/net.d/*loopback.conf*" not found
I1010 18:37:36.667427 428417 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" ;
I1010 18:37:36.682222 428417 cni.go:262] disabled [/etc/cni/net.d/87-podman-bridge.conflist] bridge cni config(s)
I1010 18:37:36.682252 428417 start.go:495] detecting cgroup driver to use...
I1010 18:37:36.682412 428417 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"
I1010 18:37:36.699322 428417 ssh_runner.go:195] Run: sh -c "sudo sed -i -r 's|^( *)sandbox_image = .*$|\1sandbox_image = "registry.k8s.io/pause:3.10"|' /etc/containerd/config.toml"
I1010 18:37:36.708910 428417 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"
I1010 18:37:36.718269 428417 containerd.go:146] configuring containerd to use "cgroupfs" as cgroup driver...
I1010 18:37:36.718330 428417 ssh_runner.go:195] Run: sh -c "sudo sed -i -r 's|^( *)SystemdCgroup = .*$|\1SystemdCgroup = false|g' /etc/containerd/config.toml"
I1010 18:37:36.727573 428417 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"
I1010 18:37:36.737783 428417 ssh_runner.go:195] Run: sh -c "sudo sed -i '/systemd_cgroup/d' /etc/containerd/config.toml"
I1010 18:37:36.747830 428417 ssh_runner.go:195] Run: sh -c "sudo sed -i 's|"io.containerd.runc.v1"|"io.containerd.runc.v2"|g' /etc/containerd/config.toml"
I1010 18:37:36.757623 428417 ssh_runner.go:195] Run: sh -c "sudo rm -rf /etc/cni/net.mk"
I1010 18:37:36.767849 428417 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"
I1010 18:37:36.777916 428417 ssh_runner.go:195] Run: sh -c "sudo sed -i '/^ *enable_unprivileged_ports = .*/d' /etc/containerd/config.toml"
I1010 18:37:36.787529 428417 ssh_runner.go:195] Run: sh -c "sudo sed -i -r 's|^( *)\[plugins."io.containerd.grpc.v1.cri"\]|&\n\1 enable_unprivileged_ports = true|' /etc/containerd/config.toml"
I1010 18:37:36.797205 428417 ssh_runner.go:195] Run: sudo sysctl net.bridge.bridge-nf-call-iptables
I1010 18:37:36.805655 428417 crio.go:166] couldn't verify netfilter by "sudo sysctl net.bridge.bridge-nf-call-iptables" which might be okay. error: sudo sysctl net.bridge.bridge-nf-call-iptables: Process exited with status 255
stdout:
stderr:
sysctl: cannot stat /proc/sys/net/bridge/bridge-nf-call-iptables: No such file or directory
I1010 18:37:36.805710 428417 ssh_runner.go:195] Run: sudo modprobe br_netfilter
I1010 18:37:36.814757 428417 ssh_runner.go:195] Run: sudo sh -c "echo 1 > /proc/sys/net/ipv4/ip_forward"
I1010 18:37:36.823190 428417 ssh_runner.go:195] Run: sudo systemctl daemon-reload
I1010 18:37:36.928425 428417 ssh_runner.go:195] Run: sudo systemctl restart containerd
I1010 18:37:36.952585 428417 start.go:495] detecting cgroup driver to use...
I1010 18:37:36.952679 428417 ssh_runner.go:195] Run: sudo systemctl cat docker.service
I1010 18:37:36.977991 428417 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service containerd
I1010 18:37:36.993619 428417 ssh_runner.go:195] Run: sudo systemctl stop -f containerd
I1010 18:37:37.020053 428417 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service containerd
I1010 18:37:37.034125 428417 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service crio
I1010 18:37:37.047365 428417 ssh_runner.go:195] Run: sudo systemctl stop -f crio
I1010 18:37:37.076519 428417 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service crio
I1010 18:37:37.089783 428417 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"
I1010 18:37:37.106549 428417 ssh_runner.go:195] Run: which cri-dockerd
I1010 18:37:37.110099 428417 ssh_runner.go:195] Run: sudo mkdir -p /etc/systemd/system/cri-docker.service.d
I1010 18:37:37.118391 428417 ssh_runner.go:362] scp memory --> /etc/systemd/system/cri-docker.service.d/10-cni.conf (190 bytes)
I1010 18:37:37.133073 428417 ssh_runner.go:195] Run: sudo systemctl unmask docker.service
I1010 18:37:37.246908 428417 ssh_runner.go:195] Run: sudo systemctl enable docker.socket
I1010 18:37:37.375044 428417 docker.go:574] configuring docker to use "cgroupfs" as cgroup driver...
I1010 18:37:37.375184 428417 ssh_runner.go:362] scp memory --> /etc/docker/daemon.json (130 bytes)
I1010 18:37:37.390421 428417 ssh_runner.go:195] Run: sudo systemctl daemon-reload
I1010 18:37:37.511029 428417 ssh_runner.go:195] Run: sudo systemctl restart docker
I1010 18:38:38.575462 428417 ssh_runner.go:235] Completed: sudo systemctl restart docker: (1m1.064394022s)
I1010 18:38:38.575551 428417 ssh_runner.go:195] Run: sudo journalctl --no-pager -u docker
I1010 18:38:38.596291 428417 out.go:201]
W1010 18:38:38.597446 428417 out.go:270] X Exiting due to RUNTIME_ENABLE: Failed to enable container runtime: sudo systemctl restart docker: Process exited with status 1
stdout:
stderr:
Job for docker.service failed because the control process exited with error code.
See "systemctl status docker.service" and "journalctl -xeu docker.service" for details.
sudo journalctl --no-pager -u docker:
-- stdout --
Oct 10 18:37:34 kindnet-128972 systemd[1]: Starting Docker Application Container Engine...
Oct 10 18:37:34 kindnet-128972 dockerd[527]: time="2024-10-10T18:37:34.935053299Z" level=info msg="Starting up"
Oct 10 18:37:34 kindnet-128972 dockerd[527]: time="2024-10-10T18:37:34.936032965Z" level=info msg="containerd not running, starting managed containerd"
Oct 10 18:37:34 kindnet-128972 dockerd[527]: time="2024-10-10T18:37:34.936748398Z" level=info msg="started new containerd process" address=/var/run/docker/containerd/containerd.sock module=libcontainerd pid=533
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.963670770Z" level=info msg="starting containerd" revision=7f7fdf5fed64eb6a7caf99b3e12efcf9d60e311c version=v1.7.22
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.982485856Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.982621353Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.982711698Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.982751023Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.982887317Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.982937338Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.983522841Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /var/lib/docker/containerd/daemon/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.983607733Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.983650461Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.983688644Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.983803303Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.984076087Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.986314466Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/5.10.207\\n\"): skip plugin" type=io.containerd.snapshotter.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.986394295Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.986588272Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/docker/containerd/daemon/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.986644910Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.986760292Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.986832860Z" level=info msg="metadata content store policy set" policy=shared
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.997686595Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.997852012Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.997902460Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.997943830Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998023598Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998148002Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998510458Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998665870Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998697734Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998717435Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998732124Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998743922Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998755353Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998770241Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998783939Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998798144Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998810774Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998820544Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998847136Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998877647Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998893347Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998905008Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998917638Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998928761Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998939013Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998949780Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.999015011Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.999031791Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.999042178Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.999052585Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.999062842Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.999075976Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.999104398Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.999133093Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.999146843Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.999212964Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.999244298Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.999258461Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.999274703Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.999283995Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.999298456Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.999314967Z" level=info msg="NRI interface is disabled by configuration."
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.999909744Z" level=info msg=serving... address=/var/run/docker/containerd/containerd-debug.sock
Oct 10 18:37:35 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:35.000005130Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock.ttrpc
Oct 10 18:37:35 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:35.000048148Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock
Oct 10 18:37:35 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:35.000326316Z" level=info msg="containerd successfully booted in 0.037465s"
Oct 10 18:37:35 kindnet-128972 dockerd[527]: time="2024-10-10T18:37:35.982331918Z" level=info msg="[graphdriver] trying configured driver: overlay2"
Oct 10 18:37:36 kindnet-128972 dockerd[527]: time="2024-10-10T18:37:36.000600560Z" level=info msg="Loading containers: start."
Oct 10 18:37:36 kindnet-128972 dockerd[527]: time="2024-10-10T18:37:36.085786811Z" level=warning msg="ip6tables is enabled, but cannot set up ip6tables chains" error="failed to create NAT chain DOCKER: iptables failed: ip6tables --wait -t nat -N DOCKER: ip6tables v1.8.9 (legacy): can't initialize ip6tables table `nat': Table does not exist (do you need to insmod?)\nPerhaps ip6tables or your kernel needs to be upgraded.\n (exit status 3)"
Oct 10 18:37:36 kindnet-128972 dockerd[527]: time="2024-10-10T18:37:36.201442368Z" level=info msg="Loading containers: done."
Oct 10 18:37:36 kindnet-128972 dockerd[527]: time="2024-10-10T18:37:36.216302312Z" level=warning msg="WARNING: bridge-nf-call-iptables is disabled"
Oct 10 18:37:36 kindnet-128972 dockerd[527]: time="2024-10-10T18:37:36.216334504Z" level=warning msg="WARNING: bridge-nf-call-ip6tables is disabled"
Oct 10 18:37:36 kindnet-128972 dockerd[527]: time="2024-10-10T18:37:36.216354911Z" level=info msg="Docker daemon" commit=41ca978 containerd-snapshotter=false storage-driver=overlay2 version=27.3.1
Oct 10 18:37:36 kindnet-128972 dockerd[527]: time="2024-10-10T18:37:36.216457205Z" level=info msg="Daemon has completed initialization"
Oct 10 18:37:36 kindnet-128972 dockerd[527]: time="2024-10-10T18:37:36.267853547Z" level=info msg="API listen on /var/run/docker.sock"
Oct 10 18:37:36 kindnet-128972 systemd[1]: Started Docker Application Container Engine.
Oct 10 18:37:36 kindnet-128972 dockerd[527]: time="2024-10-10T18:37:36.268014291Z" level=info msg="API listen on [::]:2376"
Oct 10 18:37:37 kindnet-128972 dockerd[527]: time="2024-10-10T18:37:37.506124600Z" level=info msg="Processing signal 'terminated'"
Oct 10 18:37:37 kindnet-128972 dockerd[527]: time="2024-10-10T18:37:37.507515129Z" level=info msg="stopping event stream following graceful shutdown" error="<nil>" module=libcontainerd namespace=moby
Oct 10 18:37:37 kindnet-128972 systemd[1]: Stopping Docker Application Container Engine...
Oct 10 18:37:37 kindnet-128972 dockerd[527]: time="2024-10-10T18:37:37.508987512Z" level=info msg="Daemon shutdown complete"
Oct 10 18:37:37 kindnet-128972 dockerd[527]: time="2024-10-10T18:37:37.509078642Z" level=info msg="stopping healthcheck following graceful shutdown" module=libcontainerd
Oct 10 18:37:37 kindnet-128972 dockerd[527]: time="2024-10-10T18:37:37.509264658Z" level=info msg="stopping event stream following graceful shutdown" error="context canceled" module=libcontainerd namespace=plugins.moby
Oct 10 18:37:38 kindnet-128972 systemd[1]: docker.service: Deactivated successfully.
Oct 10 18:37:38 kindnet-128972 systemd[1]: Stopped Docker Application Container Engine.
Oct 10 18:37:38 kindnet-128972 systemd[1]: Starting Docker Application Container Engine...
Oct 10 18:37:38 kindnet-128972 dockerd[844]: time="2024-10-10T18:37:38.545579984Z" level=info msg="Starting up"
Oct 10 18:38:38 kindnet-128972 dockerd[844]: failed to start daemon: failed to dial "/run/containerd/containerd.sock": failed to dial "/run/containerd/containerd.sock": context deadline exceeded
Oct 10 18:38:38 kindnet-128972 systemd[1]: docker.service: Main process exited, code=exited, status=1/FAILURE
Oct 10 18:38:38 kindnet-128972 systemd[1]: docker.service: Failed with result 'exit-code'.
Oct 10 18:38:38 kindnet-128972 systemd[1]: Failed to start Docker Application Container Engine.
-- /stdout --
X Exiting due to RUNTIME_ENABLE: Failed to enable container runtime: sudo systemctl restart docker: Process exited with status 1
stdout:
stderr:
Job for docker.service failed because the control process exited with error code.
See "systemctl status docker.service" and "journalctl -xeu docker.service" for details.
sudo journalctl --no-pager -u docker:
-- stdout --
Oct 10 18:37:34 kindnet-128972 systemd[1]: Starting Docker Application Container Engine...
Oct 10 18:37:34 kindnet-128972 dockerd[527]: time="2024-10-10T18:37:34.935053299Z" level=info msg="Starting up"
Oct 10 18:37:34 kindnet-128972 dockerd[527]: time="2024-10-10T18:37:34.936032965Z" level=info msg="containerd not running, starting managed containerd"
Oct 10 18:37:34 kindnet-128972 dockerd[527]: time="2024-10-10T18:37:34.936748398Z" level=info msg="started new containerd process" address=/var/run/docker/containerd/containerd.sock module=libcontainerd pid=533
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.963670770Z" level=info msg="starting containerd" revision=7f7fdf5fed64eb6a7caf99b3e12efcf9d60e311c version=v1.7.22
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.982485856Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.982621353Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.982711698Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.982751023Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.982887317Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.982937338Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.983522841Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /var/lib/docker/containerd/daemon/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.983607733Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.983650461Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.983688644Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.983803303Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.984076087Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.986314466Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/5.10.207\\n\"): skip plugin" type=io.containerd.snapshotter.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.986394295Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.986588272Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/docker/containerd/daemon/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.986644910Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.986760292Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.986832860Z" level=info msg="metadata content store policy set" policy=shared
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.997686595Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.997852012Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.997902460Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.997943830Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998023598Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998148002Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998510458Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998665870Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998697734Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998717435Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998732124Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998743922Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998755353Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998770241Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998783939Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998798144Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998810774Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998820544Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998847136Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998877647Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998893347Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998905008Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998917638Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998928761Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998939013Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.998949780Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.999015011Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.999031791Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.999042178Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.999052585Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.999062842Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.999075976Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.999104398Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.999133093Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.999146843Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.999212964Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.999244298Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.999258461Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.999274703Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.999283995Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.999298456Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.999314967Z" level=info msg="NRI interface is disabled by configuration."
Oct 10 18:37:34 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:34.999909744Z" level=info msg=serving... address=/var/run/docker/containerd/containerd-debug.sock
Oct 10 18:37:35 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:35.000005130Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock.ttrpc
Oct 10 18:37:35 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:35.000048148Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock
Oct 10 18:37:35 kindnet-128972 dockerd[533]: time="2024-10-10T18:37:35.000326316Z" level=info msg="containerd successfully booted in 0.037465s"
Oct 10 18:37:35 kindnet-128972 dockerd[527]: time="2024-10-10T18:37:35.982331918Z" level=info msg="[graphdriver] trying configured driver: overlay2"
Oct 10 18:37:36 kindnet-128972 dockerd[527]: time="2024-10-10T18:37:36.000600560Z" level=info msg="Loading containers: start."
Oct 10 18:37:36 kindnet-128972 dockerd[527]: time="2024-10-10T18:37:36.085786811Z" level=warning msg="ip6tables is enabled, but cannot set up ip6tables chains" error="failed to create NAT chain DOCKER: iptables failed: ip6tables --wait -t nat -N DOCKER: ip6tables v1.8.9 (legacy): can't initialize ip6tables table `nat': Table does not exist (do you need to insmod?)\nPerhaps ip6tables or your kernel needs to be upgraded.\n (exit status 3)"
Oct 10 18:37:36 kindnet-128972 dockerd[527]: time="2024-10-10T18:37:36.201442368Z" level=info msg="Loading containers: done."
Oct 10 18:37:36 kindnet-128972 dockerd[527]: time="2024-10-10T18:37:36.216302312Z" level=warning msg="WARNING: bridge-nf-call-iptables is disabled"
Oct 10 18:37:36 kindnet-128972 dockerd[527]: time="2024-10-10T18:37:36.216334504Z" level=warning msg="WARNING: bridge-nf-call-ip6tables is disabled"
Oct 10 18:37:36 kindnet-128972 dockerd[527]: time="2024-10-10T18:37:36.216354911Z" level=info msg="Docker daemon" commit=41ca978 containerd-snapshotter=false storage-driver=overlay2 version=27.3.1
Oct 10 18:37:36 kindnet-128972 dockerd[527]: time="2024-10-10T18:37:36.216457205Z" level=info msg="Daemon has completed initialization"
Oct 10 18:37:36 kindnet-128972 dockerd[527]: time="2024-10-10T18:37:36.267853547Z" level=info msg="API listen on /var/run/docker.sock"
Oct 10 18:37:36 kindnet-128972 systemd[1]: Started Docker Application Container Engine.
Oct 10 18:37:36 kindnet-128972 dockerd[527]: time="2024-10-10T18:37:36.268014291Z" level=info msg="API listen on [::]:2376"
Oct 10 18:37:37 kindnet-128972 dockerd[527]: time="2024-10-10T18:37:37.506124600Z" level=info msg="Processing signal 'terminated'"
Oct 10 18:37:37 kindnet-128972 dockerd[527]: time="2024-10-10T18:37:37.507515129Z" level=info msg="stopping event stream following graceful shutdown" error="<nil>" module=libcontainerd namespace=moby
Oct 10 18:37:37 kindnet-128972 systemd[1]: Stopping Docker Application Container Engine...
Oct 10 18:37:37 kindnet-128972 dockerd[527]: time="2024-10-10T18:37:37.508987512Z" level=info msg="Daemon shutdown complete"
Oct 10 18:37:37 kindnet-128972 dockerd[527]: time="2024-10-10T18:37:37.509078642Z" level=info msg="stopping healthcheck following graceful shutdown" module=libcontainerd
Oct 10 18:37:37 kindnet-128972 dockerd[527]: time="2024-10-10T18:37:37.509264658Z" level=info msg="stopping event stream following graceful shutdown" error="context canceled" module=libcontainerd namespace=plugins.moby
Oct 10 18:37:38 kindnet-128972 systemd[1]: docker.service: Deactivated successfully.
Oct 10 18:37:38 kindnet-128972 systemd[1]: Stopped Docker Application Container Engine.
Oct 10 18:37:38 kindnet-128972 systemd[1]: Starting Docker Application Container Engine...
Oct 10 18:37:38 kindnet-128972 dockerd[844]: time="2024-10-10T18:37:38.545579984Z" level=info msg="Starting up"
Oct 10 18:38:38 kindnet-128972 dockerd[844]: failed to start daemon: failed to dial "/run/containerd/containerd.sock": failed to dial "/run/containerd/containerd.sock": context deadline exceeded
Oct 10 18:38:38 kindnet-128972 systemd[1]: docker.service: Main process exited, code=exited, status=1/FAILURE
Oct 10 18:38:38 kindnet-128972 systemd[1]: docker.service: Failed with result 'exit-code'.
Oct 10 18:38:38 kindnet-128972 systemd[1]: Failed to start Docker Application Container Engine.
-- /stdout --
W1010 18:38:38.597491 428417 out.go:270] *
*
W1010 18:38:38.598500 428417 out.go:293] ╭─────────────────────────────────────────────────────────────────────────────────────────────╮
│ │
│ * 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. │
│ │
╰─────────────────────────────────────────────────────────────────────────────────────────────╯
I1010 18:38:38.600813 428417 out.go:201]
** /stderr **
net_test.go:114: failed start: exit status 90
--- FAIL: TestNetworkPlugins/group/kindnet/Start (106.29s)