=== RUN TestNetworkPlugins/group/flannel/Start
net_test.go:112: (dbg) Run: out/minikube-linux-amd64 start -p flannel-707566 --memory=3072 --alsologtostderr --wait=true --wait-timeout=15m --cni=flannel --driver=kvm2
net_test.go:112: (dbg) Non-zero exit: out/minikube-linux-amd64 start -p flannel-707566 --memory=3072 --alsologtostderr --wait=true --wait-timeout=15m --cni=flannel --driver=kvm2 : exit status 90 (2m1.097153542s)
-- stdout --
* [flannel-707566] minikube v1.33.0-beta.0 on Ubuntu 20.04 (kvm/amd64)
- MINIKUBE_LOCATION=18644
- MINIKUBE_SUPPRESS_DOCKER_PERFORMANCE=true
- KUBECONFIG=/home/jenkins/minikube-integration/18644-814187/kubeconfig
- MINIKUBE_HOME=/home/jenkins/minikube-integration/18644-814187/.minikube
- MINIKUBE_BIN=out/minikube-linux-amd64
- MINIKUBE_FORCE_SYSTEMD=
* Using the kvm2 driver based on user configuration
* Starting "flannel-707566" primary control-plane node in "flannel-707566" cluster
* Creating kvm2 VM (CPUs=2, Memory=3072MB, Disk=20000MB) ...
-- /stdout --
** stderr **
I0415 12:08:10.274134 868679 out.go:291] Setting OutFile to fd 1 ...
I0415 12:08:10.275101 868679 out.go:338] TERM=,COLORTERM=, which probably does not support color
I0415 12:08:10.275123 868679 out.go:304] Setting ErrFile to fd 2...
I0415 12:08:10.275130 868679 out.go:338] TERM=,COLORTERM=, which probably does not support color
I0415 12:08:10.276011 868679 root.go:338] Updating PATH: /home/jenkins/minikube-integration/18644-814187/.minikube/bin
I0415 12:08:10.277201 868679 out.go:298] Setting JSON to false
I0415 12:08:10.278897 868679 start.go:129] hostinfo: {"hostname":"ubuntu-20-agent-12","uptime":75036,"bootTime":1713107854,"procs":291,"os":"linux","platform":"ubuntu","platformFamily":"debian","platformVersion":"20.04","kernelVersion":"5.15.0-1055-gcp","kernelArch":"x86_64","virtualizationSystem":"kvm","virtualizationRole":"guest","hostId":"591c9f12-2938-3743-e2bf-c56a050d43d1"}
I0415 12:08:10.278985 868679 start.go:139] virtualization: kvm guest
I0415 12:08:10.280963 868679 out.go:177] * [flannel-707566] minikube v1.33.0-beta.0 on Ubuntu 20.04 (kvm/amd64)
I0415 12:08:10.283172 868679 out.go:177] - MINIKUBE_LOCATION=18644
I0415 12:08:10.283230 868679 notify.go:220] Checking for updates...
I0415 12:08:10.284961 868679 out.go:177] - MINIKUBE_SUPPRESS_DOCKER_PERFORMANCE=true
I0415 12:08:10.287108 868679 out.go:177] - KUBECONFIG=/home/jenkins/minikube-integration/18644-814187/kubeconfig
I0415 12:08:10.288540 868679 out.go:177] - MINIKUBE_HOME=/home/jenkins/minikube-integration/18644-814187/.minikube
I0415 12:08:10.290386 868679 out.go:177] - MINIKUBE_BIN=out/minikube-linux-amd64
I0415 12:08:10.291702 868679 out.go:177] - MINIKUBE_FORCE_SYSTEMD=
I0415 12:08:10.294123 868679 config.go:182] Loaded profile config "custom-flannel-707566": Driver=kvm2, ContainerRuntime=docker, KubernetesVersion=v1.29.3
I0415 12:08:10.294329 868679 config.go:182] Loaded profile config "enable-default-cni-707566": Driver=kvm2, ContainerRuntime=docker, KubernetesVersion=v1.29.3
I0415 12:08:10.294452 868679 config.go:182] Loaded profile config "false-707566": Driver=kvm2, ContainerRuntime=docker, KubernetesVersion=v1.29.3
I0415 12:08:10.294591 868679 driver.go:392] Setting default libvirt URI to qemu:///system
I0415 12:08:10.343625 868679 out.go:177] * Using the kvm2 driver based on user configuration
I0415 12:08:10.345165 868679 start.go:297] selected driver: kvm2
I0415 12:08:10.345192 868679 start.go:901] validating driver "kvm2" against <nil>
I0415 12:08:10.345210 868679 start.go:912] status for kvm2: {Installed:true Healthy:true Running:true NeedsImprovement:false Error:<nil> Reason: Fix: Doc: Version:}
I0415 12:08:10.346280 868679 install.go:52] acquiring lock: {Name:mk900956b073697a4aa6c80a27c6bb0742a99a53 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I0415 12:08:10.346447 868679 install.go:117] Validating docker-machine-driver-kvm2, PATH=/home/jenkins/minikube-integration/18644-814187/.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
I0415 12:08:10.368175 868679 install.go:137] /home/jenkins/workspace/KVM_Linux_integration/out/docker-machine-driver-kvm2 version is 1.33.0-beta.0
I0415 12:08:10.368279 868679 start_flags.go:310] no existing cluster config was found, will generate one from the flags
I0415 12:08:10.368646 868679 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]
I0415 12:08:10.368740 868679 cni.go:84] Creating CNI manager for "flannel"
I0415 12:08:10.368752 868679 start_flags.go:319] Found "Flannel" CNI - setting NetworkPlugin=cni
I0415 12:08:10.368855 868679 start.go:340] cluster config:
{Name:flannel-707566 KeepContext:false EmbedCerts:false MinikubeISO: KicBaseImage:gcr.io/k8s-minikube/kicbase-builds:v0.0.43-1712854342-18621@sha256:ed83a14d1540ae575c52399493a92b74b64f457445525b45c4b55f3ec4ca873f 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.29.3 ClusterName:flannel-707566 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:flannel} Nodes:[{Name: IP: Port:8443 KubernetesVersion:v1.29.3 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}
I0415 12:08:10.369016 868679 iso.go:125] acquiring lock: {Name:mk2c75515d13e4535df370ed95c816a84cfeedef Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I0415 12:08:10.371987 868679 out.go:177] * Starting "flannel-707566" primary control-plane node in "flannel-707566" cluster
I0415 12:08:10.373736 868679 preload.go:132] Checking if preload exists for k8s version v1.29.3 and runtime docker
I0415 12:08:10.373842 868679 preload.go:147] Found local preload: /home/jenkins/minikube-integration/18644-814187/.minikube/cache/preloaded-tarball/preloaded-images-k8s-v18-v1.29.3-docker-overlay2-amd64.tar.lz4
I0415 12:08:10.373863 868679 cache.go:56] Caching tarball of preloaded images
I0415 12:08:10.374015 868679 preload.go:173] Found /home/jenkins/minikube-integration/18644-814187/.minikube/cache/preloaded-tarball/preloaded-images-k8s-v18-v1.29.3-docker-overlay2-amd64.tar.lz4 in cache, skipping download
I0415 12:08:10.374031 868679 cache.go:59] Finished verifying existence of preloaded tar for v1.29.3 on docker
I0415 12:08:10.374233 868679 profile.go:143] Saving config to /home/jenkins/minikube-integration/18644-814187/.minikube/profiles/flannel-707566/config.json ...
I0415 12:08:10.374266 868679 lock.go:35] WriteFile acquiring /home/jenkins/minikube-integration/18644-814187/.minikube/profiles/flannel-707566/config.json: {Name:mkca302278a2cf321ae4fb327d15d8c014e4c69d Clock:{} Delay:500ms Timeout:1m0s Cancel:<nil>}
I0415 12:08:10.374512 868679 start.go:360] acquireMachinesLock for flannel-707566: {Name:mk71853bc574fc15bce6ced0bf098dad9ede73dc Clock:{} Delay:500ms Timeout:13m0s Cancel:<nil>}
I0415 12:08:34.613775 868679 start.go:364] duration metric: took 24.239231048s to acquireMachinesLock for "flannel-707566"
I0415 12:08:34.613878 868679 start.go:93] Provisioning new machine with config: &{Name:flannel-707566 KeepContext:false EmbedCerts:false MinikubeISO:https://storage.googleapis.com/minikube-builds/iso/18621/minikube-v1.33.0-1712854267-18621-amd64.iso KicBaseImage:gcr.io/k8s-minikube/kicbase-builds:v0.0.43-1712854342-18621@sha256:ed83a14d1540ae575c52399493a92b74b64f457445525b45c4b55f3ec4ca873f 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.29.3 ClusterName:flannel-707566 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:flannel} Nodes:[{Name: IP: Port:8443 KubernetesVersion:v1.29.3 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.29.3 ContainerRuntime:docker ControlPlane:true Worker:true}
I0415 12:08:34.614050 868679 start.go:125] createHost starting for "" (driver="kvm2")
I0415 12:08:34.616230 868679 out.go:204] * Creating kvm2 VM (CPUs=2, Memory=3072MB, Disk=20000MB) ...
I0415 12:08:34.616491 868679 main.go:141] libmachine: Found binary path at /home/jenkins/workspace/KVM_Linux_integration/out/docker-machine-driver-kvm2
I0415 12:08:34.616553 868679 main.go:141] libmachine: Launching plugin server for driver kvm2
I0415 12:08:34.638965 868679 main.go:141] libmachine: Plugin server listening at address 127.0.0.1:39467
I0415 12:08:34.639614 868679 main.go:141] libmachine: () Calling .GetVersion
I0415 12:08:34.640511 868679 main.go:141] libmachine: Using API Version 1
I0415 12:08:34.640544 868679 main.go:141] libmachine: () Calling .SetConfigRaw
I0415 12:08:34.641022 868679 main.go:141] libmachine: () Calling .GetMachineName
I0415 12:08:34.641315 868679 main.go:141] libmachine: (flannel-707566) Calling .GetMachineName
I0415 12:08:34.641658 868679 main.go:141] libmachine: (flannel-707566) Calling .DriverName
I0415 12:08:34.641903 868679 start.go:159] libmachine.API.Create for "flannel-707566" (driver="kvm2")
I0415 12:08:34.641947 868679 client.go:168] LocalClient.Create starting
I0415 12:08:34.641990 868679 main.go:141] libmachine: Reading certificate data from /home/jenkins/minikube-integration/18644-814187/.minikube/certs/ca.pem
I0415 12:08:34.642047 868679 main.go:141] libmachine: Decoding PEM data...
I0415 12:08:34.642068 868679 main.go:141] libmachine: Parsing certificate...
I0415 12:08:34.642135 868679 main.go:141] libmachine: Reading certificate data from /home/jenkins/minikube-integration/18644-814187/.minikube/certs/cert.pem
I0415 12:08:34.642155 868679 main.go:141] libmachine: Decoding PEM data...
I0415 12:08:34.642163 868679 main.go:141] libmachine: Parsing certificate...
I0415 12:08:34.642182 868679 main.go:141] libmachine: Running pre-create checks...
I0415 12:08:34.642192 868679 main.go:141] libmachine: (flannel-707566) Calling .PreCreateCheck
I0415 12:08:34.643367 868679 main.go:141] libmachine: (flannel-707566) Calling .GetConfigRaw
I0415 12:08:34.644078 868679 main.go:141] libmachine: Creating machine...
I0415 12:08:34.644094 868679 main.go:141] libmachine: (flannel-707566) Calling .Create
I0415 12:08:34.644519 868679 main.go:141] libmachine: (flannel-707566) Creating KVM machine...
I0415 12:08:34.645944 868679 main.go:141] libmachine: (flannel-707566) DBG | found existing default KVM network
I0415 12:08:34.648875 868679 main.go:141] libmachine: (flannel-707566) DBG | I0415 12:08:34.648296 869902 network.go:206] 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:0xc000015aa0}
I0415 12:08:34.648903 868679 main.go:141] libmachine: (flannel-707566) DBG | created network xml:
I0415 12:08:34.648914 868679 main.go:141] libmachine: (flannel-707566) DBG | <network>
I0415 12:08:34.648921 868679 main.go:141] libmachine: (flannel-707566) DBG | <name>mk-flannel-707566</name>
I0415 12:08:34.648931 868679 main.go:141] libmachine: (flannel-707566) DBG | <dns enable='no'/>
I0415 12:08:34.648939 868679 main.go:141] libmachine: (flannel-707566) DBG |
I0415 12:08:34.648949 868679 main.go:141] libmachine: (flannel-707566) DBG | <ip address='192.168.39.1' netmask='255.255.255.0'>
I0415 12:08:34.648958 868679 main.go:141] libmachine: (flannel-707566) DBG | <dhcp>
I0415 12:08:34.648968 868679 main.go:141] libmachine: (flannel-707566) DBG | <range start='192.168.39.2' end='192.168.39.253'/>
I0415 12:08:34.648975 868679 main.go:141] libmachine: (flannel-707566) DBG | </dhcp>
I0415 12:08:34.648985 868679 main.go:141] libmachine: (flannel-707566) DBG | </ip>
I0415 12:08:34.648991 868679 main.go:141] libmachine: (flannel-707566) DBG |
I0415 12:08:34.648998 868679 main.go:141] libmachine: (flannel-707566) DBG | </network>
I0415 12:08:34.649002 868679 main.go:141] libmachine: (flannel-707566) DBG |
I0415 12:08:34.656178 868679 main.go:141] libmachine: (flannel-707566) DBG | trying to create private KVM network mk-flannel-707566 192.168.39.0/24...
I0415 12:08:34.777283 868679 main.go:141] libmachine: (flannel-707566) Setting up store path in /home/jenkins/minikube-integration/18644-814187/.minikube/machines/flannel-707566 ...
I0415 12:08:34.777329 868679 main.go:141] libmachine: (flannel-707566) Building disk image from file:///home/jenkins/minikube-integration/18644-814187/.minikube/cache/iso/amd64/minikube-v1.33.0-1712854267-18621-amd64.iso
I0415 12:08:34.777344 868679 main.go:141] libmachine: (flannel-707566) DBG | private KVM network mk-flannel-707566 192.168.39.0/24 created
I0415 12:08:34.777363 868679 main.go:141] libmachine: (flannel-707566) DBG | I0415 12:08:34.777256 869902 common.go:145] Making disk image using store path: /home/jenkins/minikube-integration/18644-814187/.minikube
I0415 12:08:34.777387 868679 main.go:141] libmachine: (flannel-707566) Downloading /home/jenkins/minikube-integration/18644-814187/.minikube/cache/boot2docker.iso from file:///home/jenkins/minikube-integration/18644-814187/.minikube/cache/iso/amd64/minikube-v1.33.0-1712854267-18621-amd64.iso...
I0415 12:08:35.102455 868679 main.go:141] libmachine: (flannel-707566) DBG | I0415 12:08:35.100321 869902 common.go:152] Creating ssh key: /home/jenkins/minikube-integration/18644-814187/.minikube/machines/flannel-707566/id_rsa...
I0415 12:08:35.218018 868679 main.go:141] libmachine: (flannel-707566) DBG | I0415 12:08:35.217840 869902 common.go:158] Creating raw disk image: /home/jenkins/minikube-integration/18644-814187/.minikube/machines/flannel-707566/flannel-707566.rawdisk...
I0415 12:08:35.218059 868679 main.go:141] libmachine: (flannel-707566) DBG | Writing magic tar header
I0415 12:08:35.218080 868679 main.go:141] libmachine: (flannel-707566) DBG | Writing SSH key tar header
I0415 12:08:35.218099 868679 main.go:141] libmachine: (flannel-707566) DBG | I0415 12:08:35.217965 869902 common.go:172] Fixing permissions on /home/jenkins/minikube-integration/18644-814187/.minikube/machines/flannel-707566 ...
I0415 12:08:35.218116 868679 main.go:141] libmachine: (flannel-707566) DBG | Checking permissions on dir: /home/jenkins/minikube-integration/18644-814187/.minikube/machines/flannel-707566
I0415 12:08:35.218189 868679 main.go:141] libmachine: (flannel-707566) Setting executable bit set on /home/jenkins/minikube-integration/18644-814187/.minikube/machines/flannel-707566 (perms=drwx------)
I0415 12:08:35.218220 868679 main.go:141] libmachine: (flannel-707566) Setting executable bit set on /home/jenkins/minikube-integration/18644-814187/.minikube/machines (perms=drwxr-xr-x)
I0415 12:08:35.218237 868679 main.go:141] libmachine: (flannel-707566) DBG | Checking permissions on dir: /home/jenkins/minikube-integration/18644-814187/.minikube/machines
I0415 12:08:35.218254 868679 main.go:141] libmachine: (flannel-707566) Setting executable bit set on /home/jenkins/minikube-integration/18644-814187/.minikube (perms=drwxr-xr-x)
I0415 12:08:35.218269 868679 main.go:141] libmachine: (flannel-707566) DBG | Checking permissions on dir: /home/jenkins/minikube-integration/18644-814187/.minikube
I0415 12:08:35.218284 868679 main.go:141] libmachine: (flannel-707566) DBG | Checking permissions on dir: /home/jenkins/minikube-integration/18644-814187
I0415 12:08:35.218321 868679 main.go:141] libmachine: (flannel-707566) DBG | Checking permissions on dir: /home/jenkins/minikube-integration
I0415 12:08:35.218334 868679 main.go:141] libmachine: (flannel-707566) DBG | Checking permissions on dir: /home/jenkins
I0415 12:08:35.218371 868679 main.go:141] libmachine: (flannel-707566) DBG | Checking permissions on dir: /home
I0415 12:08:35.218385 868679 main.go:141] libmachine: (flannel-707566) Setting executable bit set on /home/jenkins/minikube-integration/18644-814187 (perms=drwxrwxr-x)
I0415 12:08:35.218395 868679 main.go:141] libmachine: (flannel-707566) DBG | Skipping /home - not owner
I0415 12:08:35.218410 868679 main.go:141] libmachine: (flannel-707566) Setting executable bit set on /home/jenkins/minikube-integration (perms=drwxrwxr-x)
I0415 12:08:35.218432 868679 main.go:141] libmachine: (flannel-707566) Setting executable bit set on /home/jenkins (perms=drwxr-xr-x)
I0415 12:08:35.218444 868679 main.go:141] libmachine: (flannel-707566) Creating domain...
I0415 12:08:35.219810 868679 main.go:141] libmachine: (flannel-707566) define libvirt domain using xml:
I0415 12:08:35.219852 868679 main.go:141] libmachine: (flannel-707566) <domain type='kvm'>
I0415 12:08:35.219864 868679 main.go:141] libmachine: (flannel-707566) <name>flannel-707566</name>
I0415 12:08:35.219881 868679 main.go:141] libmachine: (flannel-707566) <memory unit='MiB'>3072</memory>
I0415 12:08:35.219894 868679 main.go:141] libmachine: (flannel-707566) <vcpu>2</vcpu>
I0415 12:08:35.219905 868679 main.go:141] libmachine: (flannel-707566) <features>
I0415 12:08:35.219913 868679 main.go:141] libmachine: (flannel-707566) <acpi/>
I0415 12:08:35.219931 868679 main.go:141] libmachine: (flannel-707566) <apic/>
I0415 12:08:35.219943 868679 main.go:141] libmachine: (flannel-707566) <pae/>
I0415 12:08:35.219960 868679 main.go:141] libmachine: (flannel-707566)
I0415 12:08:35.219996 868679 main.go:141] libmachine: (flannel-707566) </features>
I0415 12:08:35.220042 868679 main.go:141] libmachine: (flannel-707566) <cpu mode='host-passthrough'>
I0415 12:08:35.220056 868679 main.go:141] libmachine: (flannel-707566)
I0415 12:08:35.220066 868679 main.go:141] libmachine: (flannel-707566) </cpu>
I0415 12:08:35.220079 868679 main.go:141] libmachine: (flannel-707566) <os>
I0415 12:08:35.220089 868679 main.go:141] libmachine: (flannel-707566) <type>hvm</type>
I0415 12:08:35.220098 868679 main.go:141] libmachine: (flannel-707566) <boot dev='cdrom'/>
I0415 12:08:35.220108 868679 main.go:141] libmachine: (flannel-707566) <boot dev='hd'/>
I0415 12:08:35.220117 868679 main.go:141] libmachine: (flannel-707566) <bootmenu enable='no'/>
I0415 12:08:35.220128 868679 main.go:141] libmachine: (flannel-707566) </os>
I0415 12:08:35.220136 868679 main.go:141] libmachine: (flannel-707566) <devices>
I0415 12:08:35.220147 868679 main.go:141] libmachine: (flannel-707566) <disk type='file' device='cdrom'>
I0415 12:08:35.220168 868679 main.go:141] libmachine: (flannel-707566) <source file='/home/jenkins/minikube-integration/18644-814187/.minikube/machines/flannel-707566/boot2docker.iso'/>
I0415 12:08:35.220179 868679 main.go:141] libmachine: (flannel-707566) <target dev='hdc' bus='scsi'/>
I0415 12:08:35.220188 868679 main.go:141] libmachine: (flannel-707566) <readonly/>
I0415 12:08:35.220199 868679 main.go:141] libmachine: (flannel-707566) </disk>
I0415 12:08:35.220209 868679 main.go:141] libmachine: (flannel-707566) <disk type='file' device='disk'>
I0415 12:08:35.220219 868679 main.go:141] libmachine: (flannel-707566) <driver name='qemu' type='raw' cache='default' io='threads' />
I0415 12:08:35.220235 868679 main.go:141] libmachine: (flannel-707566) <source file='/home/jenkins/minikube-integration/18644-814187/.minikube/machines/flannel-707566/flannel-707566.rawdisk'/>
I0415 12:08:35.220245 868679 main.go:141] libmachine: (flannel-707566) <target dev='hda' bus='virtio'/>
I0415 12:08:35.220256 868679 main.go:141] libmachine: (flannel-707566) </disk>
I0415 12:08:35.220271 868679 main.go:141] libmachine: (flannel-707566) <interface type='network'>
I0415 12:08:35.220285 868679 main.go:141] libmachine: (flannel-707566) <source network='mk-flannel-707566'/>
I0415 12:08:35.220296 868679 main.go:141] libmachine: (flannel-707566) <model type='virtio'/>
I0415 12:08:35.220306 868679 main.go:141] libmachine: (flannel-707566) </interface>
I0415 12:08:35.220315 868679 main.go:141] libmachine: (flannel-707566) <interface type='network'>
I0415 12:08:35.220327 868679 main.go:141] libmachine: (flannel-707566) <source network='default'/>
I0415 12:08:35.220343 868679 main.go:141] libmachine: (flannel-707566) <model type='virtio'/>
I0415 12:08:35.220359 868679 main.go:141] libmachine: (flannel-707566) </interface>
I0415 12:08:35.220370 868679 main.go:141] libmachine: (flannel-707566) <serial type='pty'>
I0415 12:08:35.220380 868679 main.go:141] libmachine: (flannel-707566) <target port='0'/>
I0415 12:08:35.220391 868679 main.go:141] libmachine: (flannel-707566) </serial>
I0415 12:08:35.220408 868679 main.go:141] libmachine: (flannel-707566) <console type='pty'>
I0415 12:08:35.220422 868679 main.go:141] libmachine: (flannel-707566) <target type='serial' port='0'/>
I0415 12:08:35.220434 868679 main.go:141] libmachine: (flannel-707566) </console>
I0415 12:08:35.220445 868679 main.go:141] libmachine: (flannel-707566) <rng model='virtio'>
I0415 12:08:35.220455 868679 main.go:141] libmachine: (flannel-707566) <backend model='random'>/dev/random</backend>
I0415 12:08:35.220474 868679 main.go:141] libmachine: (flannel-707566) </rng>
I0415 12:08:35.220485 868679 main.go:141] libmachine: (flannel-707566)
I0415 12:08:35.220493 868679 main.go:141] libmachine: (flannel-707566)
I0415 12:08:35.220505 868679 main.go:141] libmachine: (flannel-707566) </devices>
I0415 12:08:35.220515 868679 main.go:141] libmachine: (flannel-707566) </domain>
I0415 12:08:35.220526 868679 main.go:141] libmachine: (flannel-707566)
I0415 12:08:35.225713 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined MAC address 52:54:00:69:bd:f1 in network default
I0415 12:08:35.226319 868679 main.go:141] libmachine: (flannel-707566) Ensuring networks are active...
I0415 12:08:35.226365 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:08:35.227080 868679 main.go:141] libmachine: (flannel-707566) Ensuring network default is active
I0415 12:08:35.227387 868679 main.go:141] libmachine: (flannel-707566) Ensuring network mk-flannel-707566 is active
I0415 12:08:35.228128 868679 main.go:141] libmachine: (flannel-707566) Getting domain xml...
I0415 12:08:35.229058 868679 main.go:141] libmachine: (flannel-707566) Creating domain...
I0415 12:08:36.878829 868679 main.go:141] libmachine: (flannel-707566) Waiting to get IP...
I0415 12:08:36.879711 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:08:36.880241 868679 main.go:141] libmachine: (flannel-707566) DBG | unable to find current IP address of domain flannel-707566 in network mk-flannel-707566
I0415 12:08:36.880288 868679 main.go:141] libmachine: (flannel-707566) DBG | I0415 12:08:36.880241 869902 retry.go:31] will retry after 220.096332ms: waiting for machine to come up
I0415 12:08:37.101906 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:08:37.102608 868679 main.go:141] libmachine: (flannel-707566) DBG | unable to find current IP address of domain flannel-707566 in network mk-flannel-707566
I0415 12:08:37.102639 868679 main.go:141] libmachine: (flannel-707566) DBG | I0415 12:08:37.102555 869902 retry.go:31] will retry after 271.53968ms: waiting for machine to come up
I0415 12:08:37.376265 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:08:37.376924 868679 main.go:141] libmachine: (flannel-707566) DBG | unable to find current IP address of domain flannel-707566 in network mk-flannel-707566
I0415 12:08:37.376969 868679 main.go:141] libmachine: (flannel-707566) DBG | I0415 12:08:37.376860 869902 retry.go:31] will retry after 486.480067ms: waiting for machine to come up
I0415 12:08:38.400809 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:08:38.401404 868679 main.go:141] libmachine: (flannel-707566) DBG | unable to find current IP address of domain flannel-707566 in network mk-flannel-707566
I0415 12:08:38.401433 868679 main.go:141] libmachine: (flannel-707566) DBG | I0415 12:08:38.401377 869902 retry.go:31] will retry after 537.691656ms: waiting for machine to come up
I0415 12:08:38.941637 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:08:38.942386 868679 main.go:141] libmachine: (flannel-707566) DBG | unable to find current IP address of domain flannel-707566 in network mk-flannel-707566
I0415 12:08:38.942416 868679 main.go:141] libmachine: (flannel-707566) DBG | I0415 12:08:38.942347 869902 retry.go:31] will retry after 515.212613ms: waiting for machine to come up
I0415 12:08:39.459034 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:08:39.459971 868679 main.go:141] libmachine: (flannel-707566) DBG | unable to find current IP address of domain flannel-707566 in network mk-flannel-707566
I0415 12:08:39.460000 868679 main.go:141] libmachine: (flannel-707566) DBG | I0415 12:08:39.459871 869902 retry.go:31] will retry after 802.551456ms: waiting for machine to come up
I0415 12:08:40.265454 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:08:40.267023 868679 main.go:141] libmachine: (flannel-707566) DBG | unable to find current IP address of domain flannel-707566 in network mk-flannel-707566
I0415 12:08:40.267091 868679 main.go:141] libmachine: (flannel-707566) DBG | I0415 12:08:40.266965 869902 retry.go:31] will retry after 774.693781ms: waiting for machine to come up
I0415 12:08:41.043417 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:08:41.044176 868679 main.go:141] libmachine: (flannel-707566) DBG | unable to find current IP address of domain flannel-707566 in network mk-flannel-707566
I0415 12:08:41.044215 868679 main.go:141] libmachine: (flannel-707566) DBG | I0415 12:08:41.044062 869902 retry.go:31] will retry after 1.06239475s: waiting for machine to come up
I0415 12:08:42.108863 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:08:42.109645 868679 main.go:141] libmachine: (flannel-707566) DBG | unable to find current IP address of domain flannel-707566 in network mk-flannel-707566
I0415 12:08:42.109689 868679 main.go:141] libmachine: (flannel-707566) DBG | I0415 12:08:42.109538 869902 retry.go:31] will retry after 1.568090853s: waiting for machine to come up
I0415 12:08:43.679699 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:08:43.680480 868679 main.go:141] libmachine: (flannel-707566) DBG | unable to find current IP address of domain flannel-707566 in network mk-flannel-707566
I0415 12:08:43.680514 868679 main.go:141] libmachine: (flannel-707566) DBG | I0415 12:08:43.680434 869902 retry.go:31] will retry after 1.416308452s: waiting for machine to come up
I0415 12:08:45.099052 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:08:45.099632 868679 main.go:141] libmachine: (flannel-707566) DBG | unable to find current IP address of domain flannel-707566 in network mk-flannel-707566
I0415 12:08:45.099662 868679 main.go:141] libmachine: (flannel-707566) DBG | I0415 12:08:45.099587 869902 retry.go:31] will retry after 1.909216562s: waiting for machine to come up
I0415 12:08:47.011940 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:08:47.012627 868679 main.go:141] libmachine: (flannel-707566) DBG | unable to find current IP address of domain flannel-707566 in network mk-flannel-707566
I0415 12:08:47.012666 868679 main.go:141] libmachine: (flannel-707566) DBG | I0415 12:08:47.012557 869902 retry.go:31] will retry after 2.622096976s: waiting for machine to come up
I0415 12:08:49.638831 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:08:49.639601 868679 main.go:141] libmachine: (flannel-707566) DBG | unable to find current IP address of domain flannel-707566 in network mk-flannel-707566
I0415 12:08:49.639632 868679 main.go:141] libmachine: (flannel-707566) DBG | I0415 12:08:49.639539 869902 retry.go:31] will retry after 3.020418049s: waiting for machine to come up
I0415 12:08:52.661616 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:08:52.662251 868679 main.go:141] libmachine: (flannel-707566) DBG | unable to find current IP address of domain flannel-707566 in network mk-flannel-707566
I0415 12:08:52.662281 868679 main.go:141] libmachine: (flannel-707566) DBG | I0415 12:08:52.662206 869902 retry.go:31] will retry after 5.277300269s: waiting for machine to come up
I0415 12:08:57.942734 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:08:57.943386 868679 main.go:141] libmachine: (flannel-707566) DBG | unable to find current IP address of domain flannel-707566 in network mk-flannel-707566
I0415 12:08:57.943432 868679 main.go:141] libmachine: (flannel-707566) DBG | I0415 12:08:57.943330 869902 retry.go:31] will retry after 6.480499722s: waiting for machine to come up
I0415 12:09:04.427465 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:09:04.428256 868679 main.go:141] libmachine: (flannel-707566) Found IP for machine: 192.168.39.45
I0415 12:09:04.428282 868679 main.go:141] libmachine: (flannel-707566) Reserving static IP address...
I0415 12:09:04.428297 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has current primary IP address 192.168.39.45 and MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:09:04.428901 868679 main.go:141] libmachine: (flannel-707566) DBG | unable to find host DHCP lease matching {name: "flannel-707566", mac: "52:54:00:dd:d5:1d", ip: "192.168.39.45"} in network mk-flannel-707566
I0415 12:09:04.549225 868679 main.go:141] libmachine: (flannel-707566) Reserved static IP address: 192.168.39.45
I0415 12:09:04.549273 868679 main.go:141] libmachine: (flannel-707566) DBG | Getting to WaitForSSH function...
I0415 12:09:04.549297 868679 main.go:141] libmachine: (flannel-707566) Waiting for SSH to be available...
I0415 12:09:04.552532 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:09:04.552995 868679 main.go:141] libmachine: (flannel-707566) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:dd:d5:1d", ip: ""} in network mk-flannel-707566: {Iface:virbr3 ExpiryTime:2024-04-15 13:08:53 +0000 UTC Type:0 Mac:52:54:00:dd:d5:1d Iaid: IPaddr:192.168.39.45 Prefix:24 Hostname:minikube Clientid:01:52:54:00:dd:d5:1d}
I0415 12:09:04.553029 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined IP address 192.168.39.45 and MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:09:04.553193 868679 main.go:141] libmachine: (flannel-707566) DBG | Using SSH client type: external
I0415 12:09:04.553228 868679 main.go:141] libmachine: (flannel-707566) DBG | Using SSH private key: /home/jenkins/minikube-integration/18644-814187/.minikube/machines/flannel-707566/id_rsa (-rw-------)
I0415 12:09:04.553271 868679 main.go:141] libmachine: (flannel-707566) 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.45 -o IdentitiesOnly=yes -i /home/jenkins/minikube-integration/18644-814187/.minikube/machines/flannel-707566/id_rsa -p 22] /usr/bin/ssh <nil>}
I0415 12:09:04.553288 868679 main.go:141] libmachine: (flannel-707566) DBG | About to run SSH command:
I0415 12:09:04.553304 868679 main.go:141] libmachine: (flannel-707566) DBG | exit 0
I0415 12:09:04.684363 868679 main.go:141] libmachine: (flannel-707566) DBG | SSH cmd err, output: <nil>:
I0415 12:09:04.684686 868679 main.go:141] libmachine: (flannel-707566) KVM machine creation complete!
I0415 12:09:04.685154 868679 main.go:141] libmachine: (flannel-707566) Calling .GetConfigRaw
I0415 12:09:04.685925 868679 main.go:141] libmachine: (flannel-707566) Calling .DriverName
I0415 12:09:04.686197 868679 main.go:141] libmachine: (flannel-707566) Calling .DriverName
I0415 12:09:04.686428 868679 main.go:141] libmachine: Waiting for machine to be running, this may take a few minutes...
I0415 12:09:04.686446 868679 main.go:141] libmachine: (flannel-707566) Calling .GetState
I0415 12:09:04.688171 868679 main.go:141] libmachine: Detecting operating system of created instance...
I0415 12:09:04.688197 868679 main.go:141] libmachine: Waiting for SSH to be available...
I0415 12:09:04.688206 868679 main.go:141] libmachine: Getting to WaitForSSH function...
I0415 12:09:04.688216 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHHostname
I0415 12:09:04.691504 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:09:04.691977 868679 main.go:141] libmachine: (flannel-707566) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:dd:d5:1d", ip: ""} in network mk-flannel-707566: {Iface:virbr3 ExpiryTime:2024-04-15 13:08:53 +0000 UTC Type:0 Mac:52:54:00:dd:d5:1d Iaid: IPaddr:192.168.39.45 Prefix:24 Hostname:flannel-707566 Clientid:01:52:54:00:dd:d5:1d}
I0415 12:09:04.692012 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined IP address 192.168.39.45 and MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:09:04.692179 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHPort
I0415 12:09:04.692416 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHKeyPath
I0415 12:09:04.692619 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHKeyPath
I0415 12:09:04.692806 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHUsername
I0415 12:09:04.693002 868679 main.go:141] libmachine: Using SSH client type: native
I0415 12:09:04.693233 868679 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x82d4e0] 0x830240 <nil> [] 0s} 192.168.39.45 22 <nil> <nil>}
I0415 12:09:04.693251 868679 main.go:141] libmachine: About to run SSH command:
exit 0
I0415 12:09:04.819160 868679 main.go:141] libmachine: SSH cmd err, output: <nil>:
I0415 12:09:04.819205 868679 main.go:141] libmachine: Detecting the provisioner...
I0415 12:09:04.819218 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHHostname
I0415 12:09:04.822886 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:09:04.823422 868679 main.go:141] libmachine: (flannel-707566) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:dd:d5:1d", ip: ""} in network mk-flannel-707566: {Iface:virbr3 ExpiryTime:2024-04-15 13:08:53 +0000 UTC Type:0 Mac:52:54:00:dd:d5:1d Iaid: IPaddr:192.168.39.45 Prefix:24 Hostname:flannel-707566 Clientid:01:52:54:00:dd:d5:1d}
I0415 12:09:04.823495 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined IP address 192.168.39.45 and MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:09:04.823749 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHPort
I0415 12:09:04.824090 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHKeyPath
I0415 12:09:04.824301 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHKeyPath
I0415 12:09:04.824511 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHUsername
I0415 12:09:04.824698 868679 main.go:141] libmachine: Using SSH client type: native
I0415 12:09:04.824964 868679 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x82d4e0] 0x830240 <nil> [] 0s} 192.168.39.45 22 <nil> <nil>}
I0415 12:09:04.824982 868679 main.go:141] libmachine: About to run SSH command:
cat /etc/os-release
I0415 12:09:04.940536 868679 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"
I0415 12:09:04.940670 868679 main.go:141] libmachine: found compatible host: buildroot
I0415 12:09:04.940691 868679 main.go:141] libmachine: Provisioning with buildroot...
I0415 12:09:04.940704 868679 main.go:141] libmachine: (flannel-707566) Calling .GetMachineName
I0415 12:09:04.941045 868679 buildroot.go:166] provisioning hostname "flannel-707566"
I0415 12:09:04.941090 868679 main.go:141] libmachine: (flannel-707566) Calling .GetMachineName
I0415 12:09:04.941337 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHHostname
I0415 12:09:04.944483 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:09:04.944959 868679 main.go:141] libmachine: (flannel-707566) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:dd:d5:1d", ip: ""} in network mk-flannel-707566: {Iface:virbr3 ExpiryTime:2024-04-15 13:08:53 +0000 UTC Type:0 Mac:52:54:00:dd:d5:1d Iaid: IPaddr:192.168.39.45 Prefix:24 Hostname:flannel-707566 Clientid:01:52:54:00:dd:d5:1d}
I0415 12:09:04.945004 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined IP address 192.168.39.45 and MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:09:04.945191 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHPort
I0415 12:09:04.945424 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHKeyPath
I0415 12:09:04.945639 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHKeyPath
I0415 12:09:04.945820 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHUsername
I0415 12:09:04.946018 868679 main.go:141] libmachine: Using SSH client type: native
I0415 12:09:04.946219 868679 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x82d4e0] 0x830240 <nil> [] 0s} 192.168.39.45 22 <nil> <nil>}
I0415 12:09:04.946238 868679 main.go:141] libmachine: About to run SSH command:
sudo hostname flannel-707566 && echo "flannel-707566" | sudo tee /etc/hostname
I0415 12:09:05.080972 868679 main.go:141] libmachine: SSH cmd err, output: <nil>: flannel-707566
I0415 12:09:05.081020 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHHostname
I0415 12:09:05.084225 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:09:05.084654 868679 main.go:141] libmachine: (flannel-707566) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:dd:d5:1d", ip: ""} in network mk-flannel-707566: {Iface:virbr3 ExpiryTime:2024-04-15 13:08:53 +0000 UTC Type:0 Mac:52:54:00:dd:d5:1d Iaid: IPaddr:192.168.39.45 Prefix:24 Hostname:flannel-707566 Clientid:01:52:54:00:dd:d5:1d}
I0415 12:09:05.084711 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined IP address 192.168.39.45 and MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:09:05.085002 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHPort
I0415 12:09:05.085297 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHKeyPath
I0415 12:09:05.085544 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHKeyPath
I0415 12:09:05.085716 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHUsername
I0415 12:09:05.085959 868679 main.go:141] libmachine: Using SSH client type: native
I0415 12:09:05.086228 868679 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x82d4e0] 0x830240 <nil> [] 0s} 192.168.39.45 22 <nil> <nil>}
I0415 12:09:05.086257 868679 main.go:141] libmachine: About to run SSH command:
if ! grep -xq '.*\sflannel-707566' /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 flannel-707566/g' /etc/hosts;
else
echo '127.0.1.1 flannel-707566' | sudo tee -a /etc/hosts;
fi
fi
I0415 12:09:05.215347 868679 main.go:141] libmachine: SSH cmd err, output: <nil>:
I0415 12:09:05.215392 868679 buildroot.go:172] set auth options {CertDir:/home/jenkins/minikube-integration/18644-814187/.minikube CaCertPath:/home/jenkins/minikube-integration/18644-814187/.minikube/certs/ca.pem CaPrivateKeyPath:/home/jenkins/minikube-integration/18644-814187/.minikube/certs/ca-key.pem CaCertRemotePath:/etc/docker/ca.pem ServerCertPath:/home/jenkins/minikube-integration/18644-814187/.minikube/machines/server.pem ServerKeyPath:/home/jenkins/minikube-integration/18644-814187/.minikube/machines/server-key.pem ClientKeyPath:/home/jenkins/minikube-integration/18644-814187/.minikube/certs/key.pem ServerCertRemotePath:/etc/docker/server.pem ServerKeyRemotePath:/etc/docker/server-key.pem ClientCertPath:/home/jenkins/minikube-integration/18644-814187/.minikube/certs/cert.pem ServerCertSANs:[] StorePath:/home/jenkins/minikube-integration/18644-814187/.minikube}
I0415 12:09:05.215452 868679 buildroot.go:174] setting up certificates
I0415 12:09:05.215481 868679 provision.go:84] configureAuth start
I0415 12:09:05.215500 868679 main.go:141] libmachine: (flannel-707566) Calling .GetMachineName
I0415 12:09:05.215916 868679 main.go:141] libmachine: (flannel-707566) Calling .GetIP
I0415 12:09:05.219211 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:09:05.219638 868679 main.go:141] libmachine: (flannel-707566) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:dd:d5:1d", ip: ""} in network mk-flannel-707566: {Iface:virbr3 ExpiryTime:2024-04-15 13:08:53 +0000 UTC Type:0 Mac:52:54:00:dd:d5:1d Iaid: IPaddr:192.168.39.45 Prefix:24 Hostname:flannel-707566 Clientid:01:52:54:00:dd:d5:1d}
I0415 12:09:05.219676 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined IP address 192.168.39.45 and MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:09:05.219977 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHHostname
I0415 12:09:05.223032 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:09:05.223416 868679 main.go:141] libmachine: (flannel-707566) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:dd:d5:1d", ip: ""} in network mk-flannel-707566: {Iface:virbr3 ExpiryTime:2024-04-15 13:08:53 +0000 UTC Type:0 Mac:52:54:00:dd:d5:1d Iaid: IPaddr:192.168.39.45 Prefix:24 Hostname:flannel-707566 Clientid:01:52:54:00:dd:d5:1d}
I0415 12:09:05.223471 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined IP address 192.168.39.45 and MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:09:05.223633 868679 provision.go:143] copyHostCerts
I0415 12:09:05.223732 868679 exec_runner.go:144] found /home/jenkins/minikube-integration/18644-814187/.minikube/key.pem, removing ...
I0415 12:09:05.223759 868679 exec_runner.go:203] rm: /home/jenkins/minikube-integration/18644-814187/.minikube/key.pem
I0415 12:09:05.223857 868679 exec_runner.go:151] cp: /home/jenkins/minikube-integration/18644-814187/.minikube/certs/key.pem --> /home/jenkins/minikube-integration/18644-814187/.minikube/key.pem (1679 bytes)
I0415 12:09:05.224017 868679 exec_runner.go:144] found /home/jenkins/minikube-integration/18644-814187/.minikube/ca.pem, removing ...
I0415 12:09:05.224027 868679 exec_runner.go:203] rm: /home/jenkins/minikube-integration/18644-814187/.minikube/ca.pem
I0415 12:09:05.224065 868679 exec_runner.go:151] cp: /home/jenkins/minikube-integration/18644-814187/.minikube/certs/ca.pem --> /home/jenkins/minikube-integration/18644-814187/.minikube/ca.pem (1082 bytes)
I0415 12:09:05.224173 868679 exec_runner.go:144] found /home/jenkins/minikube-integration/18644-814187/.minikube/cert.pem, removing ...
I0415 12:09:05.224181 868679 exec_runner.go:203] rm: /home/jenkins/minikube-integration/18644-814187/.minikube/cert.pem
I0415 12:09:05.224215 868679 exec_runner.go:151] cp: /home/jenkins/minikube-integration/18644-814187/.minikube/certs/cert.pem --> /home/jenkins/minikube-integration/18644-814187/.minikube/cert.pem (1123 bytes)
I0415 12:09:05.224484 868679 provision.go:117] generating server cert: /home/jenkins/minikube-integration/18644-814187/.minikube/machines/server.pem ca-key=/home/jenkins/minikube-integration/18644-814187/.minikube/certs/ca.pem private-key=/home/jenkins/minikube-integration/18644-814187/.minikube/certs/ca-key.pem org=jenkins.flannel-707566 san=[127.0.0.1 192.168.39.45 flannel-707566 localhost minikube]
I0415 12:09:05.398827 868679 provision.go:177] copyRemoteCerts
I0415 12:09:05.398891 868679 ssh_runner.go:195] Run: sudo mkdir -p /etc/docker /etc/docker /etc/docker
I0415 12:09:05.398925 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHHostname
I0415 12:09:05.401970 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:09:05.402438 868679 main.go:141] libmachine: (flannel-707566) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:dd:d5:1d", ip: ""} in network mk-flannel-707566: {Iface:virbr3 ExpiryTime:2024-04-15 13:08:53 +0000 UTC Type:0 Mac:52:54:00:dd:d5:1d Iaid: IPaddr:192.168.39.45 Prefix:24 Hostname:flannel-707566 Clientid:01:52:54:00:dd:d5:1d}
I0415 12:09:05.402474 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined IP address 192.168.39.45 and MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:09:05.402729 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHPort
I0415 12:09:05.402968 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHKeyPath
I0415 12:09:05.403162 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHUsername
I0415 12:09:05.403362 868679 sshutil.go:53] new ssh client: &{IP:192.168.39.45 Port:22 SSHKeyPath:/home/jenkins/minikube-integration/18644-814187/.minikube/machines/flannel-707566/id_rsa Username:docker}
I0415 12:09:05.493685 868679 ssh_runner.go:362] scp /home/jenkins/minikube-integration/18644-814187/.minikube/machines/server.pem --> /etc/docker/server.pem (1212 bytes)
I0415 12:09:05.527085 868679 ssh_runner.go:362] scp /home/jenkins/minikube-integration/18644-814187/.minikube/machines/server-key.pem --> /etc/docker/server-key.pem (1679 bytes)
I0415 12:09:05.563863 868679 ssh_runner.go:362] scp /home/jenkins/minikube-integration/18644-814187/.minikube/certs/ca.pem --> /etc/docker/ca.pem (1082 bytes)
I0415 12:09:05.596951 868679 provision.go:87] duration metric: took 381.426447ms to configureAuth
I0415 12:09:05.596989 868679 buildroot.go:189] setting minikube options for container-runtime
I0415 12:09:05.597225 868679 config.go:182] Loaded profile config "flannel-707566": Driver=kvm2, ContainerRuntime=docker, KubernetesVersion=v1.29.3
I0415 12:09:05.597266 868679 main.go:141] libmachine: (flannel-707566) Calling .DriverName
I0415 12:09:05.597620 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHHostname
I0415 12:09:05.601076 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:09:05.601580 868679 main.go:141] libmachine: (flannel-707566) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:dd:d5:1d", ip: ""} in network mk-flannel-707566: {Iface:virbr3 ExpiryTime:2024-04-15 13:08:53 +0000 UTC Type:0 Mac:52:54:00:dd:d5:1d Iaid: IPaddr:192.168.39.45 Prefix:24 Hostname:flannel-707566 Clientid:01:52:54:00:dd:d5:1d}
I0415 12:09:05.601616 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined IP address 192.168.39.45 and MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:09:05.601845 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHPort
I0415 12:09:05.602161 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHKeyPath
I0415 12:09:05.602446 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHKeyPath
I0415 12:09:05.602630 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHUsername
I0415 12:09:05.602870 868679 main.go:141] libmachine: Using SSH client type: native
I0415 12:09:05.603214 868679 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x82d4e0] 0x830240 <nil> [] 0s} 192.168.39.45 22 <nil> <nil>}
I0415 12:09:05.603241 868679 main.go:141] libmachine: About to run SSH command:
df --output=fstype / | tail -n 1
I0415 12:09:05.726039 868679 main.go:141] libmachine: SSH cmd err, output: <nil>: tmpfs
I0415 12:09:05.726075 868679 buildroot.go:70] root file system type: tmpfs
I0415 12:09:05.726251 868679 provision.go:314] Updating docker unit: /lib/systemd/system/docker.service ...
I0415 12:09:05.726287 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHHostname
I0415 12:09:05.729607 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:09:05.729933 868679 main.go:141] libmachine: (flannel-707566) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:dd:d5:1d", ip: ""} in network mk-flannel-707566: {Iface:virbr3 ExpiryTime:2024-04-15 13:08:53 +0000 UTC Type:0 Mac:52:54:00:dd:d5:1d Iaid: IPaddr:192.168.39.45 Prefix:24 Hostname:flannel-707566 Clientid:01:52:54:00:dd:d5:1d}
I0415 12:09:05.729968 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined IP address 192.168.39.45 and MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:09:05.730374 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHPort
I0415 12:09:05.730590 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHKeyPath
I0415 12:09:05.730859 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHKeyPath
I0415 12:09:05.731056 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHUsername
I0415 12:09:05.731262 868679 main.go:141] libmachine: Using SSH client type: native
I0415 12:09:05.731468 868679 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x82d4e0] 0x830240 <nil> [] 0s} 192.168.39.45 22 <nil> <nil>}
I0415 12:09:05.731542 868679 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
I0415 12:09:05.867535 868679 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
I0415 12:09:05.867576 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHHostname
I0415 12:09:05.870999 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:09:05.871454 868679 main.go:141] libmachine: (flannel-707566) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:dd:d5:1d", ip: ""} in network mk-flannel-707566: {Iface:virbr3 ExpiryTime:2024-04-15 13:08:53 +0000 UTC Type:0 Mac:52:54:00:dd:d5:1d Iaid: IPaddr:192.168.39.45 Prefix:24 Hostname:flannel-707566 Clientid:01:52:54:00:dd:d5:1d}
I0415 12:09:05.871489 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined IP address 192.168.39.45 and MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:09:05.871705 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHPort
I0415 12:09:05.871976 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHKeyPath
I0415 12:09:05.872243 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHKeyPath
I0415 12:09:05.872451 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHUsername
I0415 12:09:05.872745 868679 main.go:141] libmachine: Using SSH client type: native
I0415 12:09:05.872979 868679 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x82d4e0] 0x830240 <nil> [] 0s} 192.168.39.45 22 <nil> <nil>}
I0415 12:09:05.872999 868679 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; }
I0415 12:09:08.519423 868679 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.
I0415 12:09:08.519475 868679 main.go:141] libmachine: Checking connection to Docker...
I0415 12:09:08.519490 868679 main.go:141] libmachine: (flannel-707566) Calling .GetURL
I0415 12:09:08.521056 868679 main.go:141] libmachine: (flannel-707566) DBG | Using libvirt version 6000000
I0415 12:09:08.523976 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:09:08.524483 868679 main.go:141] libmachine: (flannel-707566) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:dd:d5:1d", ip: ""} in network mk-flannel-707566: {Iface:virbr3 ExpiryTime:2024-04-15 13:08:53 +0000 UTC Type:0 Mac:52:54:00:dd:d5:1d Iaid: IPaddr:192.168.39.45 Prefix:24 Hostname:flannel-707566 Clientid:01:52:54:00:dd:d5:1d}
I0415 12:09:08.524518 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined IP address 192.168.39.45 and MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:09:08.524702 868679 main.go:141] libmachine: Docker is up and running!
I0415 12:09:08.524718 868679 main.go:141] libmachine: Reticulating splines...
I0415 12:09:08.524728 868679 client.go:171] duration metric: took 33.882771495s to LocalClient.Create
I0415 12:09:08.524759 868679 start.go:167] duration metric: took 33.88285952s to libmachine.API.Create "flannel-707566"
I0415 12:09:08.524773 868679 start.go:293] postStartSetup for "flannel-707566" (driver="kvm2")
I0415 12:09:08.524787 868679 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]
I0415 12:09:08.524817 868679 main.go:141] libmachine: (flannel-707566) Calling .DriverName
I0415 12:09:08.525199 868679 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
I0415 12:09:08.525235 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHHostname
I0415 12:09:08.527736 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:09:08.528177 868679 main.go:141] libmachine: (flannel-707566) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:dd:d5:1d", ip: ""} in network mk-flannel-707566: {Iface:virbr3 ExpiryTime:2024-04-15 13:08:53 +0000 UTC Type:0 Mac:52:54:00:dd:d5:1d Iaid: IPaddr:192.168.39.45 Prefix:24 Hostname:flannel-707566 Clientid:01:52:54:00:dd:d5:1d}
I0415 12:09:08.528202 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined IP address 192.168.39.45 and MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:09:08.528391 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHPort
I0415 12:09:08.528672 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHKeyPath
I0415 12:09:08.528870 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHUsername
I0415 12:09:08.529059 868679 sshutil.go:53] new ssh client: &{IP:192.168.39.45 Port:22 SSHKeyPath:/home/jenkins/minikube-integration/18644-814187/.minikube/machines/flannel-707566/id_rsa Username:docker}
I0415 12:09:08.623329 868679 ssh_runner.go:195] Run: cat /etc/os-release
I0415 12:09:08.629502 868679 info.go:137] Remote host: Buildroot 2023.02.9
I0415 12:09:08.629545 868679 filesync.go:126] Scanning /home/jenkins/minikube-integration/18644-814187/.minikube/addons for local assets ...
I0415 12:09:08.629627 868679 filesync.go:126] Scanning /home/jenkins/minikube-integration/18644-814187/.minikube/files for local assets ...
I0415 12:09:08.629738 868679 filesync.go:149] local asset: /home/jenkins/minikube-integration/18644-814187/.minikube/files/etc/ssl/certs/8215202.pem -> 8215202.pem in /etc/ssl/certs
I0415 12:09:08.629844 868679 ssh_runner.go:195] Run: sudo mkdir -p /etc/ssl/certs
I0415 12:09:08.642710 868679 ssh_runner.go:362] scp /home/jenkins/minikube-integration/18644-814187/.minikube/files/etc/ssl/certs/8215202.pem --> /etc/ssl/certs/8215202.pem (1708 bytes)
I0415 12:09:08.683263 868679 start.go:296] duration metric: took 158.472073ms for postStartSetup
I0415 12:09:08.683342 868679 main.go:141] libmachine: (flannel-707566) Calling .GetConfigRaw
I0415 12:09:08.684140 868679 main.go:141] libmachine: (flannel-707566) Calling .GetIP
I0415 12:09:08.687631 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:09:08.688088 868679 main.go:141] libmachine: (flannel-707566) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:dd:d5:1d", ip: ""} in network mk-flannel-707566: {Iface:virbr3 ExpiryTime:2024-04-15 13:08:53 +0000 UTC Type:0 Mac:52:54:00:dd:d5:1d Iaid: IPaddr:192.168.39.45 Prefix:24 Hostname:flannel-707566 Clientid:01:52:54:00:dd:d5:1d}
I0415 12:09:08.688119 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined IP address 192.168.39.45 and MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:09:08.688414 868679 profile.go:143] Saving config to /home/jenkins/minikube-integration/18644-814187/.minikube/profiles/flannel-707566/config.json ...
I0415 12:09:08.688655 868679 start.go:128] duration metric: took 34.074588544s to createHost
I0415 12:09:08.688683 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHHostname
I0415 12:09:08.691624 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:09:08.691979 868679 main.go:141] libmachine: (flannel-707566) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:dd:d5:1d", ip: ""} in network mk-flannel-707566: {Iface:virbr3 ExpiryTime:2024-04-15 13:08:53 +0000 UTC Type:0 Mac:52:54:00:dd:d5:1d Iaid: IPaddr:192.168.39.45 Prefix:24 Hostname:flannel-707566 Clientid:01:52:54:00:dd:d5:1d}
I0415 12:09:08.692010 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined IP address 192.168.39.45 and MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:09:08.692244 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHPort
I0415 12:09:08.692609 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHKeyPath
I0415 12:09:08.692921 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHKeyPath
I0415 12:09:08.693133 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHUsername
I0415 12:09:08.693309 868679 main.go:141] libmachine: Using SSH client type: native
I0415 12:09:08.693558 868679 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x82d4e0] 0x830240 <nil> [] 0s} 192.168.39.45 22 <nil> <nil>}
I0415 12:09:08.693574 868679 main.go:141] libmachine: About to run SSH command:
date +%s.%N
I0415 12:09:08.808935 868679 main.go:141] libmachine: SSH cmd err, output: <nil>: 1713182948.798775518
I0415 12:09:08.808967 868679 fix.go:216] guest clock: 1713182948.798775518
I0415 12:09:08.808977 868679 fix.go:229] Guest: 2024-04-15 12:09:08.798775518 +0000 UTC Remote: 2024-04-15 12:09:08.688668951 +0000 UTC m=+58.472721110 (delta=110.106567ms)
I0415 12:09:08.809022 868679 fix.go:200] guest clock delta is within tolerance: 110.106567ms
I0415 12:09:08.809029 868679 start.go:83] releasing machines lock for "flannel-707566", held for 34.195213655s
I0415 12:09:08.809057 868679 main.go:141] libmachine: (flannel-707566) Calling .DriverName
I0415 12:09:08.809420 868679 main.go:141] libmachine: (flannel-707566) Calling .GetIP
I0415 12:09:08.813444 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:09:08.813859 868679 main.go:141] libmachine: (flannel-707566) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:dd:d5:1d", ip: ""} in network mk-flannel-707566: {Iface:virbr3 ExpiryTime:2024-04-15 13:08:53 +0000 UTC Type:0 Mac:52:54:00:dd:d5:1d Iaid: IPaddr:192.168.39.45 Prefix:24 Hostname:flannel-707566 Clientid:01:52:54:00:dd:d5:1d}
I0415 12:09:08.813913 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined IP address 192.168.39.45 and MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:09:08.814180 868679 main.go:141] libmachine: (flannel-707566) Calling .DriverName
I0415 12:09:08.814905 868679 main.go:141] libmachine: (flannel-707566) Calling .DriverName
I0415 12:09:08.815175 868679 main.go:141] libmachine: (flannel-707566) Calling .DriverName
I0415 12:09:08.815337 868679 ssh_runner.go:195] Run: curl -sS -m 2 https://registry.k8s.io/
I0415 12:09:08.815398 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHHostname
I0415 12:09:08.815439 868679 ssh_runner.go:195] Run: cat /version.json
I0415 12:09:08.815469 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHHostname
I0415 12:09:08.818897 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:09:08.819176 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:09:08.819336 868679 main.go:141] libmachine: (flannel-707566) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:dd:d5:1d", ip: ""} in network mk-flannel-707566: {Iface:virbr3 ExpiryTime:2024-04-15 13:08:53 +0000 UTC Type:0 Mac:52:54:00:dd:d5:1d Iaid: IPaddr:192.168.39.45 Prefix:24 Hostname:flannel-707566 Clientid:01:52:54:00:dd:d5:1d}
I0415 12:09:08.819365 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined IP address 192.168.39.45 and MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:09:08.819623 868679 main.go:141] libmachine: (flannel-707566) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:dd:d5:1d", ip: ""} in network mk-flannel-707566: {Iface:virbr3 ExpiryTime:2024-04-15 13:08:53 +0000 UTC Type:0 Mac:52:54:00:dd:d5:1d Iaid: IPaddr:192.168.39.45 Prefix:24 Hostname:flannel-707566 Clientid:01:52:54:00:dd:d5:1d}
I0415 12:09:08.819642 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHPort
I0415 12:09:08.819654 868679 main.go:141] libmachine: (flannel-707566) DBG | domain flannel-707566 has defined IP address 192.168.39.45 and MAC address 52:54:00:dd:d5:1d in network mk-flannel-707566
I0415 12:09:08.819875 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHPort
I0415 12:09:08.819888 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHKeyPath
I0415 12:09:08.820054 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHKeyPath
I0415 12:09:08.820110 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHUsername
I0415 12:09:08.820207 868679 main.go:141] libmachine: (flannel-707566) Calling .GetSSHUsername
I0415 12:09:08.820412 868679 sshutil.go:53] new ssh client: &{IP:192.168.39.45 Port:22 SSHKeyPath:/home/jenkins/minikube-integration/18644-814187/.minikube/machines/flannel-707566/id_rsa Username:docker}
I0415 12:09:08.820412 868679 sshutil.go:53] new ssh client: &{IP:192.168.39.45 Port:22 SSHKeyPath:/home/jenkins/minikube-integration/18644-814187/.minikube/machines/flannel-707566/id_rsa Username:docker}
I0415 12:09:08.942906 868679 ssh_runner.go:195] Run: systemctl --version
I0415 12:09:08.956560 868679 ssh_runner.go:195] Run: sh -c "stat /etc/cni/net.d/*loopback.conf*"
W0415 12:09:08.966916 868679 cni.go:209] loopback cni configuration skipped: "/etc/cni/net.d/*loopback.conf*" not found
I0415 12:09:08.967007 868679 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" ;
I0415 12:09:08.992484 868679 cni.go:262] disabled [/etc/cni/net.d/87-podman-bridge.conflist] bridge cni config(s)
I0415 12:09:08.992531 868679 start.go:494] detecting cgroup driver to use...
I0415 12:09:08.992725 868679 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"
I0415 12:09:09.017913 868679 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"
I0415 12:09:09.034116 868679 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"
I0415 12:09:09.049942 868679 containerd.go:146] configuring containerd to use "cgroupfs" as cgroup driver...
I0415 12:09:09.050031 868679 ssh_runner.go:195] Run: sh -c "sudo sed -i -r 's|^( *)SystemdCgroup = .*$|\1SystemdCgroup = false|g' /etc/containerd/config.toml"
I0415 12:09:09.071866 868679 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"
I0415 12:09:09.087789 868679 ssh_runner.go:195] Run: sh -c "sudo sed -i '/systemd_cgroup/d' /etc/containerd/config.toml"
I0415 12:09:09.103864 868679 ssh_runner.go:195] Run: sh -c "sudo sed -i 's|"io.containerd.runc.v1"|"io.containerd.runc.v2"|g' /etc/containerd/config.toml"
I0415 12:09:09.119771 868679 ssh_runner.go:195] Run: sh -c "sudo rm -rf /etc/cni/net.mk"
I0415 12:09:09.135494 868679 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"
I0415 12:09:09.151185 868679 ssh_runner.go:195] Run: sh -c "sudo sed -i '/^ *enable_unprivileged_ports = .*/d' /etc/containerd/config.toml"
I0415 12:09:09.166976 868679 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"
I0415 12:09:09.184152 868679 ssh_runner.go:195] Run: sudo sysctl net.bridge.bridge-nf-call-iptables
I0415 12:09:09.199665 868679 ssh_runner.go:195] Run: sudo sh -c "echo 1 > /proc/sys/net/ipv4/ip_forward"
I0415 12:09:09.215017 868679 ssh_runner.go:195] Run: sudo systemctl daemon-reload
I0415 12:09:09.354166 868679 ssh_runner.go:195] Run: sudo systemctl restart containerd
I0415 12:09:09.385699 868679 start.go:494] detecting cgroup driver to use...
I0415 12:09:09.385860 868679 ssh_runner.go:195] Run: sudo systemctl cat docker.service
I0415 12:09:09.419718 868679 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service containerd
I0415 12:09:09.446002 868679 ssh_runner.go:195] Run: sudo systemctl stop -f containerd
I0415 12:09:09.482185 868679 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service containerd
I0415 12:09:09.503138 868679 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service crio
I0415 12:09:09.528168 868679 ssh_runner.go:195] Run: sudo systemctl stop -f crio
I0415 12:09:09.570233 868679 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service crio
I0415 12:09:09.591099 868679 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"
I0415 12:09:09.616421 868679 ssh_runner.go:195] Run: which cri-dockerd
I0415 12:09:09.621816 868679 ssh_runner.go:195] Run: sudo mkdir -p /etc/systemd/system/cri-docker.service.d
I0415 12:09:09.636547 868679 ssh_runner.go:362] scp memory --> /etc/systemd/system/cri-docker.service.d/10-cni.conf (189 bytes)
I0415 12:09:09.662573 868679 ssh_runner.go:195] Run: sudo systemctl unmask docker.service
I0415 12:09:09.802718 868679 ssh_runner.go:195] Run: sudo systemctl enable docker.socket
I0415 12:09:09.961968 868679 docker.go:574] configuring docker to use "cgroupfs" as cgroup driver...
I0415 12:09:09.962152 868679 ssh_runner.go:362] scp memory --> /etc/docker/daemon.json (130 bytes)
I0415 12:09:09.985802 868679 ssh_runner.go:195] Run: sudo systemctl daemon-reload
I0415 12:09:10.132618 868679 ssh_runner.go:195] Run: sudo systemctl restart docker
I0415 12:10:11.268707 868679 ssh_runner.go:235] Completed: sudo systemctl restart docker: (1m1.136047322s)
I0415 12:10:11.268805 868679 ssh_runner.go:195] Run: sudo journalctl --no-pager -u docker
I0415 12:10:11.294572 868679 out.go:177]
W0415 12:10:11.296989 868679 out.go:239] 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 --
Apr 15 12:09:06 flannel-707566 systemd[1]: Starting Docker Application Container Engine...
Apr 15 12:09:06 flannel-707566 dockerd[535]: time="2024-04-15T12:09:06.412506273Z" level=info msg="Starting up"
Apr 15 12:09:06 flannel-707566 dockerd[535]: time="2024-04-15T12:09:06.413717931Z" level=info msg="containerd not running, starting managed containerd"
Apr 15 12:09:06 flannel-707566 dockerd[535]: time="2024-04-15T12:09:06.423253391Z" level=info msg="started new containerd process" address=/var/run/docker/containerd/containerd.sock module=libcontainerd pid=541
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.471715286Z" level=info msg="starting containerd" revision=926c9586fe4a6236699318391cd44976a98e31f1 version=v1.7.15
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.503454361Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.503617296Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.503710709Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.503751795Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.503958238Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.504044108Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.504327999Z" 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
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.504398294Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.504440288Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured"
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.504482068Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.504584760Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.504845235Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.507968947Z" 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
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.508131298Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.508381073Z" 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
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.508451839Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.508586418Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.508656787Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured"
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.508695231Z" level=info msg="metadata content store policy set" policy=shared
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.532507178Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.532751788Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.533035383Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.533097007Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.533139500Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.533305526Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.534165406Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.534375157Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.534504928Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.534555883Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.534595773Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.534634625Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.534675460Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.534715470Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.534756183Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.534795917Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.534840701Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.534941647Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.535007101Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.535047138Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.535167991Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.535212789Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.535251330Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.535288596Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.535325061Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.535362815Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.535400771Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.535440661Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.535479772Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.535526584Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.535571457Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.535612692Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.535659980Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.535697626Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.535733601Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.535847666Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.536040111Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="no OpenTelemetry endpoint: skip plugin" type=io.containerd.tracing.processor.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.536080967Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.536119414Z" level=info msg="skipping tracing processor initialization (no tracing plugin)" error="no OpenTelemetry endpoint: skip plugin"
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.536259030Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.536301227Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.536348121Z" level=info msg="NRI interface is disabled by configuration."
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.536930904Z" level=info msg=serving... address=/var/run/docker/containerd/containerd-debug.sock
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.537228965Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock.ttrpc
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.537429113Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.537517774Z" level=info msg="containerd successfully booted in 0.069256s"
Apr 15 12:09:07 flannel-707566 dockerd[535]: time="2024-04-15T12:09:07.952807441Z" level=info msg="[graphdriver] trying configured driver: overlay2"
Apr 15 12:09:08 flannel-707566 dockerd[535]: time="2024-04-15T12:09:08.134135159Z" level=info msg="Loading containers: start."
Apr 15 12:09:08 flannel-707566 dockerd[535]: time="2024-04-15T12:09:08.393971986Z" level=info msg="Loading containers: done."
Apr 15 12:09:08 flannel-707566 dockerd[535]: time="2024-04-15T12:09:08.413032321Z" level=info msg="Docker daemon" commit=8b79278 containerd-snapshotter=false storage-driver=overlay2 version=26.0.0
Apr 15 12:09:08 flannel-707566 dockerd[535]: time="2024-04-15T12:09:08.413167433Z" level=info msg="Daemon has completed initialization"
Apr 15 12:09:08 flannel-707566 dockerd[535]: time="2024-04-15T12:09:08.506510274Z" level=info msg="API listen on /var/run/docker.sock"
Apr 15 12:09:08 flannel-707566 systemd[1]: Started Docker Application Container Engine.
Apr 15 12:09:08 flannel-707566 dockerd[535]: time="2024-04-15T12:09:08.507836018Z" level=info msg="API listen on [::]:2376"
Apr 15 12:09:10 flannel-707566 systemd[1]: Stopping Docker Application Container Engine...
Apr 15 12:09:10 flannel-707566 dockerd[535]: time="2024-04-15T12:09:10.144070867Z" level=info msg="Processing signal 'terminated'"
Apr 15 12:09:10 flannel-707566 dockerd[535]: time="2024-04-15T12:09:10.146119893Z" level=info msg="stopping event stream following graceful shutdown" error="<nil>" module=libcontainerd namespace=moby
Apr 15 12:09:10 flannel-707566 dockerd[535]: time="2024-04-15T12:09:10.148047149Z" level=info msg="Daemon shutdown complete"
Apr 15 12:09:10 flannel-707566 dockerd[535]: time="2024-04-15T12:09:10.148247726Z" level=info msg="stopping event stream following graceful shutdown" error="context canceled" module=libcontainerd namespace=plugins.moby
Apr 15 12:09:10 flannel-707566 dockerd[535]: time="2024-04-15T12:09:10.148287665Z" level=info msg="stopping healthcheck following graceful shutdown" module=libcontainerd
Apr 15 12:09:11 flannel-707566 systemd[1]: docker.service: Deactivated successfully.
Apr 15 12:09:11 flannel-707566 systemd[1]: Stopped Docker Application Container Engine.
Apr 15 12:09:11 flannel-707566 systemd[1]: Starting Docker Application Container Engine...
Apr 15 12:09:11 flannel-707566 dockerd[796]: time="2024-04-15T12:09:11.228657299Z" level=info msg="Starting up"
Apr 15 12:10:11 flannel-707566 dockerd[796]: failed to start daemon: failed to dial "/run/containerd/containerd.sock": failed to dial "/run/containerd/containerd.sock": context deadline exceeded
Apr 15 12:10:11 flannel-707566 systemd[1]: docker.service: Main process exited, code=exited, status=1/FAILURE
Apr 15 12:10:11 flannel-707566 systemd[1]: docker.service: Failed with result 'exit-code'.
Apr 15 12:10:11 flannel-707566 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 --
Apr 15 12:09:06 flannel-707566 systemd[1]: Starting Docker Application Container Engine...
Apr 15 12:09:06 flannel-707566 dockerd[535]: time="2024-04-15T12:09:06.412506273Z" level=info msg="Starting up"
Apr 15 12:09:06 flannel-707566 dockerd[535]: time="2024-04-15T12:09:06.413717931Z" level=info msg="containerd not running, starting managed containerd"
Apr 15 12:09:06 flannel-707566 dockerd[535]: time="2024-04-15T12:09:06.423253391Z" level=info msg="started new containerd process" address=/var/run/docker/containerd/containerd.sock module=libcontainerd pid=541
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.471715286Z" level=info msg="starting containerd" revision=926c9586fe4a6236699318391cd44976a98e31f1 version=v1.7.15
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.503454361Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.503617296Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.503710709Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.503751795Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.503958238Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.504044108Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.504327999Z" 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
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.504398294Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.504440288Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured"
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.504482068Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.504584760Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.504845235Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.507968947Z" 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
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.508131298Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.508381073Z" 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
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.508451839Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.508586418Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.508656787Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured"
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.508695231Z" level=info msg="metadata content store policy set" policy=shared
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.532507178Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.532751788Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.533035383Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.533097007Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.533139500Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.533305526Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.534165406Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.534375157Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.534504928Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.534555883Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.534595773Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.534634625Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.534675460Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.534715470Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.534756183Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.534795917Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.534840701Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.534941647Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.535007101Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.535047138Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.535167991Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.535212789Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.535251330Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.535288596Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.535325061Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.535362815Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.535400771Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.535440661Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.535479772Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.535526584Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.535571457Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.535612692Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.535659980Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.535697626Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.535733601Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.535847666Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.536040111Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="no OpenTelemetry endpoint: skip plugin" type=io.containerd.tracing.processor.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.536080967Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.536119414Z" level=info msg="skipping tracing processor initialization (no tracing plugin)" error="no OpenTelemetry endpoint: skip plugin"
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.536259030Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.536301227Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.536348121Z" level=info msg="NRI interface is disabled by configuration."
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.536930904Z" level=info msg=serving... address=/var/run/docker/containerd/containerd-debug.sock
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.537228965Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock.ttrpc
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.537429113Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock
Apr 15 12:09:06 flannel-707566 dockerd[541]: time="2024-04-15T12:09:06.537517774Z" level=info msg="containerd successfully booted in 0.069256s"
Apr 15 12:09:07 flannel-707566 dockerd[535]: time="2024-04-15T12:09:07.952807441Z" level=info msg="[graphdriver] trying configured driver: overlay2"
Apr 15 12:09:08 flannel-707566 dockerd[535]: time="2024-04-15T12:09:08.134135159Z" level=info msg="Loading containers: start."
Apr 15 12:09:08 flannel-707566 dockerd[535]: time="2024-04-15T12:09:08.393971986Z" level=info msg="Loading containers: done."
Apr 15 12:09:08 flannel-707566 dockerd[535]: time="2024-04-15T12:09:08.413032321Z" level=info msg="Docker daemon" commit=8b79278 containerd-snapshotter=false storage-driver=overlay2 version=26.0.0
Apr 15 12:09:08 flannel-707566 dockerd[535]: time="2024-04-15T12:09:08.413167433Z" level=info msg="Daemon has completed initialization"
Apr 15 12:09:08 flannel-707566 dockerd[535]: time="2024-04-15T12:09:08.506510274Z" level=info msg="API listen on /var/run/docker.sock"
Apr 15 12:09:08 flannel-707566 systemd[1]: Started Docker Application Container Engine.
Apr 15 12:09:08 flannel-707566 dockerd[535]: time="2024-04-15T12:09:08.507836018Z" level=info msg="API listen on [::]:2376"
Apr 15 12:09:10 flannel-707566 systemd[1]: Stopping Docker Application Container Engine...
Apr 15 12:09:10 flannel-707566 dockerd[535]: time="2024-04-15T12:09:10.144070867Z" level=info msg="Processing signal 'terminated'"
Apr 15 12:09:10 flannel-707566 dockerd[535]: time="2024-04-15T12:09:10.146119893Z" level=info msg="stopping event stream following graceful shutdown" error="<nil>" module=libcontainerd namespace=moby
Apr 15 12:09:10 flannel-707566 dockerd[535]: time="2024-04-15T12:09:10.148047149Z" level=info msg="Daemon shutdown complete"
Apr 15 12:09:10 flannel-707566 dockerd[535]: time="2024-04-15T12:09:10.148247726Z" level=info msg="stopping event stream following graceful shutdown" error="context canceled" module=libcontainerd namespace=plugins.moby
Apr 15 12:09:10 flannel-707566 dockerd[535]: time="2024-04-15T12:09:10.148287665Z" level=info msg="stopping healthcheck following graceful shutdown" module=libcontainerd
Apr 15 12:09:11 flannel-707566 systemd[1]: docker.service: Deactivated successfully.
Apr 15 12:09:11 flannel-707566 systemd[1]: Stopped Docker Application Container Engine.
Apr 15 12:09:11 flannel-707566 systemd[1]: Starting Docker Application Container Engine...
Apr 15 12:09:11 flannel-707566 dockerd[796]: time="2024-04-15T12:09:11.228657299Z" level=info msg="Starting up"
Apr 15 12:10:11 flannel-707566 dockerd[796]: failed to start daemon: failed to dial "/run/containerd/containerd.sock": failed to dial "/run/containerd/containerd.sock": context deadline exceeded
Apr 15 12:10:11 flannel-707566 systemd[1]: docker.service: Main process exited, code=exited, status=1/FAILURE
Apr 15 12:10:11 flannel-707566 systemd[1]: docker.service: Failed with result 'exit-code'.
Apr 15 12:10:11 flannel-707566 systemd[1]: Failed to start Docker Application Container Engine.
-- /stdout --
W0415 12:10:11.297076 868679 out.go:239] *
*
W0415 12:10:11.298139 868679 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. │
│ │
╰─────────────────────────────────────────────────────────────────────────────────────────────╯
I0415 12:10:11.300620 868679 out.go:177]
** /stderr **
net_test.go:114: failed start: exit status 90
--- FAIL: TestNetworkPlugins/group/flannel/Start (121.12s)