=== RUN TestNetworkPlugins/group/enable-default-cni/Start
net_test.go:112: (dbg) Run: out/minikube-linux-amd64 start -p enable-default-cni-304911 --memory=3072 --alsologtostderr --wait=true --wait-timeout=15m --enable-default-cni=true --driver=kvm2
E0911 11:19:49.368348 13224 cert_rotation.go:168] key failed with : open /home/jenkins/minikube-integration/17225-6025/.minikube/profiles/gvisor-129995/client.crt: no such file or directory
E0911 11:19:55.521436 13224 cert_rotation.go:168] key failed with : open /home/jenkins/minikube-integration/17225-6025/.minikube/profiles/skaffold-478844/client.crt: no such file or directory
net_test.go:112: (dbg) Non-zero exit: out/minikube-linux-amd64 start -p enable-default-cni-304911 --memory=3072 --alsologtostderr --wait=true --wait-timeout=15m --enable-default-cni=true --driver=kvm2 : exit status 90 (47.453561904s)
-- stdout --
* [enable-default-cni-304911] minikube v1.31.2 on Ubuntu 20.04 (kvm/amd64)
- MINIKUBE_LOCATION=17225
- MINIKUBE_SUPPRESS_DOCKER_PERFORMANCE=true
- KUBECONFIG=/home/jenkins/minikube-integration/17225-6025/kubeconfig
- MINIKUBE_HOME=/home/jenkins/minikube-integration/17225-6025/.minikube
- MINIKUBE_BIN=out/minikube-linux-amd64
- MINIKUBE_FORCE_SYSTEMD=
* Using the kvm2 driver based on user configuration
* Starting control plane node enable-default-cni-304911 in cluster enable-default-cni-304911
* Creating kvm2 VM (CPUs=2, Memory=3072MB, Disk=20000MB) ...
-- /stdout --
** stderr **
I0911 11:19:47.936411 45125 out.go:296] Setting OutFile to fd 1 ...
I0911 11:19:47.936552 45125 out.go:343] TERM=,COLORTERM=, which probably does not support color
I0911 11:19:47.936563 45125 out.go:309] Setting ErrFile to fd 2...
I0911 11:19:47.936570 45125 out.go:343] TERM=,COLORTERM=, which probably does not support color
I0911 11:19:47.936901 45125 root.go:338] Updating PATH: /home/jenkins/minikube-integration/17225-6025/.minikube/bin
I0911 11:19:47.937701 45125 out.go:303] Setting JSON to false
I0911 11:19:47.939100 45125 start.go:128] hostinfo: {"hostname":"ubuntu-20-agent-3","uptime":3739,"bootTime":1694427449,"procs":311,"os":"linux","platform":"ubuntu","platformFamily":"debian","platformVersion":"20.04","kernelVersion":"5.15.0-1041-gcp","kernelArch":"x86_64","virtualizationSystem":"kvm","virtualizationRole":"guest","hostId":"591c9f12-2938-3743-e2bf-c56a050d43d1"}
I0911 11:19:47.939176 45125 start.go:138] virtualization: kvm guest
I0911 11:19:47.941657 45125 out.go:177] * [enable-default-cni-304911] minikube v1.31.2 on Ubuntu 20.04 (kvm/amd64)
I0911 11:19:47.943806 45125 out.go:177] - MINIKUBE_LOCATION=17225
I0911 11:19:47.945376 45125 out.go:177] - MINIKUBE_SUPPRESS_DOCKER_PERFORMANCE=true
I0911 11:19:47.943883 45125 notify.go:220] Checking for updates...
I0911 11:19:47.948447 45125 out.go:177] - KUBECONFIG=/home/jenkins/minikube-integration/17225-6025/kubeconfig
I0911 11:19:47.950105 45125 out.go:177] - MINIKUBE_HOME=/home/jenkins/minikube-integration/17225-6025/.minikube
I0911 11:19:47.951700 45125 out.go:177] - MINIKUBE_BIN=out/minikube-linux-amd64
I0911 11:19:47.953314 45125 out.go:177] - MINIKUBE_FORCE_SYSTEMD=
I0911 11:19:47.955432 45125 config.go:182] Loaded profile config "calico-304911": Driver=kvm2, ContainerRuntime=docker, KubernetesVersion=v1.28.1
I0911 11:19:47.955573 45125 config.go:182] Loaded profile config "custom-flannel-304911": Driver=kvm2, ContainerRuntime=docker, KubernetesVersion=v1.28.1
I0911 11:19:47.955709 45125 config.go:182] Loaded profile config "false-304911": Driver=kvm2, ContainerRuntime=docker, KubernetesVersion=v1.28.1
I0911 11:19:47.956191 45125 driver.go:373] Setting default libvirt URI to qemu:///system
I0911 11:19:47.999776 45125 out.go:177] * Using the kvm2 driver based on user configuration
I0911 11:19:48.001378 45125 start.go:298] selected driver: kvm2
I0911 11:19:48.001392 45125 start.go:902] validating driver "kvm2" against <nil>
I0911 11:19:48.001403 45125 start.go:913] status for kvm2: {Installed:true Healthy:true Running:true NeedsImprovement:false Error:<nil> Reason: Fix: Doc: Version:}
I0911 11:19:48.002113 45125 install.go:52] acquiring lock: {Name:mk900956b073697a4aa6c80a27c6bb0742a99a53 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I0911 11:19:48.002187 45125 install.go:117] Validating docker-machine-driver-kvm2, PATH=/home/jenkins/minikube-integration/17225-6025/.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
I0911 11:19:48.018111 45125 install.go:137] /home/jenkins/workspace/KVM_Linux_integration/out/docker-machine-driver-kvm2 version is 1.31.2
I0911 11:19:48.018177 45125 start_flags.go:307] no existing cluster config was found, will generate one from the flags
E0911 11:19:48.018438 45125 start_flags.go:455] Found deprecated --enable-default-cni flag, setting --cni=bridge
I0911 11:19:48.018467 45125 start_flags.go:922] Waiting for all components: map[apiserver:true apps_running:true default_sa:true extra:true kubelet:true node_ready:true system_pods:true]
I0911 11:19:48.018504 45125 cni.go:84] Creating CNI manager for "bridge"
I0911 11:19:48.018513 45125 start_flags.go:316] Found "bridge CNI" CNI - setting NetworkPlugin=cni
I0911 11:19:48.018524 45125 start_flags.go:321] config:
{Name:enable-default-cni-304911 KeepContext:false EmbedCerts:false MinikubeISO: KicBaseImage:gcr.io/k8s-minikube/kicbase-builds:v0.0.40-1693938323-17174@sha256:4edc55cb1933a7155ece55408f8b4aebfd99e28fa2209bc82b369d8ca3bf525b Memory:3072 CPUs:2 DiskSize:20000 VMDriver: Driver:kvm2 HyperkitVpnKitSock: HyperkitVSockPorts:[] DockerEnv:[] ContainerVolumeMounts:[] InsecureRegistry:[] RegistryMirror:[] HostOnlyCIDR:192.168.59.1/24 HypervVirtualSwitch: HypervUseExternalSwitch:false HypervExternalAdapter: KVMNetwork:default KVMQemuURI:qemu:///system KVMGPU:false KVMHidden:false KVMNUMACount:1 APIServerPort:0 DockerOpt:[] DisableDriverMounts:false NFSShare:[] NFSSharesRoot:/nfsshares UUID: NoVTXCheck:false DNSProxy:false HostDNSResolver:true HostOnlyNicType:virtio NatNicType:virtio SSHIPAddress: SSHUser:root SSHKey: SSHPort:22 KubernetesConfig:{KubernetesVersion:v1.28.1 ClusterName:enable-default-cni-304911 Namespace:default APIServerName:minikubeCA APIServerNames:[] APIServerIPs:[] DNSDomain:cluster.local Con
tainerRuntime:docker CRISocket: NetworkPlugin:cni FeatureGates: ServiceCIDR:10.96.0.0/12 ImageRepository: LoadBalancerStartIP: LoadBalancerEndIP: CustomIngressCert: RegistryAliases: ExtraOptions:[] ShouldLoadCachedImages:true EnableDefaultCNI:false CNI:bridge NodeIP: NodePort:8443 NodeName:} Nodes:[] 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 AutoPauseInterval:1m0s}
I0911 11:19:48.018707 45125 iso.go:125] acquiring lock: {Name:mk505ff3d3cf2c9eebbc446e5f169ceb5e457b9e Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I0911 11:19:48.020848 45125 out.go:177] * Starting control plane node enable-default-cni-304911 in cluster enable-default-cni-304911
I0911 11:19:48.022343 45125 preload.go:132] Checking if preload exists for k8s version v1.28.1 and runtime docker
I0911 11:19:48.022386 45125 preload.go:148] Found local preload: /home/jenkins/minikube-integration/17225-6025/.minikube/cache/preloaded-tarball/preloaded-images-k8s-v18-v1.28.1-docker-overlay2-amd64.tar.lz4
I0911 11:19:48.022411 45125 cache.go:57] Caching tarball of preloaded images
I0911 11:19:48.022517 45125 preload.go:174] Found /home/jenkins/minikube-integration/17225-6025/.minikube/cache/preloaded-tarball/preloaded-images-k8s-v18-v1.28.1-docker-overlay2-amd64.tar.lz4 in cache, skipping download
I0911 11:19:48.022529 45125 cache.go:60] Finished verifying existence of preloaded tar for v1.28.1 on docker
I0911 11:19:48.022682 45125 profile.go:148] Saving config to /home/jenkins/minikube-integration/17225-6025/.minikube/profiles/enable-default-cni-304911/config.json ...
I0911 11:19:48.022703 45125 lock.go:35] WriteFile acquiring /home/jenkins/minikube-integration/17225-6025/.minikube/profiles/enable-default-cni-304911/config.json: {Name:mkd9404f878b6b210b9e520542b0558145e00666 Clock:{} Delay:500ms Timeout:1m0s Cancel:<nil>}
I0911 11:19:48.022847 45125 start.go:365] acquiring machines lock for enable-default-cni-304911: {Name:mkd7bbbfa87c00fb01eeac67b9f499aece489964 Clock:{} Delay:500ms Timeout:13m0s Cancel:<nil>}
I0911 11:20:04.493441 45125 start.go:369] acquired machines lock for "enable-default-cni-304911" in 16.470545743s
I0911 11:20:04.493510 45125 start.go:93] Provisioning new machine with config: &{Name:enable-default-cni-304911 KeepContext:false EmbedCerts:false MinikubeISO:https://storage.googleapis.com/minikube-builds/iso/17120/minikube-v1.31.0-1692872107-17120-amd64.iso KicBaseImage:gcr.io/k8s-minikube/kicbase-builds:v0.0.40-1693938323-17174@sha256:4edc55cb1933a7155ece55408f8b4aebfd99e28fa2209bc82b369d8ca3bf525b Memory:3072 CPUs:2 DiskSize:20000 VMDriver: Driver:kvm2 HyperkitVpnKitSock: HyperkitVSockPorts:[] DockerEnv:[] ContainerVolumeMounts:[] InsecureRegistry:[] RegistryMirror:[] HostOnlyCIDR:192.168.59.1/24 HypervVirtualSwitch: HypervUseExternalSwitch:false HypervExternalAdapter: KVMNetwork:default KVMQemuURI:qemu:///system KVMGPU:false KVMHidden:false KVMNUMACount:1 APIServerPort:0 DockerOpt:[] DisableDriverMounts:false NFSShare:[] NFSSharesRoot:/nfsshares UUID: NoVTXCheck:false DNSProxy:false HostDNSResolver:true HostOnlyNicType:virtio NatNicType:virtio SSHIPAddress: SSHUser:root SSHKey: SSHPort:22 Kube
rnetesConfig:{KubernetesVersion:v1.28.1 ClusterName:enable-default-cni-304911 Namespace:default APIServerName:minikubeCA APIServerNames:[] APIServerIPs:[] DNSDomain:cluster.local ContainerRuntime:docker CRISocket: NetworkPlugin:cni FeatureGates: ServiceCIDR:10.96.0.0/12 ImageRepository: LoadBalancerStartIP: LoadBalancerEndIP: CustomIngressCert: RegistryAliases: ExtraOptions:[] ShouldLoadCachedImages:true EnableDefaultCNI:false CNI:bridge NodeIP: NodePort:8443 NodeName:} Nodes:[{Name: IP: Port:8443 KubernetesVersion:v1.28.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:docke
r MountIP: MountMSize:262144 MountOptions:[] MountPort:0 MountType:9p MountUID:docker BinaryMirror: DisableOptimizations:false DisableMetrics:false CustomQemuFirmwarePath: SocketVMnetClientPath: SocketVMnetPath: StaticIP: SSHAuthSock: SSHAgentPID:0 AutoPauseInterval:1m0s} &{Name: IP: Port:8443 KubernetesVersion:v1.28.1 ContainerRuntime:docker ControlPlane:true Worker:true}
I0911 11:20:04.493636 45125 start.go:125] createHost starting for "" (driver="kvm2")
I0911 11:20:04.495534 45125 out.go:204] * Creating kvm2 VM (CPUs=2, Memory=3072MB, Disk=20000MB) ...
I0911 11:20:04.495718 45125 main.go:141] libmachine: Found binary path at /home/jenkins/workspace/KVM_Linux_integration/out/docker-machine-driver-kvm2
I0911 11:20:04.495778 45125 main.go:141] libmachine: Launching plugin server for driver kvm2
I0911 11:20:04.512841 45125 main.go:141] libmachine: Plugin server listening at address 127.0.0.1:45043
I0911 11:20:04.513281 45125 main.go:141] libmachine: () Calling .GetVersion
I0911 11:20:04.513958 45125 main.go:141] libmachine: Using API Version 1
I0911 11:20:04.513984 45125 main.go:141] libmachine: () Calling .SetConfigRaw
I0911 11:20:04.514293 45125 main.go:141] libmachine: () Calling .GetMachineName
I0911 11:20:04.514500 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetMachineName
I0911 11:20:04.514675 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .DriverName
I0911 11:20:04.514857 45125 start.go:159] libmachine.API.Create for "enable-default-cni-304911" (driver="kvm2")
I0911 11:20:04.514886 45125 client.go:168] LocalClient.Create starting
I0911 11:20:04.514916 45125 main.go:141] libmachine: Reading certificate data from /home/jenkins/minikube-integration/17225-6025/.minikube/certs/ca.pem
I0911 11:20:04.514957 45125 main.go:141] libmachine: Decoding PEM data...
I0911 11:20:04.514987 45125 main.go:141] libmachine: Parsing certificate...
I0911 11:20:04.515057 45125 main.go:141] libmachine: Reading certificate data from /home/jenkins/minikube-integration/17225-6025/.minikube/certs/cert.pem
I0911 11:20:04.515085 45125 main.go:141] libmachine: Decoding PEM data...
I0911 11:20:04.515102 45125 main.go:141] libmachine: Parsing certificate...
I0911 11:20:04.515140 45125 main.go:141] libmachine: Running pre-create checks...
I0911 11:20:04.515154 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .PreCreateCheck
I0911 11:20:04.515530 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetConfigRaw
I0911 11:20:04.515918 45125 main.go:141] libmachine: Creating machine...
I0911 11:20:04.515936 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .Create
I0911 11:20:04.516062 45125 main.go:141] libmachine: (enable-default-cni-304911) Creating KVM machine...
I0911 11:20:04.517157 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | found existing default KVM network
I0911 11:20:04.518722 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | I0911 11:20:04.518523 45263 network.go:209] using free private subnet 192.168.39.0/24: &{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: IfaceIPv4: IfaceMTU:0 IfaceMAC:} reservation:0xc000029f60}
I0911 11:20:04.524150 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | trying to create private KVM network mk-enable-default-cni-304911 192.168.39.0/24...
I0911 11:20:04.604363 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | private KVM network mk-enable-default-cni-304911 192.168.39.0/24 created
I0911 11:20:04.604412 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | I0911 11:20:04.604299 45263 common.go:145] Making disk image using store path: /home/jenkins/minikube-integration/17225-6025/.minikube
I0911 11:20:04.604445 45125 main.go:141] libmachine: (enable-default-cni-304911) Setting up store path in /home/jenkins/minikube-integration/17225-6025/.minikube/machines/enable-default-cni-304911 ...
I0911 11:20:04.604458 45125 main.go:141] libmachine: (enable-default-cni-304911) Building disk image from file:///home/jenkins/minikube-integration/17225-6025/.minikube/cache/iso/amd64/minikube-v1.31.0-1692872107-17120-amd64.iso
I0911 11:20:04.604644 45125 main.go:141] libmachine: (enable-default-cni-304911) Downloading /home/jenkins/minikube-integration/17225-6025/.minikube/cache/boot2docker.iso from file:///home/jenkins/minikube-integration/17225-6025/.minikube/cache/iso/amd64/minikube-v1.31.0-1692872107-17120-amd64.iso...
I0911 11:20:04.868262 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | I0911 11:20:04.868096 45263 common.go:152] Creating ssh key: /home/jenkins/minikube-integration/17225-6025/.minikube/machines/enable-default-cni-304911/id_rsa...
I0911 11:20:05.167258 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | I0911 11:20:05.167139 45263 common.go:158] Creating raw disk image: /home/jenkins/minikube-integration/17225-6025/.minikube/machines/enable-default-cni-304911/enable-default-cni-304911.rawdisk...
I0911 11:20:05.167287 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | Writing magic tar header
I0911 11:20:05.167300 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | Writing SSH key tar header
I0911 11:20:05.167386 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | I0911 11:20:05.167298 45263 common.go:172] Fixing permissions on /home/jenkins/minikube-integration/17225-6025/.minikube/machines/enable-default-cni-304911 ...
I0911 11:20:05.167462 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | Checking permissions on dir: /home/jenkins/minikube-integration/17225-6025/.minikube/machines/enable-default-cni-304911
I0911 11:20:05.167481 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | Checking permissions on dir: /home/jenkins/minikube-integration/17225-6025/.minikube/machines
I0911 11:20:05.167489 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | Checking permissions on dir: /home/jenkins/minikube-integration/17225-6025/.minikube
I0911 11:20:05.167500 45125 main.go:141] libmachine: (enable-default-cni-304911) Setting executable bit set on /home/jenkins/minikube-integration/17225-6025/.minikube/machines/enable-default-cni-304911 (perms=drwx------)
I0911 11:20:05.167517 45125 main.go:141] libmachine: (enable-default-cni-304911) Setting executable bit set on /home/jenkins/minikube-integration/17225-6025/.minikube/machines (perms=drwxr-xr-x)
I0911 11:20:05.167530 45125 main.go:141] libmachine: (enable-default-cni-304911) Setting executable bit set on /home/jenkins/minikube-integration/17225-6025/.minikube (perms=drwxr-xr-x)
I0911 11:20:05.167545 45125 main.go:141] libmachine: (enable-default-cni-304911) Setting executable bit set on /home/jenkins/minikube-integration/17225-6025 (perms=drwxrwxr-x)
I0911 11:20:05.167556 45125 main.go:141] libmachine: (enable-default-cni-304911) Setting executable bit set on /home/jenkins/minikube-integration (perms=drwxrwxr-x)
I0911 11:20:05.167582 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | Checking permissions on dir: /home/jenkins/minikube-integration/17225-6025
I0911 11:20:05.167599 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | Checking permissions on dir: /home/jenkins/minikube-integration
I0911 11:20:05.167611 45125 main.go:141] libmachine: (enable-default-cni-304911) Setting executable bit set on /home/jenkins (perms=drwxr-xr-x)
I0911 11:20:05.167628 45125 main.go:141] libmachine: (enable-default-cni-304911) Creating domain...
I0911 11:20:05.167660 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | Checking permissions on dir: /home/jenkins
I0911 11:20:05.167690 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | Checking permissions on dir: /home
I0911 11:20:05.167709 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | Skipping /home - not owner
I0911 11:20:05.168719 45125 main.go:141] libmachine: (enable-default-cni-304911) define libvirt domain using xml:
I0911 11:20:05.168735 45125 main.go:141] libmachine: (enable-default-cni-304911) <domain type='kvm'>
I0911 11:20:05.168742 45125 main.go:141] libmachine: (enable-default-cni-304911) <name>enable-default-cni-304911</name>
I0911 11:20:05.168748 45125 main.go:141] libmachine: (enable-default-cni-304911) <memory unit='MiB'>3072</memory>
I0911 11:20:05.168754 45125 main.go:141] libmachine: (enable-default-cni-304911) <vcpu>2</vcpu>
I0911 11:20:05.168776 45125 main.go:141] libmachine: (enable-default-cni-304911) <features>
I0911 11:20:05.168785 45125 main.go:141] libmachine: (enable-default-cni-304911) <acpi/>
I0911 11:20:05.168790 45125 main.go:141] libmachine: (enable-default-cni-304911) <apic/>
I0911 11:20:05.168799 45125 main.go:141] libmachine: (enable-default-cni-304911) <pae/>
I0911 11:20:05.168804 45125 main.go:141] libmachine: (enable-default-cni-304911)
I0911 11:20:05.168812 45125 main.go:141] libmachine: (enable-default-cni-304911) </features>
I0911 11:20:05.168821 45125 main.go:141] libmachine: (enable-default-cni-304911) <cpu mode='host-passthrough'>
I0911 11:20:05.168827 45125 main.go:141] libmachine: (enable-default-cni-304911)
I0911 11:20:05.168834 45125 main.go:141] libmachine: (enable-default-cni-304911) </cpu>
I0911 11:20:05.168839 45125 main.go:141] libmachine: (enable-default-cni-304911) <os>
I0911 11:20:05.168852 45125 main.go:141] libmachine: (enable-default-cni-304911) <type>hvm</type>
I0911 11:20:05.168860 45125 main.go:141] libmachine: (enable-default-cni-304911) <boot dev='cdrom'/>
I0911 11:20:05.168865 45125 main.go:141] libmachine: (enable-default-cni-304911) <boot dev='hd'/>
I0911 11:20:05.168877 45125 main.go:141] libmachine: (enable-default-cni-304911) <bootmenu enable='no'/>
I0911 11:20:05.168883 45125 main.go:141] libmachine: (enable-default-cni-304911) </os>
I0911 11:20:05.168891 45125 main.go:141] libmachine: (enable-default-cni-304911) <devices>
I0911 11:20:05.168903 45125 main.go:141] libmachine: (enable-default-cni-304911) <disk type='file' device='cdrom'>
I0911 11:20:05.168927 45125 main.go:141] libmachine: (enable-default-cni-304911) <source file='/home/jenkins/minikube-integration/17225-6025/.minikube/machines/enable-default-cni-304911/boot2docker.iso'/>
I0911 11:20:05.168944 45125 main.go:141] libmachine: (enable-default-cni-304911) <target dev='hdc' bus='scsi'/>
I0911 11:20:05.168954 45125 main.go:141] libmachine: (enable-default-cni-304911) <readonly/>
I0911 11:20:05.168969 45125 main.go:141] libmachine: (enable-default-cni-304911) </disk>
I0911 11:20:05.168978 45125 main.go:141] libmachine: (enable-default-cni-304911) <disk type='file' device='disk'>
I0911 11:20:05.168990 45125 main.go:141] libmachine: (enable-default-cni-304911) <driver name='qemu' type='raw' cache='default' io='threads' />
I0911 11:20:05.169006 45125 main.go:141] libmachine: (enable-default-cni-304911) <source file='/home/jenkins/minikube-integration/17225-6025/.minikube/machines/enable-default-cni-304911/enable-default-cni-304911.rawdisk'/>
I0911 11:20:05.169037 45125 main.go:141] libmachine: (enable-default-cni-304911) <target dev='hda' bus='virtio'/>
I0911 11:20:05.169060 45125 main.go:141] libmachine: (enable-default-cni-304911) </disk>
I0911 11:20:05.169076 45125 main.go:141] libmachine: (enable-default-cni-304911) <interface type='network'>
I0911 11:20:05.169089 45125 main.go:141] libmachine: (enable-default-cni-304911) <source network='mk-enable-default-cni-304911'/>
I0911 11:20:05.169104 45125 main.go:141] libmachine: (enable-default-cni-304911) <model type='virtio'/>
I0911 11:20:05.169116 45125 main.go:141] libmachine: (enable-default-cni-304911) </interface>
I0911 11:20:05.169128 45125 main.go:141] libmachine: (enable-default-cni-304911) <interface type='network'>
I0911 11:20:05.169145 45125 main.go:141] libmachine: (enable-default-cni-304911) <source network='default'/>
I0911 11:20:05.169158 45125 main.go:141] libmachine: (enable-default-cni-304911) <model type='virtio'/>
I0911 11:20:05.169167 45125 main.go:141] libmachine: (enable-default-cni-304911) </interface>
I0911 11:20:05.169180 45125 main.go:141] libmachine: (enable-default-cni-304911) <serial type='pty'>
I0911 11:20:05.169192 45125 main.go:141] libmachine: (enable-default-cni-304911) <target port='0'/>
I0911 11:20:05.169214 45125 main.go:141] libmachine: (enable-default-cni-304911) </serial>
I0911 11:20:05.169232 45125 main.go:141] libmachine: (enable-default-cni-304911) <console type='pty'>
I0911 11:20:05.169250 45125 main.go:141] libmachine: (enable-default-cni-304911) <target type='serial' port='0'/>
I0911 11:20:05.169266 45125 main.go:141] libmachine: (enable-default-cni-304911) </console>
I0911 11:20:05.169279 45125 main.go:141] libmachine: (enable-default-cni-304911) <rng model='virtio'>
I0911 11:20:05.169296 45125 main.go:141] libmachine: (enable-default-cni-304911) <backend model='random'>/dev/random</backend>
I0911 11:20:05.169309 45125 main.go:141] libmachine: (enable-default-cni-304911) </rng>
I0911 11:20:05.169322 45125 main.go:141] libmachine: (enable-default-cni-304911)
I0911 11:20:05.169335 45125 main.go:141] libmachine: (enable-default-cni-304911)
I0911 11:20:05.169347 45125 main.go:141] libmachine: (enable-default-cni-304911) </devices>
I0911 11:20:05.169360 45125 main.go:141] libmachine: (enable-default-cni-304911) </domain>
I0911 11:20:05.169371 45125 main.go:141] libmachine: (enable-default-cni-304911)
I0911 11:20:05.254281 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined MAC address 52:54:00:3b:de:c9 in network default
I0911 11:20:05.254835 45125 main.go:141] libmachine: (enable-default-cni-304911) Ensuring networks are active...
I0911 11:20:05.254856 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:05.255634 45125 main.go:141] libmachine: (enable-default-cni-304911) Ensuring network default is active
I0911 11:20:05.255989 45125 main.go:141] libmachine: (enable-default-cni-304911) Ensuring network mk-enable-default-cni-304911 is active
I0911 11:20:05.312629 45125 main.go:141] libmachine: (enable-default-cni-304911) Getting domain xml...
I0911 11:20:05.313882 45125 main.go:141] libmachine: (enable-default-cni-304911) Creating domain...
I0911 11:20:06.746168 45125 main.go:141] libmachine: (enable-default-cni-304911) Waiting to get IP...
I0911 11:20:06.747080 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:06.747605 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | unable to find current IP address of domain enable-default-cni-304911 in network mk-enable-default-cni-304911
I0911 11:20:06.747636 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | I0911 11:20:06.747585 45263 retry.go:31] will retry after 187.604017ms: waiting for machine to come up
I0911 11:20:06.937803 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:06.938586 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | unable to find current IP address of domain enable-default-cni-304911 in network mk-enable-default-cni-304911
I0911 11:20:06.938620 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | I0911 11:20:06.938530 45263 retry.go:31] will retry after 317.0709ms: waiting for machine to come up
I0911 11:20:07.257198 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:07.257710 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | unable to find current IP address of domain enable-default-cni-304911 in network mk-enable-default-cni-304911
I0911 11:20:07.257738 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | I0911 11:20:07.257672 45263 retry.go:31] will retry after 304.661076ms: waiting for machine to come up
I0911 11:20:07.564415 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:07.564922 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | unable to find current IP address of domain enable-default-cni-304911 in network mk-enable-default-cni-304911
I0911 11:20:07.564952 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | I0911 11:20:07.564876 45263 retry.go:31] will retry after 418.24404ms: waiting for machine to come up
I0911 11:20:07.985420 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:07.986001 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | unable to find current IP address of domain enable-default-cni-304911 in network mk-enable-default-cni-304911
I0911 11:20:07.986046 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | I0911 11:20:07.985949 45263 retry.go:31] will retry after 752.42061ms: waiting for machine to come up
I0911 11:20:08.740383 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:08.740999 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | unable to find current IP address of domain enable-default-cni-304911 in network mk-enable-default-cni-304911
I0911 11:20:08.741026 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | I0911 11:20:08.740945 45263 retry.go:31] will retry after 676.467304ms: waiting for machine to come up
I0911 11:20:09.419057 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:09.419903 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | unable to find current IP address of domain enable-default-cni-304911 in network mk-enable-default-cni-304911
I0911 11:20:09.419931 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | I0911 11:20:09.419718 45263 retry.go:31] will retry after 877.119118ms: waiting for machine to come up
I0911 11:20:10.298256 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:10.298901 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | unable to find current IP address of domain enable-default-cni-304911 in network mk-enable-default-cni-304911
I0911 11:20:10.298935 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | I0911 11:20:10.298857 45263 retry.go:31] will retry after 1.465468927s: waiting for machine to come up
I0911 11:20:11.765835 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:11.766293 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | unable to find current IP address of domain enable-default-cni-304911 in network mk-enable-default-cni-304911
I0911 11:20:11.766327 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | I0911 11:20:11.766191 45263 retry.go:31] will retry after 1.799949158s: waiting for machine to come up
I0911 11:20:13.567495 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:13.568147 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | unable to find current IP address of domain enable-default-cni-304911 in network mk-enable-default-cni-304911
I0911 11:20:13.568191 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | I0911 11:20:13.568101 45263 retry.go:31] will retry after 2.285971206s: waiting for machine to come up
I0911 11:20:15.855398 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:15.855966 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | unable to find current IP address of domain enable-default-cni-304911 in network mk-enable-default-cni-304911
I0911 11:20:15.855996 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | I0911 11:20:15.855919 45263 retry.go:31] will retry after 2.728781263s: waiting for machine to come up
I0911 11:20:18.586425 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:18.586787 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | unable to find current IP address of domain enable-default-cni-304911 in network mk-enable-default-cni-304911
I0911 11:20:18.586814 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | I0911 11:20:18.586708 45263 retry.go:31] will retry after 2.788085849s: waiting for machine to come up
I0911 11:20:21.377583 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:21.378123 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | unable to find current IP address of domain enable-default-cni-304911 in network mk-enable-default-cni-304911
I0911 11:20:21.378156 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | I0911 11:20:21.378060 45263 retry.go:31] will retry after 4.087291335s: waiting for machine to come up
I0911 11:20:25.466998 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:25.467522 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | unable to find current IP address of domain enable-default-cni-304911 in network mk-enable-default-cni-304911
I0911 11:20:25.467547 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | I0911 11:20:25.467475 45263 retry.go:31] will retry after 3.907555685s: waiting for machine to come up
I0911 11:20:29.377712 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:29.378373 45125 main.go:141] libmachine: (enable-default-cni-304911) Found IP for machine: 192.168.39.30
I0911 11:20:29.378397 45125 main.go:141] libmachine: (enable-default-cni-304911) Reserving static IP address...
I0911 11:20:29.378434 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has current primary IP address 192.168.39.30 and MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:29.378800 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | unable to find host DHCP lease matching {name: "enable-default-cni-304911", mac: "52:54:00:6a:94:df", ip: "192.168.39.30"} in network mk-enable-default-cni-304911
I0911 11:20:29.462361 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | Getting to WaitForSSH function...
I0911 11:20:29.462408 45125 main.go:141] libmachine: (enable-default-cni-304911) Reserved static IP address: 192.168.39.30
I0911 11:20:29.462427 45125 main.go:141] libmachine: (enable-default-cni-304911) Waiting for SSH to be available...
I0911 11:20:29.465757 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:29.466136 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:6a:94:df", ip: ""} in network mk-enable-default-cni-304911: {Iface:virbr2 ExpiryTime:2023-09-11 12:20:23 +0000 UTC Type:0 Mac:52:54:00:6a:94:df Iaid: IPaddr:192.168.39.30 Prefix:24 Hostname:minikube Clientid:01:52:54:00:6a:94:df}
I0911 11:20:29.466187 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined IP address 192.168.39.30 and MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:29.466270 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | Using SSH client type: external
I0911 11:20:29.466303 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | Using SSH private key: /home/jenkins/minikube-integration/17225-6025/.minikube/machines/enable-default-cni-304911/id_rsa (-rw-------)
I0911 11:20:29.466330 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | &{[-F /dev/null -o ConnectionAttempts=3 -o ConnectTimeout=10 -o ControlMaster=no -o ControlPath=none -o LogLevel=quiet -o PasswordAuthentication=no -o ServerAliveInterval=60 -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null docker@192.168.39.30 -o IdentitiesOnly=yes -i /home/jenkins/minikube-integration/17225-6025/.minikube/machines/enable-default-cni-304911/id_rsa -p 22] /usr/bin/ssh <nil>}
I0911 11:20:29.466403 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | About to run SSH command:
I0911 11:20:29.466426 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | exit 0
I0911 11:20:29.568644 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | SSH cmd err, output: <nil>:
I0911 11:20:29.568932 45125 main.go:141] libmachine: (enable-default-cni-304911) KVM machine creation complete!
I0911 11:20:29.569457 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetConfigRaw
I0911 11:20:29.570041 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .DriverName
I0911 11:20:29.570232 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .DriverName
I0911 11:20:29.570416 45125 main.go:141] libmachine: Waiting for machine to be running, this may take a few minutes...
I0911 11:20:29.570432 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetState
I0911 11:20:29.572024 45125 main.go:141] libmachine: Detecting operating system of created instance...
I0911 11:20:29.572041 45125 main.go:141] libmachine: Waiting for SSH to be available...
I0911 11:20:29.572050 45125 main.go:141] libmachine: Getting to WaitForSSH function...
I0911 11:20:29.572065 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHHostname
I0911 11:20:29.574977 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:29.575532 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:6a:94:df", ip: ""} in network mk-enable-default-cni-304911: {Iface:virbr2 ExpiryTime:2023-09-11 12:20:23 +0000 UTC Type:0 Mac:52:54:00:6a:94:df Iaid: IPaddr:192.168.39.30 Prefix:24 Hostname:enable-default-cni-304911 Clientid:01:52:54:00:6a:94:df}
I0911 11:20:29.575572 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined IP address 192.168.39.30 and MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:29.575728 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHPort
I0911 11:20:29.575896 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHKeyPath
I0911 11:20:29.576055 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHKeyPath
I0911 11:20:29.576354 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHUsername
I0911 11:20:29.576610 45125 main.go:141] libmachine: Using SSH client type: native
I0911 11:20:29.577064 45125 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x80ff00] 0x812fa0 <nil> [] 0s} 192.168.39.30 22 <nil> <nil>}
I0911 11:20:29.577076 45125 main.go:141] libmachine: About to run SSH command:
exit 0
I0911 11:20:29.696065 45125 main.go:141] libmachine: SSH cmd err, output: <nil>:
I0911 11:20:29.696087 45125 main.go:141] libmachine: Detecting the provisioner...
I0911 11:20:29.696097 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHHostname
I0911 11:20:29.698906 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:29.699360 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:6a:94:df", ip: ""} in network mk-enable-default-cni-304911: {Iface:virbr2 ExpiryTime:2023-09-11 12:20:23 +0000 UTC Type:0 Mac:52:54:00:6a:94:df Iaid: IPaddr:192.168.39.30 Prefix:24 Hostname:enable-default-cni-304911 Clientid:01:52:54:00:6a:94:df}
I0911 11:20:29.699400 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined IP address 192.168.39.30 and MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:29.699589 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHPort
I0911 11:20:29.699804 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHKeyPath
I0911 11:20:29.699952 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHKeyPath
I0911 11:20:29.700100 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHUsername
I0911 11:20:29.700274 45125 main.go:141] libmachine: Using SSH client type: native
I0911 11:20:29.700732 45125 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x80ff00] 0x812fa0 <nil> [] 0s} 192.168.39.30 22 <nil> <nil>}
I0911 11:20:29.700750 45125 main.go:141] libmachine: About to run SSH command:
cat /etc/os-release
I0911 11:20:29.813870 45125 main.go:141] libmachine: SSH cmd err, output: <nil>: NAME=Buildroot
VERSION=2021.02.12-1-g88b5c50-dirty
ID=buildroot
VERSION_ID=2021.02.12
PRETTY_NAME="Buildroot 2021.02.12"
I0911 11:20:29.813925 45125 main.go:141] libmachine: found compatible host: buildroot
I0911 11:20:29.813936 45125 main.go:141] libmachine: Provisioning with buildroot...
I0911 11:20:29.814030 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetMachineName
I0911 11:20:29.814296 45125 buildroot.go:166] provisioning hostname "enable-default-cni-304911"
I0911 11:20:29.814330 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetMachineName
I0911 11:20:29.814524 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHHostname
I0911 11:20:29.818310 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:29.818823 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:6a:94:df", ip: ""} in network mk-enable-default-cni-304911: {Iface:virbr2 ExpiryTime:2023-09-11 12:20:23 +0000 UTC Type:0 Mac:52:54:00:6a:94:df Iaid: IPaddr:192.168.39.30 Prefix:24 Hostname:enable-default-cni-304911 Clientid:01:52:54:00:6a:94:df}
I0911 11:20:29.818857 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined IP address 192.168.39.30 and MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:29.818995 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHPort
I0911 11:20:29.819302 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHKeyPath
I0911 11:20:29.819515 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHKeyPath
I0911 11:20:29.819692 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHUsername
I0911 11:20:29.819892 45125 main.go:141] libmachine: Using SSH client type: native
I0911 11:20:29.820608 45125 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x80ff00] 0x812fa0 <nil> [] 0s} 192.168.39.30 22 <nil> <nil>}
I0911 11:20:29.820631 45125 main.go:141] libmachine: About to run SSH command:
sudo hostname enable-default-cni-304911 && echo "enable-default-cni-304911" | sudo tee /etc/hostname
I0911 11:20:29.952856 45125 main.go:141] libmachine: SSH cmd err, output: <nil>: enable-default-cni-304911
I0911 11:20:29.952892 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHHostname
I0911 11:20:29.956781 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:29.957314 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:6a:94:df", ip: ""} in network mk-enable-default-cni-304911: {Iface:virbr2 ExpiryTime:2023-09-11 12:20:23 +0000 UTC Type:0 Mac:52:54:00:6a:94:df Iaid: IPaddr:192.168.39.30 Prefix:24 Hostname:enable-default-cni-304911 Clientid:01:52:54:00:6a:94:df}
I0911 11:20:29.957365 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined IP address 192.168.39.30 and MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:29.957529 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHPort
I0911 11:20:29.957754 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHKeyPath
I0911 11:20:29.957919 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHKeyPath
I0911 11:20:29.958082 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHUsername
I0911 11:20:29.958275 45125 main.go:141] libmachine: Using SSH client type: native
I0911 11:20:29.958683 45125 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x80ff00] 0x812fa0 <nil> [] 0s} 192.168.39.30 22 <nil> <nil>}
I0911 11:20:29.958714 45125 main.go:141] libmachine: About to run SSH command:
if ! grep -xq '.*\senable-default-cni-304911' /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 enable-default-cni-304911/g' /etc/hosts;
else
echo '127.0.1.1 enable-default-cni-304911' | sudo tee -a /etc/hosts;
fi
fi
I0911 11:20:30.098835 45125 main.go:141] libmachine: SSH cmd err, output: <nil>:
I0911 11:20:30.098855 45125 buildroot.go:172] set auth options {CertDir:/home/jenkins/minikube-integration/17225-6025/.minikube CaCertPath:/home/jenkins/minikube-integration/17225-6025/.minikube/certs/ca.pem CaPrivateKeyPath:/home/jenkins/minikube-integration/17225-6025/.minikube/certs/ca-key.pem CaCertRemotePath:/etc/docker/ca.pem ServerCertPath:/home/jenkins/minikube-integration/17225-6025/.minikube/machines/server.pem ServerKeyPath:/home/jenkins/minikube-integration/17225-6025/.minikube/machines/server-key.pem ClientKeyPath:/home/jenkins/minikube-integration/17225-6025/.minikube/certs/key.pem ServerCertRemotePath:/etc/docker/server.pem ServerKeyRemotePath:/etc/docker/server-key.pem ClientCertPath:/home/jenkins/minikube-integration/17225-6025/.minikube/certs/cert.pem ServerCertSANs:[] StorePath:/home/jenkins/minikube-integration/17225-6025/.minikube}
I0911 11:20:30.098895 45125 buildroot.go:174] setting up certificates
I0911 11:20:30.098906 45125 provision.go:83] configureAuth start
I0911 11:20:30.098914 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetMachineName
I0911 11:20:30.099181 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetIP
I0911 11:20:30.103554 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:30.104179 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:6a:94:df", ip: ""} in network mk-enable-default-cni-304911: {Iface:virbr2 ExpiryTime:2023-09-11 12:20:23 +0000 UTC Type:0 Mac:52:54:00:6a:94:df Iaid: IPaddr:192.168.39.30 Prefix:24 Hostname:enable-default-cni-304911 Clientid:01:52:54:00:6a:94:df}
I0911 11:20:30.104203 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined IP address 192.168.39.30 and MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:30.105126 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHHostname
I0911 11:20:30.108359 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:30.108786 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:6a:94:df", ip: ""} in network mk-enable-default-cni-304911: {Iface:virbr2 ExpiryTime:2023-09-11 12:20:23 +0000 UTC Type:0 Mac:52:54:00:6a:94:df Iaid: IPaddr:192.168.39.30 Prefix:24 Hostname:enable-default-cni-304911 Clientid:01:52:54:00:6a:94:df}
I0911 11:20:30.108827 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined IP address 192.168.39.30 and MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:30.109048 45125 provision.go:138] copyHostCerts
I0911 11:20:30.109108 45125 exec_runner.go:144] found /home/jenkins/minikube-integration/17225-6025/.minikube/ca.pem, removing ...
I0911 11:20:30.109119 45125 exec_runner.go:203] rm: /home/jenkins/minikube-integration/17225-6025/.minikube/ca.pem
I0911 11:20:30.109176 45125 exec_runner.go:151] cp: /home/jenkins/minikube-integration/17225-6025/.minikube/certs/ca.pem --> /home/jenkins/minikube-integration/17225-6025/.minikube/ca.pem (1082 bytes)
I0911 11:20:30.109309 45125 exec_runner.go:144] found /home/jenkins/minikube-integration/17225-6025/.minikube/cert.pem, removing ...
I0911 11:20:30.109316 45125 exec_runner.go:203] rm: /home/jenkins/minikube-integration/17225-6025/.minikube/cert.pem
I0911 11:20:30.109350 45125 exec_runner.go:151] cp: /home/jenkins/minikube-integration/17225-6025/.minikube/certs/cert.pem --> /home/jenkins/minikube-integration/17225-6025/.minikube/cert.pem (1123 bytes)
I0911 11:20:30.109435 45125 exec_runner.go:144] found /home/jenkins/minikube-integration/17225-6025/.minikube/key.pem, removing ...
I0911 11:20:30.109441 45125 exec_runner.go:203] rm: /home/jenkins/minikube-integration/17225-6025/.minikube/key.pem
I0911 11:20:30.109466 45125 exec_runner.go:151] cp: /home/jenkins/minikube-integration/17225-6025/.minikube/certs/key.pem --> /home/jenkins/minikube-integration/17225-6025/.minikube/key.pem (1679 bytes)
I0911 11:20:30.109540 45125 provision.go:112] generating server cert: /home/jenkins/minikube-integration/17225-6025/.minikube/machines/server.pem ca-key=/home/jenkins/minikube-integration/17225-6025/.minikube/certs/ca.pem private-key=/home/jenkins/minikube-integration/17225-6025/.minikube/certs/ca-key.pem org=jenkins.enable-default-cni-304911 san=[192.168.39.30 192.168.39.30 localhost 127.0.0.1 minikube enable-default-cni-304911]
I0911 11:20:30.178275 45125 provision.go:172] copyRemoteCerts
I0911 11:20:30.178349 45125 ssh_runner.go:195] Run: sudo mkdir -p /etc/docker /etc/docker /etc/docker
I0911 11:20:30.178383 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHHostname
I0911 11:20:30.180997 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:30.181440 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:6a:94:df", ip: ""} in network mk-enable-default-cni-304911: {Iface:virbr2 ExpiryTime:2023-09-11 12:20:23 +0000 UTC Type:0 Mac:52:54:00:6a:94:df Iaid: IPaddr:192.168.39.30 Prefix:24 Hostname:enable-default-cni-304911 Clientid:01:52:54:00:6a:94:df}
I0911 11:20:30.181473 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined IP address 192.168.39.30 and MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:30.181601 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHPort
I0911 11:20:30.181801 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHKeyPath
I0911 11:20:30.181961 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHUsername
I0911 11:20:30.182112 45125 sshutil.go:53] new ssh client: &{IP:192.168.39.30 Port:22 SSHKeyPath:/home/jenkins/minikube-integration/17225-6025/.minikube/machines/enable-default-cni-304911/id_rsa Username:docker}
I0911 11:20:30.273456 45125 ssh_runner.go:362] scp /home/jenkins/minikube-integration/17225-6025/.minikube/certs/ca.pem --> /etc/docker/ca.pem (1082 bytes)
I0911 11:20:30.306781 45125 ssh_runner.go:362] scp /home/jenkins/minikube-integration/17225-6025/.minikube/machines/server.pem --> /etc/docker/server.pem (1249 bytes)
I0911 11:20:30.343780 45125 ssh_runner.go:362] scp /home/jenkins/minikube-integration/17225-6025/.minikube/machines/server-key.pem --> /etc/docker/server-key.pem (1675 bytes)
I0911 11:20:30.388417 45125 provision.go:86] duration metric: configureAuth took 289.498004ms
I0911 11:20:30.388445 45125 buildroot.go:189] setting minikube options for container-runtime
I0911 11:20:30.388674 45125 config.go:182] Loaded profile config "enable-default-cni-304911": Driver=kvm2, ContainerRuntime=docker, KubernetesVersion=v1.28.1
I0911 11:20:30.388701 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .DriverName
I0911 11:20:30.391999 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHHostname
I0911 11:20:30.397746 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:30.398316 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:6a:94:df", ip: ""} in network mk-enable-default-cni-304911: {Iface:virbr2 ExpiryTime:2023-09-11 12:20:23 +0000 UTC Type:0 Mac:52:54:00:6a:94:df Iaid: IPaddr:192.168.39.30 Prefix:24 Hostname:enable-default-cni-304911 Clientid:01:52:54:00:6a:94:df}
I0911 11:20:30.398353 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined IP address 192.168.39.30 and MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:30.398553 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHPort
I0911 11:20:30.398748 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHKeyPath
I0911 11:20:30.398956 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHKeyPath
I0911 11:20:30.399114 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHUsername
I0911 11:20:30.399291 45125 main.go:141] libmachine: Using SSH client type: native
I0911 11:20:30.399858 45125 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x80ff00] 0x812fa0 <nil> [] 0s} 192.168.39.30 22 <nil> <nil>}
I0911 11:20:30.399873 45125 main.go:141] libmachine: About to run SSH command:
df --output=fstype / | tail -n 1
I0911 11:20:30.534214 45125 main.go:141] libmachine: SSH cmd err, output: <nil>: tmpfs
I0911 11:20:30.534240 45125 buildroot.go:70] root file system type: tmpfs
I0911 11:20:30.534371 45125 provision.go:309] Updating docker unit: /lib/systemd/system/docker.service ...
I0911 11:20:30.534393 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHHostname
I0911 11:20:30.537248 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:30.537582 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:6a:94:df", ip: ""} in network mk-enable-default-cni-304911: {Iface:virbr2 ExpiryTime:2023-09-11 12:20:23 +0000 UTC Type:0 Mac:52:54:00:6a:94:df Iaid: IPaddr:192.168.39.30 Prefix:24 Hostname:enable-default-cni-304911 Clientid:01:52:54:00:6a:94:df}
I0911 11:20:30.537627 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined IP address 192.168.39.30 and MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:30.537795 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHPort
I0911 11:20:30.538017 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHKeyPath
I0911 11:20:30.538225 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHKeyPath
I0911 11:20:30.538402 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHUsername
I0911 11:20:30.540549 45125 main.go:141] libmachine: Using SSH client type: native
I0911 11:20:30.541246 45125 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x80ff00] 0x812fa0 <nil> [] 0s} 192.168.39.30 22 <nil> <nil>}
I0911 11:20:30.541354 45125 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
I0911 11:20:30.673922 45125 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
I0911 11:20:30.673949 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHHostname
I0911 11:20:30.678823 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:30.679393 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:6a:94:df", ip: ""} in network mk-enable-default-cni-304911: {Iface:virbr2 ExpiryTime:2023-09-11 12:20:23 +0000 UTC Type:0 Mac:52:54:00:6a:94:df Iaid: IPaddr:192.168.39.30 Prefix:24 Hostname:enable-default-cni-304911 Clientid:01:52:54:00:6a:94:df}
I0911 11:20:30.679420 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined IP address 192.168.39.30 and MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:30.679637 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHPort
I0911 11:20:30.679803 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHKeyPath
I0911 11:20:30.679989 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHKeyPath
I0911 11:20:30.680216 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHUsername
I0911 11:20:30.680449 45125 main.go:141] libmachine: Using SSH client type: native
I0911 11:20:30.681051 45125 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x80ff00] 0x812fa0 <nil> [] 0s} 192.168.39.30 22 <nil> <nil>}
I0911 11:20:30.681088 45125 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; }
I0911 11:20:31.753324 45125 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.
I0911 11:20:31.753354 45125 main.go:141] libmachine: Checking connection to Docker...
I0911 11:20:31.753366 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetURL
I0911 11:20:31.754667 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | Using libvirt version 6000000
I0911 11:20:31.756736 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:31.757093 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:6a:94:df", ip: ""} in network mk-enable-default-cni-304911: {Iface:virbr2 ExpiryTime:2023-09-11 12:20:23 +0000 UTC Type:0 Mac:52:54:00:6a:94:df Iaid: IPaddr:192.168.39.30 Prefix:24 Hostname:enable-default-cni-304911 Clientid:01:52:54:00:6a:94:df}
I0911 11:20:31.757126 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined IP address 192.168.39.30 and MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:31.757259 45125 main.go:141] libmachine: Docker is up and running!
I0911 11:20:31.757278 45125 main.go:141] libmachine: Reticulating splines...
I0911 11:20:31.757293 45125 client.go:171] LocalClient.Create took 27.242391379s
I0911 11:20:31.757315 45125 start.go:167] duration metric: libmachine.API.Create for "enable-default-cni-304911" took 27.242460125s
I0911 11:20:31.757324 45125 start.go:300] post-start starting for "enable-default-cni-304911" (driver="kvm2")
I0911 11:20:31.757337 45125 start.go:329] creating required directories: [/etc/kubernetes/addons /etc/kubernetes/manifests /var/tmp/minikube /var/lib/minikube /var/lib/minikube/certs /var/lib/minikube/images /var/lib/minikube/binaries /tmp/gvisor /usr/share/ca-certificates /etc/ssl/certs]
I0911 11:20:31.757357 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .DriverName
I0911 11:20:31.757585 45125 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
I0911 11:20:31.757618 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHHostname
I0911 11:20:31.760750 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:31.760784 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:6a:94:df", ip: ""} in network mk-enable-default-cni-304911: {Iface:virbr2 ExpiryTime:2023-09-11 12:20:23 +0000 UTC Type:0 Mac:52:54:00:6a:94:df Iaid: IPaddr:192.168.39.30 Prefix:24 Hostname:enable-default-cni-304911 Clientid:01:52:54:00:6a:94:df}
I0911 11:20:31.760813 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined IP address 192.168.39.30 and MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:31.761001 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHPort
I0911 11:20:31.761620 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHKeyPath
I0911 11:20:31.761828 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHUsername
I0911 11:20:31.762004 45125 sshutil.go:53] new ssh client: &{IP:192.168.39.30 Port:22 SSHKeyPath:/home/jenkins/minikube-integration/17225-6025/.minikube/machines/enable-default-cni-304911/id_rsa Username:docker}
I0911 11:20:31.854324 45125 ssh_runner.go:195] Run: cat /etc/os-release
I0911 11:20:31.858866 45125 info.go:137] Remote host: Buildroot 2021.02.12
I0911 11:20:31.858888 45125 filesync.go:126] Scanning /home/jenkins/minikube-integration/17225-6025/.minikube/addons for local assets ...
I0911 11:20:31.858954 45125 filesync.go:126] Scanning /home/jenkins/minikube-integration/17225-6025/.minikube/files for local assets ...
I0911 11:20:31.859058 45125 filesync.go:149] local asset: /home/jenkins/minikube-integration/17225-6025/.minikube/files/etc/ssl/certs/132242.pem -> 132242.pem in /etc/ssl/certs
I0911 11:20:31.859170 45125 ssh_runner.go:195] Run: sudo mkdir -p /etc/ssl/certs
I0911 11:20:31.870132 45125 ssh_runner.go:362] scp /home/jenkins/minikube-integration/17225-6025/.minikube/files/etc/ssl/certs/132242.pem --> /etc/ssl/certs/132242.pem (1708 bytes)
I0911 11:20:31.899521 45125 start.go:303] post-start completed in 142.18288ms
I0911 11:20:31.899653 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetConfigRaw
I0911 11:20:31.900294 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetIP
I0911 11:20:31.905607 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:31.906047 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:6a:94:df", ip: ""} in network mk-enable-default-cni-304911: {Iface:virbr2 ExpiryTime:2023-09-11 12:20:23 +0000 UTC Type:0 Mac:52:54:00:6a:94:df Iaid: IPaddr:192.168.39.30 Prefix:24 Hostname:enable-default-cni-304911 Clientid:01:52:54:00:6a:94:df}
I0911 11:20:31.906077 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined IP address 192.168.39.30 and MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:31.906372 45125 profile.go:148] Saving config to /home/jenkins/minikube-integration/17225-6025/.minikube/profiles/enable-default-cni-304911/config.json ...
I0911 11:20:31.906592 45125 start.go:128] duration metric: createHost completed in 27.412944269s
I0911 11:20:31.906619 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHHostname
I0911 11:20:31.909186 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:31.909658 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:6a:94:df", ip: ""} in network mk-enable-default-cni-304911: {Iface:virbr2 ExpiryTime:2023-09-11 12:20:23 +0000 UTC Type:0 Mac:52:54:00:6a:94:df Iaid: IPaddr:192.168.39.30 Prefix:24 Hostname:enable-default-cni-304911 Clientid:01:52:54:00:6a:94:df}
I0911 11:20:31.909689 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined IP address 192.168.39.30 and MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:31.912406 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHPort
I0911 11:20:31.912605 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHKeyPath
I0911 11:20:31.912775 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHKeyPath
I0911 11:20:31.912974 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHUsername
I0911 11:20:31.913176 45125 main.go:141] libmachine: Using SSH client type: native
I0911 11:20:31.913789 45125 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x80ff00] 0x812fa0 <nil> [] 0s} 192.168.39.30 22 <nil> <nil>}
I0911 11:20:31.913808 45125 main.go:141] libmachine: About to run SSH command:
date +%s.%N
I0911 11:20:32.054016 45125 main.go:141] libmachine: SSH cmd err, output: <nil>: 1694431231.988764057
I0911 11:20:32.054042 45125 fix.go:206] guest clock: 1694431231.988764057
I0911 11:20:32.054051 45125 fix.go:219] Guest: 2023-09-11 11:20:31.988764057 +0000 UTC Remote: 2023-09-11 11:20:31.90660366 +0000 UTC m=+44.018494119 (delta=82.160397ms)
I0911 11:20:32.054075 45125 fix.go:190] guest clock delta is within tolerance: 82.160397ms
I0911 11:20:32.054088 45125 start.go:83] releasing machines lock for "enable-default-cni-304911", held for 27.560615527s
I0911 11:20:32.054111 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .DriverName
I0911 11:20:32.054392 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetIP
I0911 11:20:32.057409 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:32.057908 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:6a:94:df", ip: ""} in network mk-enable-default-cni-304911: {Iface:virbr2 ExpiryTime:2023-09-11 12:20:23 +0000 UTC Type:0 Mac:52:54:00:6a:94:df Iaid: IPaddr:192.168.39.30 Prefix:24 Hostname:enable-default-cni-304911 Clientid:01:52:54:00:6a:94:df}
I0911 11:20:32.057940 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined IP address 192.168.39.30 and MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:32.058138 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .DriverName
I0911 11:20:32.064424 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .DriverName
I0911 11:20:32.064683 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .DriverName
I0911 11:20:32.064774 45125 ssh_runner.go:195] Run: curl -sS -m 2 https://registry.k8s.io/
I0911 11:20:32.064812 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHHostname
I0911 11:20:32.065249 45125 ssh_runner.go:195] Run: cat /version.json
I0911 11:20:32.065271 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHHostname
I0911 11:20:32.068572 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:32.068732 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:32.068944 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:6a:94:df", ip: ""} in network mk-enable-default-cni-304911: {Iface:virbr2 ExpiryTime:2023-09-11 12:20:23 +0000 UTC Type:0 Mac:52:54:00:6a:94:df Iaid: IPaddr:192.168.39.30 Prefix:24 Hostname:enable-default-cni-304911 Clientid:01:52:54:00:6a:94:df}
I0911 11:20:32.068973 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined IP address 192.168.39.30 and MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:32.069144 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:6a:94:df", ip: ""} in network mk-enable-default-cni-304911: {Iface:virbr2 ExpiryTime:2023-09-11 12:20:23 +0000 UTC Type:0 Mac:52:54:00:6a:94:df Iaid: IPaddr:192.168.39.30 Prefix:24 Hostname:enable-default-cni-304911 Clientid:01:52:54:00:6a:94:df}
I0911 11:20:32.069167 45125 main.go:141] libmachine: (enable-default-cni-304911) DBG | domain enable-default-cni-304911 has defined IP address 192.168.39.30 and MAC address 52:54:00:6a:94:df in network mk-enable-default-cni-304911
I0911 11:20:32.069192 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHPort
I0911 11:20:32.069426 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHPort
I0911 11:20:32.069468 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHKeyPath
I0911 11:20:32.069614 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHKeyPath
I0911 11:20:32.069638 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHUsername
I0911 11:20:32.069799 45125 main.go:141] libmachine: (enable-default-cni-304911) Calling .GetSSHUsername
I0911 11:20:32.069833 45125 sshutil.go:53] new ssh client: &{IP:192.168.39.30 Port:22 SSHKeyPath:/home/jenkins/minikube-integration/17225-6025/.minikube/machines/enable-default-cni-304911/id_rsa Username:docker}
I0911 11:20:32.070283 45125 sshutil.go:53] new ssh client: &{IP:192.168.39.30 Port:22 SSHKeyPath:/home/jenkins/minikube-integration/17225-6025/.minikube/machines/enable-default-cni-304911/id_rsa Username:docker}
I0911 11:20:32.193104 45125 ssh_runner.go:195] Run: systemctl --version
I0911 11:20:32.228537 45125 ssh_runner.go:195] Run: sh -c "stat /etc/cni/net.d/*loopback.conf*"
W0911 11:20:32.236992 45125 cni.go:209] loopback cni configuration skipped: "/etc/cni/net.d/*loopback.conf*" not found
I0911 11:20:32.237073 45125 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" ;
I0911 11:20:32.258809 45125 cni.go:262] disabled [/etc/cni/net.d/87-podman-bridge.conflist] bridge cni config(s)
I0911 11:20:32.258848 45125 start.go:466] detecting cgroup driver to use...
I0911 11:20:32.258977 45125 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"
I0911 11:20:32.281308 45125 ssh_runner.go:195] Run: sh -c "sudo sed -i -r 's|^( *)sandbox_image = .*$|\1sandbox_image = "registry.k8s.io/pause:3.9"|' /etc/containerd/config.toml"
I0911 11:20:32.293889 45125 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"
I0911 11:20:32.304872 45125 containerd.go:145] configuring containerd to use "cgroupfs" as cgroup driver...
I0911 11:20:32.304927 45125 ssh_runner.go:195] Run: sh -c "sudo sed -i -r 's|^( *)SystemdCgroup = .*$|\1SystemdCgroup = false|g' /etc/containerd/config.toml"
I0911 11:20:32.315749 45125 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"
I0911 11:20:32.329945 45125 ssh_runner.go:195] Run: sh -c "sudo sed -i '/systemd_cgroup/d' /etc/containerd/config.toml"
I0911 11:20:32.343648 45125 ssh_runner.go:195] Run: sh -c "sudo sed -i 's|"io.containerd.runc.v1"|"io.containerd.runc.v2"|g' /etc/containerd/config.toml"
I0911 11:20:32.354955 45125 ssh_runner.go:195] Run: sh -c "sudo rm -rf /etc/cni/net.mk"
I0911 11:20:32.367920 45125 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"
I0911 11:20:32.381124 45125 ssh_runner.go:195] Run: sudo sysctl net.bridge.bridge-nf-call-iptables
I0911 11:20:32.391515 45125 ssh_runner.go:195] Run: sudo sh -c "echo 1 > /proc/sys/net/ipv4/ip_forward"
I0911 11:20:32.401849 45125 ssh_runner.go:195] Run: sudo systemctl daemon-reload
I0911 11:20:32.529948 45125 ssh_runner.go:195] Run: sudo systemctl restart containerd
I0911 11:20:32.559401 45125 start.go:466] detecting cgroup driver to use...
I0911 11:20:32.559477 45125 ssh_runner.go:195] Run: sudo systemctl cat docker.service
I0911 11:20:32.580778 45125 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service containerd
I0911 11:20:32.602938 45125 ssh_runner.go:195] Run: sudo systemctl stop -f containerd
I0911 11:20:32.626861 45125 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service containerd
I0911 11:20:32.642642 45125 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service crio
I0911 11:20:32.657881 45125 ssh_runner.go:195] Run: sudo systemctl stop -f crio
I0911 11:20:32.711711 45125 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service crio
I0911 11:20:32.730678 45125 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"
I0911 11:20:32.762813 45125 ssh_runner.go:195] Run: which cri-dockerd
I0911 11:20:32.767320 45125 ssh_runner.go:195] Run: sudo mkdir -p /etc/systemd/system/cri-docker.service.d
I0911 11:20:32.776614 45125 ssh_runner.go:362] scp memory --> /etc/systemd/system/cri-docker.service.d/10-cni.conf (189 bytes)
I0911 11:20:32.794975 45125 ssh_runner.go:195] Run: sudo systemctl unmask docker.service
I0911 11:20:32.911015 45125 ssh_runner.go:195] Run: sudo systemctl enable docker.socket
I0911 11:20:33.037639 45125 docker.go:535] configuring docker to use "cgroupfs" as cgroup driver...
I0911 11:20:33.037671 45125 ssh_runner.go:362] scp memory --> /etc/docker/daemon.json (144 bytes)
I0911 11:20:33.057548 45125 ssh_runner.go:195] Run: sudo systemctl daemon-reload
I0911 11:20:33.191495 45125 ssh_runner.go:195] Run: sudo systemctl restart docker
I0911 11:20:34.705753 45125 ssh_runner.go:235] Completed: sudo systemctl restart docker: (1.514223942s)
I0911 11:20:34.705822 45125 ssh_runner.go:195] Run: sudo systemctl enable cri-docker.socket
I0911 11:20:34.836103 45125 ssh_runner.go:195] Run: sudo systemctl unmask cri-docker.socket
I0911 11:20:34.996344 45125 ssh_runner.go:195] Run: sudo systemctl enable cri-docker.socket
I0911 11:20:35.153497 45125 ssh_runner.go:195] Run: sudo systemctl daemon-reload
I0911 11:20:35.294374 45125 ssh_runner.go:195] Run: sudo systemctl restart cri-docker.socket
I0911 11:20:35.326598 45125 out.go:177]
W0911 11:20:35.328381 45125 out.go:239] X Exiting due to RUNTIME_ENABLE: Failed to enable container runtime: sudo systemctl restart cri-docker.socket: Process exited with status 1
stdout:
stderr:
Job failed. See "journalctl -xe" for details.
X Exiting due to RUNTIME_ENABLE: Failed to enable container runtime: sudo systemctl restart cri-docker.socket: Process exited with status 1
stdout:
stderr:
Job failed. See "journalctl -xe" for details.
W0911 11:20:35.328405 45125 out.go:239] *
*
W0911 11:20:35.329608 45125 out.go:239] ╭─────────────────────────────────────────────────────────────────────────────────────────────╮
│ │
│ * If the above advice does not help, please let us know: │
│ https://github.com/kubernetes/minikube/issues/new/choose │
│ │
│ * Please run `minikube logs --file=logs.txt` and attach logs.txt to the GitHub issue. │
│ │
╰─────────────────────────────────────────────────────────────────────────────────────────────╯
╭─────────────────────────────────────────────────────────────────────────────────────────────╮
│ │
│ * If the above advice does not help, please let us know: │
│ https://github.com/kubernetes/minikube/issues/new/choose │
│ │
│ * Please run `minikube logs --file=logs.txt` and attach logs.txt to the GitHub issue. │
│ │
╰─────────────────────────────────────────────────────────────────────────────────────────────╯
I0911 11:20:35.331211 45125 out.go:177]
** /stderr **
net_test.go:114: failed start: exit status 90
--- FAIL: TestNetworkPlugins/group/enable-default-cni/Start (47.48s)