=== RUN TestNetworkPlugins/group/bridge/Start
net_test.go:112: (dbg) Run: out/minikube-linux-amd64 start -p bridge-258288 --memory=3072 --alsologtostderr --wait=true --wait-timeout=15m --cni=bridge --driver=kvm2
net_test.go:112: (dbg) Non-zero exit: out/minikube-linux-amd64 start -p bridge-258288 --memory=3072 --alsologtostderr --wait=true --wait-timeout=15m --cni=bridge --driver=kvm2 : exit status 90 (1m31.346447968s)
-- stdout --
* [bridge-258288] minikube v1.35.0 on Ubuntu 20.04 (kvm/amd64)
- MINIKUBE_LOCATION=20317
- MINIKUBE_SUPPRESS_DOCKER_PERFORMANCE=true
- KUBECONFIG=/home/jenkins/minikube-integration/20317-81875/kubeconfig
- MINIKUBE_HOME=/home/jenkins/minikube-integration/20317-81875/.minikube
- MINIKUBE_BIN=out/minikube-linux-amd64
- MINIKUBE_FORCE_SYSTEMD=
* Using the kvm2 driver based on user configuration
* Starting "bridge-258288" primary control-plane node in "bridge-258288" cluster
* Creating kvm2 VM (CPUs=2, Memory=3072MB, Disk=20000MB) ...
-- /stdout --
** stderr **
I0127 13:00:46.645956 139218 out.go:345] Setting OutFile to fd 1 ...
I0127 13:00:46.646376 139218 out.go:392] TERM=,COLORTERM=, which probably does not support color
I0127 13:00:46.646423 139218 out.go:358] Setting ErrFile to fd 2...
I0127 13:00:46.646438 139218 out.go:392] TERM=,COLORTERM=, which probably does not support color
I0127 13:00:46.646687 139218 root.go:338] Updating PATH: /home/jenkins/minikube-integration/20317-81875/.minikube/bin
I0127 13:00:46.647664 139218 out.go:352] Setting JSON to false
I0127 13:00:46.649549 139218 start.go:129] hostinfo: {"hostname":"ubuntu-20-agent-7","uptime":9795,"bootTime":1737973052,"procs":345,"os":"linux","platform":"ubuntu","platformFamily":"debian","platformVersion":"20.04","kernelVersion":"5.15.0-1074-gcp","kernelArch":"x86_64","virtualizationSystem":"kvm","virtualizationRole":"guest","hostId":"591c9f12-2938-3743-e2bf-c56a050d43d1"}
I0127 13:00:46.649730 139218 start.go:139] virtualization: kvm guest
I0127 13:00:46.652079 139218 out.go:177] * [bridge-258288] minikube v1.35.0 on Ubuntu 20.04 (kvm/amd64)
I0127 13:00:46.653611 139218 notify.go:220] Checking for updates...
I0127 13:00:46.653708 139218 out.go:177] - MINIKUBE_LOCATION=20317
I0127 13:00:46.655047 139218 out.go:177] - MINIKUBE_SUPPRESS_DOCKER_PERFORMANCE=true
I0127 13:00:46.656377 139218 out.go:177] - KUBECONFIG=/home/jenkins/minikube-integration/20317-81875/kubeconfig
I0127 13:00:46.657626 139218 out.go:177] - MINIKUBE_HOME=/home/jenkins/minikube-integration/20317-81875/.minikube
I0127 13:00:46.658831 139218 out.go:177] - MINIKUBE_BIN=out/minikube-linux-amd64
I0127 13:00:46.660111 139218 out.go:177] - MINIKUBE_FORCE_SYSTEMD=
I0127 13:00:46.661833 139218 config.go:182] Loaded profile config "enable-default-cni-258288": Driver=kvm2, ContainerRuntime=docker, KubernetesVersion=v1.32.1
I0127 13:00:46.662004 139218 config.go:182] Loaded profile config "flannel-258288": Driver=kvm2, ContainerRuntime=docker, KubernetesVersion=v1.32.1
I0127 13:00:46.662138 139218 config.go:182] Loaded profile config "kubenet-258288": Driver=kvm2, ContainerRuntime=docker, KubernetesVersion=v1.32.1
I0127 13:00:46.662289 139218 driver.go:394] Setting default libvirt URI to qemu:///system
I0127 13:00:46.718738 139218 out.go:177] * Using the kvm2 driver based on user configuration
I0127 13:00:46.720394 139218 start.go:297] selected driver: kvm2
I0127 13:00:46.720472 139218 start.go:901] validating driver "kvm2" against <nil>
I0127 13:00:46.720503 139218 start.go:912] status for kvm2: {Installed:true Healthy:true Running:true NeedsImprovement:false Error:<nil> Reason: Fix: Doc: Version:}
I0127 13:00:46.721852 139218 install.go:52] acquiring lock: {Name:mk900956b073697a4aa6c80a27c6bb0742a99a53 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I0127 13:00:46.721959 139218 install.go:117] Validating docker-machine-driver-kvm2, PATH=/home/jenkins/minikube-integration/20317-81875/.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
I0127 13:00:46.746117 139218 install.go:137] /home/jenkins/workspace/KVM_Linux_integration/out/docker-machine-driver-kvm2 version is 1.35.0
I0127 13:00:46.746195 139218 start_flags.go:310] no existing cluster config was found, will generate one from the flags
I0127 13:00:46.746566 139218 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]
I0127 13:00:46.746623 139218 cni.go:84] Creating CNI manager for "bridge"
I0127 13:00:46.746632 139218 start_flags.go:319] Found "bridge CNI" CNI - setting NetworkPlugin=cni
I0127 13:00:46.746723 139218 start.go:340] cluster config:
{Name:bridge-258288 KeepContext:false EmbedCerts:false MinikubeISO: KicBaseImage:gcr.io/k8s-minikube/kicbase:v0.0.46@sha256:fd2d445ddcc33ebc5c6b68a17e6219ea207ce63c005095ea1525296da2d1a279 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.32.1 ClusterName:bridge-258288 Namespace:default APIServerHAVIP: APIServerName:minikubeCA APIServerNames:[] APIServerIPs:[] DNSDomain:cluster.local ContainerRuntime:docker CRISocket: Network
Plugin:cni FeatureGates: ServiceCIDR:10.96.0.0/12 ImageRepository: LoadBalancerStartIP: LoadBalancerEndIP: CustomIngressCert: RegistryAliases: ExtraOptions:[] ShouldLoadCachedImages:true EnableDefaultCNI:false CNI:bridge} Nodes:[{Name: IP: Port:8443 KubernetesVersion:v1.32.1 ContainerRuntime:docker ControlPlane:true Worker:true}] Addons:map[] CustomAddonImages:map[] CustomAddonRegistries:map[] VerifyComponents:map[apiserver:true apps_running:true default_sa:true extra:true kubelet:true node_ready:true system_pods:true] StartHostTimeout:15m0s ScheduledStop:<nil> ExposedPorts:[] ListenAddress: Network: Subnet: MultiNodeRequested:false ExtraDisks:0 CertExpiration:26280h0m0s Mount:false MountString:/home/jenkins:/minikube-host Mount9PVersion:9p2000.L MountGID:docker MountIP: MountMSize:262144 MountOptions:[] MountPort:0 MountType:9p MountUID:docker BinaryMirror: DisableOptimizations:false DisableMetrics:false CustomQemuFirmwarePath: SocketVMnetClientPath: SocketVMnetPath: StaticIP: SSHAuthSock: SSHAgentPID:0 GPUs
: AutoPauseInterval:1m0s}
I0127 13:00:46.746926 139218 iso.go:125] acquiring lock: {Name:mkd5a53f4cbb5fee4e2a8ef95827c364c7421a40 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I0127 13:00:46.749685 139218 out.go:177] * Starting "bridge-258288" primary control-plane node in "bridge-258288" cluster
I0127 13:00:46.750941 139218 preload.go:131] Checking if preload exists for k8s version v1.32.1 and runtime docker
I0127 13:00:46.750997 139218 preload.go:146] Found local preload: /home/jenkins/minikube-integration/20317-81875/.minikube/cache/preloaded-tarball/preloaded-images-k8s-v18-v1.32.1-docker-overlay2-amd64.tar.lz4
I0127 13:00:46.751012 139218 cache.go:56] Caching tarball of preloaded images
I0127 13:00:46.751126 139218 preload.go:172] Found /home/jenkins/minikube-integration/20317-81875/.minikube/cache/preloaded-tarball/preloaded-images-k8s-v18-v1.32.1-docker-overlay2-amd64.tar.lz4 in cache, skipping download
I0127 13:00:46.751141 139218 cache.go:59] Finished verifying existence of preloaded tar for v1.32.1 on docker
I0127 13:00:46.751322 139218 profile.go:143] Saving config to /home/jenkins/minikube-integration/20317-81875/.minikube/profiles/bridge-258288/config.json ...
I0127 13:00:46.751356 139218 lock.go:35] WriteFile acquiring /home/jenkins/minikube-integration/20317-81875/.minikube/profiles/bridge-258288/config.json: {Name:mkb328e87d94894d9f330b2e2ef63657eaf7ca42 Clock:{} Delay:500ms Timeout:1m0s Cancel:<nil>}
I0127 13:00:46.751557 139218 start.go:360] acquireMachinesLock for bridge-258288: {Name:mka71e20ed7ec37dffe8aeca84620a4774dbc92d Clock:{} Delay:500ms Timeout:13m0s Cancel:<nil>}
I0127 13:00:46.751601 139218 start.go:364] duration metric: took 24.626µs to acquireMachinesLock for "bridge-258288"
I0127 13:00:46.751623 139218 start.go:93] Provisioning new machine with config: &{Name:bridge-258288 KeepContext:false EmbedCerts:false MinikubeISO:https://storage.googleapis.com/minikube/iso/minikube-v1.35.0-amd64.iso KicBaseImage:gcr.io/k8s-minikube/kicbase:v0.0.46@sha256:fd2d445ddcc33ebc5c6b68a17e6219ea207ce63c005095ea1525296da2d1a279 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.32.1 ClusterName:bridge-258288 Namespa
ce: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:bridge} Nodes:[{Name: IP: Port:8443 KubernetesVersion:v1.32.1 ContainerRuntime:docker ControlPlane:true Worker:true}] Addons:map[] CustomAddonImages:map[] CustomAddonRegistries:map[] VerifyComponents:map[apiserver:true apps_running:true default_sa:true extra:true kubelet:true node_ready:true system_pods:true] StartHostTimeout:15m0s ScheduledStop:<nil> ExposedPorts:[] ListenAddress: Network: Subnet: MultiNodeRequested:false ExtraDisks:0 CertExpiration:26280h0m0s Mount:false MountString:/home/jenkins:/minikube-host Mount9PVersion:9p2000.L MountGID:docker MountIP: MountMSize:262144 MountOptions:[] MountPort:0 MountType:9p MountUID:docker BinaryMirror: D
isableOptimizations:false DisableMetrics:false CustomQemuFirmwarePath: SocketVMnetClientPath: SocketVMnetPath: StaticIP: SSHAuthSock: SSHAgentPID:0 GPUs: AutoPauseInterval:1m0s} &{Name: IP: Port:8443 KubernetesVersion:v1.32.1 ContainerRuntime:docker ControlPlane:true Worker:true}
I0127 13:00:46.751707 139218 start.go:125] createHost starting for "" (driver="kvm2")
I0127 13:00:46.754165 139218 out.go:235] * Creating kvm2 VM (CPUs=2, Memory=3072MB, Disk=20000MB) ...
I0127 13:00:46.754356 139218 main.go:141] libmachine: Found binary path at /home/jenkins/workspace/KVM_Linux_integration/out/docker-machine-driver-kvm2
I0127 13:00:46.754423 139218 main.go:141] libmachine: Launching plugin server for driver kvm2
I0127 13:00:46.772133 139218 main.go:141] libmachine: Plugin server listening at address 127.0.0.1:43071
I0127 13:00:46.773229 139218 main.go:141] libmachine: () Calling .GetVersion
I0127 13:00:46.773860 139218 main.go:141] libmachine: Using API Version 1
I0127 13:00:46.773880 139218 main.go:141] libmachine: () Calling .SetConfigRaw
I0127 13:00:46.774365 139218 main.go:141] libmachine: () Calling .GetMachineName
I0127 13:00:46.774618 139218 main.go:141] libmachine: (bridge-258288) Calling .GetMachineName
I0127 13:00:46.774738 139218 main.go:141] libmachine: (bridge-258288) Calling .DriverName
I0127 13:00:46.774846 139218 start.go:159] libmachine.API.Create for "bridge-258288" (driver="kvm2")
I0127 13:00:46.774870 139218 client.go:168] LocalClient.Create starting
I0127 13:00:46.774930 139218 main.go:141] libmachine: Reading certificate data from /home/jenkins/minikube-integration/20317-81875/.minikube/certs/ca.pem
I0127 13:00:46.774962 139218 main.go:141] libmachine: Decoding PEM data...
I0127 13:00:46.775000 139218 main.go:141] libmachine: Parsing certificate...
I0127 13:00:46.775060 139218 main.go:141] libmachine: Reading certificate data from /home/jenkins/minikube-integration/20317-81875/.minikube/certs/cert.pem
I0127 13:00:46.775081 139218 main.go:141] libmachine: Decoding PEM data...
I0127 13:00:46.775092 139218 main.go:141] libmachine: Parsing certificate...
I0127 13:00:46.775105 139218 main.go:141] libmachine: Running pre-create checks...
I0127 13:00:46.775114 139218 main.go:141] libmachine: (bridge-258288) Calling .PreCreateCheck
I0127 13:00:46.775430 139218 main.go:141] libmachine: (bridge-258288) Calling .GetConfigRaw
I0127 13:00:46.775819 139218 main.go:141] libmachine: Creating machine...
I0127 13:00:46.775831 139218 main.go:141] libmachine: (bridge-258288) Calling .Create
I0127 13:00:46.775937 139218 main.go:141] libmachine: (bridge-258288) creating KVM machine...
I0127 13:00:46.775957 139218 main.go:141] libmachine: (bridge-258288) creating network...
I0127 13:00:46.777587 139218 main.go:141] libmachine: (bridge-258288) DBG | found existing default KVM network
I0127 13:00:46.779415 139218 main.go:141] libmachine: (bridge-258288) DBG | I0127 13:00:46.779230 139251 network.go:211] skipping subnet 192.168.39.0/24 that is taken: &{IP:192.168.39.0 Netmask:255.255.255.0 Prefix:24 CIDR:192.168.39.0/24 Gateway:192.168.39.1 ClientMin:192.168.39.2 ClientMax:192.168.39.254 Broadcast:192.168.39.255 IsPrivate:true Interface:{IfaceName:virbr3 IfaceIPv4:192.168.39.1 IfaceMTU:1500 IfaceMAC:52:54:00:d7:57:92} reservation:<nil>}
I0127 13:00:46.780768 139218 main.go:141] libmachine: (bridge-258288) DBG | I0127 13:00:46.780668 139251 network.go:211] skipping subnet 192.168.50.0/24 that is taken: &{IP:192.168.50.0 Netmask:255.255.255.0 Prefix:24 CIDR:192.168.50.0/24 Gateway:192.168.50.1 ClientMin:192.168.50.2 ClientMax:192.168.50.254 Broadcast:192.168.50.255 IsPrivate:true Interface:{IfaceName:virbr1 IfaceIPv4:192.168.50.1 IfaceMTU:1500 IfaceMAC:52:54:00:8c:cd:88} reservation:<nil>}
I0127 13:00:46.782267 139218 main.go:141] libmachine: (bridge-258288) DBG | I0127 13:00:46.782144 139251 network.go:211] skipping subnet 192.168.61.0/24 that is taken: &{IP:192.168.61.0 Netmask:255.255.255.0 Prefix:24 CIDR:192.168.61.0/24 Gateway:192.168.61.1 ClientMin:192.168.61.2 ClientMax:192.168.61.254 Broadcast:192.168.61.255 IsPrivate:true Interface:{IfaceName:virbr2 IfaceIPv4:192.168.61.1 IfaceMTU:1500 IfaceMAC:52:54:00:ce:33:23} reservation:<nil>}
I0127 13:00:46.784043 139218 main.go:141] libmachine: (bridge-258288) DBG | I0127 13:00:46.783947 139251 network.go:206] using free private subnet 192.168.72.0/24: &{IP:192.168.72.0 Netmask:255.255.255.0 Prefix:24 CIDR:192.168.72.0/24 Gateway:192.168.72.1 ClientMin:192.168.72.2 ClientMax:192.168.72.254 Broadcast:192.168.72.255 IsPrivate:true Interface:{IfaceName: IfaceIPv4: IfaceMTU:0 IfaceMAC:} reservation:0xc0003e0610}
I0127 13:00:46.784208 139218 main.go:141] libmachine: (bridge-258288) DBG | created network xml:
I0127 13:00:46.784231 139218 main.go:141] libmachine: (bridge-258288) DBG | <network>
I0127 13:00:46.784242 139218 main.go:141] libmachine: (bridge-258288) DBG | <name>mk-bridge-258288</name>
I0127 13:00:46.784253 139218 main.go:141] libmachine: (bridge-258288) DBG | <dns enable='no'/>
I0127 13:00:46.784269 139218 main.go:141] libmachine: (bridge-258288) DBG |
I0127 13:00:46.784283 139218 main.go:141] libmachine: (bridge-258288) DBG | <ip address='192.168.72.1' netmask='255.255.255.0'>
I0127 13:00:46.784298 139218 main.go:141] libmachine: (bridge-258288) DBG | <dhcp>
I0127 13:00:46.784307 139218 main.go:141] libmachine: (bridge-258288) DBG | <range start='192.168.72.2' end='192.168.72.253'/>
I0127 13:00:46.784316 139218 main.go:141] libmachine: (bridge-258288) DBG | </dhcp>
I0127 13:00:46.784323 139218 main.go:141] libmachine: (bridge-258288) DBG | </ip>
I0127 13:00:46.784332 139218 main.go:141] libmachine: (bridge-258288) DBG |
I0127 13:00:46.784338 139218 main.go:141] libmachine: (bridge-258288) DBG | </network>
I0127 13:00:46.784351 139218 main.go:141] libmachine: (bridge-258288) DBG |
I0127 13:00:46.790466 139218 main.go:141] libmachine: (bridge-258288) DBG | trying to create private KVM network mk-bridge-258288 192.168.72.0/24...
I0127 13:00:46.891990 139218 main.go:141] libmachine: (bridge-258288) DBG | private KVM network mk-bridge-258288 192.168.72.0/24 created
I0127 13:00:46.892135 139218 main.go:141] libmachine: (bridge-258288) setting up store path in /home/jenkins/minikube-integration/20317-81875/.minikube/machines/bridge-258288 ...
I0127 13:00:46.892214 139218 main.go:141] libmachine: (bridge-258288) building disk image from file:///home/jenkins/minikube-integration/20317-81875/.minikube/cache/iso/amd64/minikube-v1.35.0-amd64.iso
I0127 13:00:46.892334 139218 main.go:141] libmachine: (bridge-258288) DBG | I0127 13:00:46.892277 139251 common.go:144] Making disk image using store path: /home/jenkins/minikube-integration/20317-81875/.minikube
I0127 13:00:46.893290 139218 main.go:141] libmachine: (bridge-258288) Downloading /home/jenkins/minikube-integration/20317-81875/.minikube/cache/boot2docker.iso from file:///home/jenkins/minikube-integration/20317-81875/.minikube/cache/iso/amd64/minikube-v1.35.0-amd64.iso...
I0127 13:00:47.247709 139218 main.go:141] libmachine: (bridge-258288) DBG | I0127 13:00:47.247512 139251 common.go:151] Creating ssh key: /home/jenkins/minikube-integration/20317-81875/.minikube/machines/bridge-258288/id_rsa...
I0127 13:00:47.587793 139218 main.go:141] libmachine: (bridge-258288) DBG | I0127 13:00:47.587671 139251 common.go:157] Creating raw disk image: /home/jenkins/minikube-integration/20317-81875/.minikube/machines/bridge-258288/bridge-258288.rawdisk...
I0127 13:00:47.587828 139218 main.go:141] libmachine: (bridge-258288) DBG | Writing magic tar header
I0127 13:00:47.587842 139218 main.go:141] libmachine: (bridge-258288) DBG | Writing SSH key tar header
I0127 13:00:47.587907 139218 main.go:141] libmachine: (bridge-258288) DBG | I0127 13:00:47.587840 139251 common.go:171] Fixing permissions on /home/jenkins/minikube-integration/20317-81875/.minikube/machines/bridge-258288 ...
I0127 13:00:47.588061 139218 main.go:141] libmachine: (bridge-258288) DBG | checking permissions on dir: /home/jenkins/minikube-integration/20317-81875/.minikube/machines/bridge-258288
I0127 13:00:47.588099 139218 main.go:141] libmachine: (bridge-258288) DBG | checking permissions on dir: /home/jenkins/minikube-integration/20317-81875/.minikube/machines
I0127 13:00:47.588113 139218 main.go:141] libmachine: (bridge-258288) setting executable bit set on /home/jenkins/minikube-integration/20317-81875/.minikube/machines/bridge-258288 (perms=drwx------)
I0127 13:00:47.588126 139218 main.go:141] libmachine: (bridge-258288) setting executable bit set on /home/jenkins/minikube-integration/20317-81875/.minikube/machines (perms=drwxr-xr-x)
I0127 13:00:47.588136 139218 main.go:141] libmachine: (bridge-258288) setting executable bit set on /home/jenkins/minikube-integration/20317-81875/.minikube (perms=drwxr-xr-x)
I0127 13:00:47.588149 139218 main.go:141] libmachine: (bridge-258288) setting executable bit set on /home/jenkins/minikube-integration/20317-81875 (perms=drwxrwxr-x)
I0127 13:00:47.588159 139218 main.go:141] libmachine: (bridge-258288) setting executable bit set on /home/jenkins/minikube-integration (perms=drwxrwxr-x)
I0127 13:00:47.588173 139218 main.go:141] libmachine: (bridge-258288) DBG | checking permissions on dir: /home/jenkins/minikube-integration/20317-81875/.minikube
I0127 13:00:47.588186 139218 main.go:141] libmachine: (bridge-258288) setting executable bit set on /home/jenkins (perms=drwxr-xr-x)
I0127 13:00:47.588199 139218 main.go:141] libmachine: (bridge-258288) DBG | checking permissions on dir: /home/jenkins/minikube-integration/20317-81875
I0127 13:00:47.588210 139218 main.go:141] libmachine: (bridge-258288) creating domain...
I0127 13:00:47.588223 139218 main.go:141] libmachine: (bridge-258288) DBG | checking permissions on dir: /home/jenkins/minikube-integration
I0127 13:00:47.588236 139218 main.go:141] libmachine: (bridge-258288) DBG | checking permissions on dir: /home/jenkins
I0127 13:00:47.588247 139218 main.go:141] libmachine: (bridge-258288) DBG | checking permissions on dir: /home
I0127 13:00:47.588262 139218 main.go:141] libmachine: (bridge-258288) DBG | skipping /home - not owner
I0127 13:00:47.589571 139218 main.go:141] libmachine: (bridge-258288) define libvirt domain using xml:
I0127 13:00:47.589597 139218 main.go:141] libmachine: (bridge-258288) <domain type='kvm'>
I0127 13:00:47.589607 139218 main.go:141] libmachine: (bridge-258288) <name>bridge-258288</name>
I0127 13:00:47.589615 139218 main.go:141] libmachine: (bridge-258288) <memory unit='MiB'>3072</memory>
I0127 13:00:47.589623 139218 main.go:141] libmachine: (bridge-258288) <vcpu>2</vcpu>
I0127 13:00:47.589633 139218 main.go:141] libmachine: (bridge-258288) <features>
I0127 13:00:47.589645 139218 main.go:141] libmachine: (bridge-258288) <acpi/>
I0127 13:00:47.589651 139218 main.go:141] libmachine: (bridge-258288) <apic/>
I0127 13:00:47.589681 139218 main.go:141] libmachine: (bridge-258288) <pae/>
I0127 13:00:47.589689 139218 main.go:141] libmachine: (bridge-258288)
I0127 13:00:47.589697 139218 main.go:141] libmachine: (bridge-258288) </features>
I0127 13:00:47.589703 139218 main.go:141] libmachine: (bridge-258288) <cpu mode='host-passthrough'>
I0127 13:00:47.589710 139218 main.go:141] libmachine: (bridge-258288)
I0127 13:00:47.589720 139218 main.go:141] libmachine: (bridge-258288) </cpu>
I0127 13:00:47.589728 139218 main.go:141] libmachine: (bridge-258288) <os>
I0127 13:00:47.589737 139218 main.go:141] libmachine: (bridge-258288) <type>hvm</type>
I0127 13:00:47.589744 139218 main.go:141] libmachine: (bridge-258288) <boot dev='cdrom'/>
I0127 13:00:47.589754 139218 main.go:141] libmachine: (bridge-258288) <boot dev='hd'/>
I0127 13:00:47.589762 139218 main.go:141] libmachine: (bridge-258288) <bootmenu enable='no'/>
I0127 13:00:47.589773 139218 main.go:141] libmachine: (bridge-258288) </os>
I0127 13:00:47.589780 139218 main.go:141] libmachine: (bridge-258288) <devices>
I0127 13:00:47.589792 139218 main.go:141] libmachine: (bridge-258288) <disk type='file' device='cdrom'>
I0127 13:00:47.589826 139218 main.go:141] libmachine: (bridge-258288) <source file='/home/jenkins/minikube-integration/20317-81875/.minikube/machines/bridge-258288/boot2docker.iso'/>
I0127 13:00:47.589837 139218 main.go:141] libmachine: (bridge-258288) <target dev='hdc' bus='scsi'/>
I0127 13:00:47.589845 139218 main.go:141] libmachine: (bridge-258288) <readonly/>
I0127 13:00:47.589854 139218 main.go:141] libmachine: (bridge-258288) </disk>
I0127 13:00:47.589863 139218 main.go:141] libmachine: (bridge-258288) <disk type='file' device='disk'>
I0127 13:00:47.589878 139218 main.go:141] libmachine: (bridge-258288) <driver name='qemu' type='raw' cache='default' io='threads' />
I0127 13:00:47.589891 139218 main.go:141] libmachine: (bridge-258288) <source file='/home/jenkins/minikube-integration/20317-81875/.minikube/machines/bridge-258288/bridge-258288.rawdisk'/>
I0127 13:00:47.589901 139218 main.go:141] libmachine: (bridge-258288) <target dev='hda' bus='virtio'/>
I0127 13:00:47.589909 139218 main.go:141] libmachine: (bridge-258288) </disk>
I0127 13:00:47.589919 139218 main.go:141] libmachine: (bridge-258288) <interface type='network'>
I0127 13:00:47.589934 139218 main.go:141] libmachine: (bridge-258288) <source network='mk-bridge-258288'/>
I0127 13:00:47.589944 139218 main.go:141] libmachine: (bridge-258288) <model type='virtio'/>
I0127 13:00:47.589952 139218 main.go:141] libmachine: (bridge-258288) </interface>
I0127 13:00:47.589962 139218 main.go:141] libmachine: (bridge-258288) <interface type='network'>
I0127 13:00:47.589971 139218 main.go:141] libmachine: (bridge-258288) <source network='default'/>
I0127 13:00:47.589980 139218 main.go:141] libmachine: (bridge-258288) <model type='virtio'/>
I0127 13:00:47.589988 139218 main.go:141] libmachine: (bridge-258288) </interface>
I0127 13:00:47.589997 139218 main.go:141] libmachine: (bridge-258288) <serial type='pty'>
I0127 13:00:47.590006 139218 main.go:141] libmachine: (bridge-258288) <target port='0'/>
I0127 13:00:47.590016 139218 main.go:141] libmachine: (bridge-258288) </serial>
I0127 13:00:47.590024 139218 main.go:141] libmachine: (bridge-258288) <console type='pty'>
I0127 13:00:47.590035 139218 main.go:141] libmachine: (bridge-258288) <target type='serial' port='0'/>
I0127 13:00:47.590043 139218 main.go:141] libmachine: (bridge-258288) </console>
I0127 13:00:47.590053 139218 main.go:141] libmachine: (bridge-258288) <rng model='virtio'>
I0127 13:00:47.590062 139218 main.go:141] libmachine: (bridge-258288) <backend model='random'>/dev/random</backend>
I0127 13:00:47.590072 139218 main.go:141] libmachine: (bridge-258288) </rng>
I0127 13:00:47.590079 139218 main.go:141] libmachine: (bridge-258288)
I0127 13:00:47.590087 139218 main.go:141] libmachine: (bridge-258288)
I0127 13:00:47.590095 139218 main.go:141] libmachine: (bridge-258288) </devices>
I0127 13:00:47.590105 139218 main.go:141] libmachine: (bridge-258288) </domain>
I0127 13:00:47.590115 139218 main.go:141] libmachine: (bridge-258288)
I0127 13:00:47.594681 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined MAC address 52:54:00:d0:8e:ad in network default
I0127 13:00:47.595201 139218 main.go:141] libmachine: (bridge-258288) starting domain...
I0127 13:00:47.595229 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:00:47.595237 139218 main.go:141] libmachine: (bridge-258288) ensuring networks are active...
I0127 13:00:47.595966 139218 main.go:141] libmachine: (bridge-258288) Ensuring network default is active
I0127 13:00:47.596351 139218 main.go:141] libmachine: (bridge-258288) Ensuring network mk-bridge-258288 is active
I0127 13:00:47.596922 139218 main.go:141] libmachine: (bridge-258288) getting domain XML...
I0127 13:00:47.597627 139218 main.go:141] libmachine: (bridge-258288) creating domain...
I0127 13:00:49.440518 139218 main.go:141] libmachine: (bridge-258288) waiting for IP...
I0127 13:00:49.441239 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:00:49.441720 139218 main.go:141] libmachine: (bridge-258288) DBG | unable to find current IP address of domain bridge-258288 in network mk-bridge-258288
I0127 13:00:49.441825 139218 main.go:141] libmachine: (bridge-258288) DBG | I0127 13:00:49.441726 139251 retry.go:31] will retry after 230.482147ms: waiting for domain to come up
I0127 13:00:49.674449 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:00:49.675021 139218 main.go:141] libmachine: (bridge-258288) DBG | unable to find current IP address of domain bridge-258288 in network mk-bridge-258288
I0127 13:00:49.675063 139218 main.go:141] libmachine: (bridge-258288) DBG | I0127 13:00:49.675012 139251 retry.go:31] will retry after 336.820107ms: waiting for domain to come up
I0127 13:00:50.013677 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:00:50.014318 139218 main.go:141] libmachine: (bridge-258288) DBG | unable to find current IP address of domain bridge-258288 in network mk-bridge-258288
I0127 13:00:50.014342 139218 main.go:141] libmachine: (bridge-258288) DBG | I0127 13:00:50.014279 139251 retry.go:31] will retry after 345.169421ms: waiting for domain to come up
I0127 13:00:50.360839 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:00:50.361388 139218 main.go:141] libmachine: (bridge-258288) DBG | unable to find current IP address of domain bridge-258288 in network mk-bridge-258288
I0127 13:00:50.361434 139218 main.go:141] libmachine: (bridge-258288) DBG | I0127 13:00:50.361369 139251 retry.go:31] will retry after 498.3993ms: waiting for domain to come up
I0127 13:00:50.861159 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:00:50.861876 139218 main.go:141] libmachine: (bridge-258288) DBG | unable to find current IP address of domain bridge-258288 in network mk-bridge-258288
I0127 13:00:50.861900 139218 main.go:141] libmachine: (bridge-258288) DBG | I0127 13:00:50.861873 139251 retry.go:31] will retry after 475.286925ms: waiting for domain to come up
I0127 13:00:51.338568 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:00:51.339108 139218 main.go:141] libmachine: (bridge-258288) DBG | unable to find current IP address of domain bridge-258288 in network mk-bridge-258288
I0127 13:00:51.339224 139218 main.go:141] libmachine: (bridge-258288) DBG | I0127 13:00:51.339086 139251 retry.go:31] will retry after 892.472118ms: waiting for domain to come up
I0127 13:00:52.312874 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:00:52.313381 139218 main.go:141] libmachine: (bridge-258288) DBG | unable to find current IP address of domain bridge-258288 in network mk-bridge-258288
I0127 13:00:52.313465 139218 main.go:141] libmachine: (bridge-258288) DBG | I0127 13:00:52.313386 139251 retry.go:31] will retry after 1.151240543s: waiting for domain to come up
I0127 13:00:53.466885 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:00:53.467537 139218 main.go:141] libmachine: (bridge-258288) DBG | unable to find current IP address of domain bridge-258288 in network mk-bridge-258288
I0127 13:00:53.467569 139218 main.go:141] libmachine: (bridge-258288) DBG | I0127 13:00:53.467499 139251 retry.go:31] will retry after 1.359046645s: waiting for domain to come up
I0127 13:00:54.829042 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:00:54.829622 139218 main.go:141] libmachine: (bridge-258288) DBG | unable to find current IP address of domain bridge-258288 in network mk-bridge-258288
I0127 13:00:54.829672 139218 main.go:141] libmachine: (bridge-258288) DBG | I0127 13:00:54.829597 139251 retry.go:31] will retry after 1.276349122s: waiting for domain to come up
I0127 13:00:56.107054 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:00:56.107565 139218 main.go:141] libmachine: (bridge-258288) DBG | unable to find current IP address of domain bridge-258288 in network mk-bridge-258288
I0127 13:00:56.107604 139218 main.go:141] libmachine: (bridge-258288) DBG | I0127 13:00:56.107517 139251 retry.go:31] will retry after 2.163229999s: waiting for domain to come up
I0127 13:00:58.272290 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:00:58.272809 139218 main.go:141] libmachine: (bridge-258288) DBG | unable to find current IP address of domain bridge-258288 in network mk-bridge-258288
I0127 13:00:58.272839 139218 main.go:141] libmachine: (bridge-258288) DBG | I0127 13:00:58.272776 139251 retry.go:31] will retry after 2.149315587s: waiting for domain to come up
I0127 13:01:00.424211 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:01:00.424992 139218 main.go:141] libmachine: (bridge-258288) DBG | unable to find current IP address of domain bridge-258288 in network mk-bridge-258288
I0127 13:01:00.425025 139218 main.go:141] libmachine: (bridge-258288) DBG | I0127 13:01:00.424961 139251 retry.go:31] will retry after 3.096056428s: waiting for domain to come up
I0127 13:01:03.523851 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:01:03.524548 139218 main.go:141] libmachine: (bridge-258288) DBG | unable to find current IP address of domain bridge-258288 in network mk-bridge-258288
I0127 13:01:03.524591 139218 main.go:141] libmachine: (bridge-258288) DBG | I0127 13:01:03.524500 139251 retry.go:31] will retry after 3.47805453s: waiting for domain to come up
I0127 13:01:07.004508 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:01:07.005001 139218 main.go:141] libmachine: (bridge-258288) DBG | unable to find current IP address of domain bridge-258288 in network mk-bridge-258288
I0127 13:01:07.005020 139218 main.go:141] libmachine: (bridge-258288) DBG | I0127 13:01:07.004967 139251 retry.go:31] will retry after 4.80565759s: waiting for domain to come up
I0127 13:01:11.812572 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:01:11.813181 139218 main.go:141] libmachine: (bridge-258288) found domain IP: 192.168.72.104
I0127 13:01:11.813216 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has current primary IP address 192.168.72.104 and MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:01:11.813226 139218 main.go:141] libmachine: (bridge-258288) reserving static IP address...
I0127 13:01:11.813680 139218 main.go:141] libmachine: (bridge-258288) DBG | unable to find host DHCP lease matching {name: "bridge-258288", mac: "52:54:00:2e:5f:95", ip: "192.168.72.104"} in network mk-bridge-258288
I0127 13:01:11.897814 139218 main.go:141] libmachine: (bridge-258288) reserved static IP address 192.168.72.104 for domain bridge-258288
I0127 13:01:11.897851 139218 main.go:141] libmachine: (bridge-258288) waiting for SSH...
I0127 13:01:11.897862 139218 main.go:141] libmachine: (bridge-258288) DBG | Getting to WaitForSSH function...
I0127 13:01:11.900757 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:01:11.901306 139218 main.go:141] libmachine: (bridge-258288) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:2e:5f:95", ip: ""} in network mk-bridge-258288: {Iface:virbr4 ExpiryTime:2025-01-27 14:01:03 +0000 UTC Type:0 Mac:52:54:00:2e:5f:95 Iaid: IPaddr:192.168.72.104 Prefix:24 Hostname:minikube Clientid:01:52:54:00:2e:5f:95}
I0127 13:01:11.901343 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined IP address 192.168.72.104 and MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:01:11.901581 139218 main.go:141] libmachine: (bridge-258288) DBG | Using SSH client type: external
I0127 13:01:11.901610 139218 main.go:141] libmachine: (bridge-258288) DBG | Using SSH private key: /home/jenkins/minikube-integration/20317-81875/.minikube/machines/bridge-258288/id_rsa (-rw-------)
I0127 13:01:11.901638 139218 main.go:141] libmachine: (bridge-258288) 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.72.104 -o IdentitiesOnly=yes -i /home/jenkins/minikube-integration/20317-81875/.minikube/machines/bridge-258288/id_rsa -p 22] /usr/bin/ssh <nil>}
I0127 13:01:11.901651 139218 main.go:141] libmachine: (bridge-258288) DBG | About to run SSH command:
I0127 13:01:11.901684 139218 main.go:141] libmachine: (bridge-258288) DBG | exit 0
I0127 13:01:12.038261 139218 main.go:141] libmachine: (bridge-258288) DBG | SSH cmd err, output: <nil>:
I0127 13:01:12.038529 139218 main.go:141] libmachine: (bridge-258288) KVM machine creation complete
I0127 13:01:12.038964 139218 main.go:141] libmachine: (bridge-258288) Calling .GetConfigRaw
I0127 13:01:12.039589 139218 main.go:141] libmachine: (bridge-258288) Calling .DriverName
I0127 13:01:12.039814 139218 main.go:141] libmachine: (bridge-258288) Calling .DriverName
I0127 13:01:12.039981 139218 main.go:141] libmachine: Waiting for machine to be running, this may take a few minutes...
I0127 13:01:12.039998 139218 main.go:141] libmachine: (bridge-258288) Calling .GetState
I0127 13:01:12.041316 139218 main.go:141] libmachine: Detecting operating system of created instance...
I0127 13:01:12.041335 139218 main.go:141] libmachine: Waiting for SSH to be available...
I0127 13:01:12.041343 139218 main.go:141] libmachine: Getting to WaitForSSH function...
I0127 13:01:12.041350 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHHostname
I0127 13:01:12.044126 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:01:12.044492 139218 main.go:141] libmachine: (bridge-258288) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:2e:5f:95", ip: ""} in network mk-bridge-258288: {Iface:virbr4 ExpiryTime:2025-01-27 14:01:03 +0000 UTC Type:0 Mac:52:54:00:2e:5f:95 Iaid: IPaddr:192.168.72.104 Prefix:24 Hostname:bridge-258288 Clientid:01:52:54:00:2e:5f:95}
I0127 13:01:12.044530 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined IP address 192.168.72.104 and MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:01:12.044728 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHPort
I0127 13:01:12.044925 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHKeyPath
I0127 13:01:12.045085 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHKeyPath
I0127 13:01:12.045244 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHUsername
I0127 13:01:12.045433 139218 main.go:141] libmachine: Using SSH client type: native
I0127 13:01:12.045699 139218 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x8641c0] 0x866ea0 <nil> [] 0s} 192.168.72.104 22 <nil> <nil>}
I0127 13:01:12.045714 139218 main.go:141] libmachine: About to run SSH command:
exit 0
I0127 13:01:12.161621 139218 main.go:141] libmachine: SSH cmd err, output: <nil>:
I0127 13:01:12.161674 139218 main.go:141] libmachine: Detecting the provisioner...
I0127 13:01:12.161687 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHHostname
I0127 13:01:12.164873 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:01:12.165324 139218 main.go:141] libmachine: (bridge-258288) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:2e:5f:95", ip: ""} in network mk-bridge-258288: {Iface:virbr4 ExpiryTime:2025-01-27 14:01:03 +0000 UTC Type:0 Mac:52:54:00:2e:5f:95 Iaid: IPaddr:192.168.72.104 Prefix:24 Hostname:bridge-258288 Clientid:01:52:54:00:2e:5f:95}
I0127 13:01:12.165358 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined IP address 192.168.72.104 and MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:01:12.165499 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHPort
I0127 13:01:12.165718 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHKeyPath
I0127 13:01:12.165909 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHKeyPath
I0127 13:01:12.166075 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHUsername
I0127 13:01:12.166281 139218 main.go:141] libmachine: Using SSH client type: native
I0127 13:01:12.166501 139218 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x8641c0] 0x866ea0 <nil> [] 0s} 192.168.72.104 22 <nil> <nil>}
I0127 13:01:12.166519 139218 main.go:141] libmachine: About to run SSH command:
cat /etc/os-release
I0127 13:01:12.284086 139218 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"
I0127 13:01:12.284162 139218 main.go:141] libmachine: found compatible host: buildroot
I0127 13:01:12.284168 139218 main.go:141] libmachine: Provisioning with buildroot...
I0127 13:01:12.284184 139218 main.go:141] libmachine: (bridge-258288) Calling .GetMachineName
I0127 13:01:12.284482 139218 buildroot.go:166] provisioning hostname "bridge-258288"
I0127 13:01:12.284516 139218 main.go:141] libmachine: (bridge-258288) Calling .GetMachineName
I0127 13:01:12.284748 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHHostname
I0127 13:01:12.288255 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:01:12.288831 139218 main.go:141] libmachine: (bridge-258288) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:2e:5f:95", ip: ""} in network mk-bridge-258288: {Iface:virbr4 ExpiryTime:2025-01-27 14:01:03 +0000 UTC Type:0 Mac:52:54:00:2e:5f:95 Iaid: IPaddr:192.168.72.104 Prefix:24 Hostname:bridge-258288 Clientid:01:52:54:00:2e:5f:95}
I0127 13:01:12.288864 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined IP address 192.168.72.104 and MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:01:12.289295 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHPort
I0127 13:01:12.289451 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHKeyPath
I0127 13:01:12.289540 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHKeyPath
I0127 13:01:12.289609 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHUsername
I0127 13:01:12.289739 139218 main.go:141] libmachine: Using SSH client type: native
I0127 13:01:12.289976 139218 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x8641c0] 0x866ea0 <nil> [] 0s} 192.168.72.104 22 <nil> <nil>}
I0127 13:01:12.289997 139218 main.go:141] libmachine: About to run SSH command:
sudo hostname bridge-258288 && echo "bridge-258288" | sudo tee /etc/hostname
I0127 13:01:12.431627 139218 main.go:141] libmachine: SSH cmd err, output: <nil>: bridge-258288
I0127 13:01:12.431661 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHHostname
I0127 13:01:12.434497 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:01:12.434963 139218 main.go:141] libmachine: (bridge-258288) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:2e:5f:95", ip: ""} in network mk-bridge-258288: {Iface:virbr4 ExpiryTime:2025-01-27 14:01:03 +0000 UTC Type:0 Mac:52:54:00:2e:5f:95 Iaid: IPaddr:192.168.72.104 Prefix:24 Hostname:bridge-258288 Clientid:01:52:54:00:2e:5f:95}
I0127 13:01:12.435014 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined IP address 192.168.72.104 and MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:01:12.435223 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHPort
I0127 13:01:12.435398 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHKeyPath
I0127 13:01:12.435566 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHKeyPath
I0127 13:01:12.435766 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHUsername
I0127 13:01:12.435964 139218 main.go:141] libmachine: Using SSH client type: native
I0127 13:01:12.436199 139218 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x8641c0] 0x866ea0 <nil> [] 0s} 192.168.72.104 22 <nil> <nil>}
I0127 13:01:12.436223 139218 main.go:141] libmachine: About to run SSH command:
if ! grep -xq '.*\sbridge-258288' /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 bridge-258288/g' /etc/hosts;
else
echo '127.0.1.1 bridge-258288' | sudo tee -a /etc/hosts;
fi
fi
I0127 13:01:12.565667 139218 main.go:141] libmachine: SSH cmd err, output: <nil>:
I0127 13:01:12.565708 139218 buildroot.go:172] set auth options {CertDir:/home/jenkins/minikube-integration/20317-81875/.minikube CaCertPath:/home/jenkins/minikube-integration/20317-81875/.minikube/certs/ca.pem CaPrivateKeyPath:/home/jenkins/minikube-integration/20317-81875/.minikube/certs/ca-key.pem CaCertRemotePath:/etc/docker/ca.pem ServerCertPath:/home/jenkins/minikube-integration/20317-81875/.minikube/machines/server.pem ServerKeyPath:/home/jenkins/minikube-integration/20317-81875/.minikube/machines/server-key.pem ClientKeyPath:/home/jenkins/minikube-integration/20317-81875/.minikube/certs/key.pem ServerCertRemotePath:/etc/docker/server.pem ServerKeyRemotePath:/etc/docker/server-key.pem ClientCertPath:/home/jenkins/minikube-integration/20317-81875/.minikube/certs/cert.pem ServerCertSANs:[] StorePath:/home/jenkins/minikube-integration/20317-81875/.minikube}
I0127 13:01:12.565743 139218 buildroot.go:174] setting up certificates
I0127 13:01:12.565754 139218 provision.go:84] configureAuth start
I0127 13:01:12.565764 139218 main.go:141] libmachine: (bridge-258288) Calling .GetMachineName
I0127 13:01:12.566042 139218 main.go:141] libmachine: (bridge-258288) Calling .GetIP
I0127 13:01:12.569007 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:01:12.569350 139218 main.go:141] libmachine: (bridge-258288) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:2e:5f:95", ip: ""} in network mk-bridge-258288: {Iface:virbr4 ExpiryTime:2025-01-27 14:01:03 +0000 UTC Type:0 Mac:52:54:00:2e:5f:95 Iaid: IPaddr:192.168.72.104 Prefix:24 Hostname:bridge-258288 Clientid:01:52:54:00:2e:5f:95}
I0127 13:01:12.569384 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined IP address 192.168.72.104 and MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:01:12.569586 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHHostname
I0127 13:01:12.571958 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:01:12.572299 139218 main.go:141] libmachine: (bridge-258288) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:2e:5f:95", ip: ""} in network mk-bridge-258288: {Iface:virbr4 ExpiryTime:2025-01-27 14:01:03 +0000 UTC Type:0 Mac:52:54:00:2e:5f:95 Iaid: IPaddr:192.168.72.104 Prefix:24 Hostname:bridge-258288 Clientid:01:52:54:00:2e:5f:95}
I0127 13:01:12.572326 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined IP address 192.168.72.104 and MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:01:12.572482 139218 provision.go:143] copyHostCerts
I0127 13:01:12.572553 139218 exec_runner.go:144] found /home/jenkins/minikube-integration/20317-81875/.minikube/ca.pem, removing ...
I0127 13:01:12.572567 139218 exec_runner.go:203] rm: /home/jenkins/minikube-integration/20317-81875/.minikube/ca.pem
I0127 13:01:12.572646 139218 exec_runner.go:151] cp: /home/jenkins/minikube-integration/20317-81875/.minikube/certs/ca.pem --> /home/jenkins/minikube-integration/20317-81875/.minikube/ca.pem (1082 bytes)
I0127 13:01:12.572798 139218 exec_runner.go:144] found /home/jenkins/minikube-integration/20317-81875/.minikube/cert.pem, removing ...
I0127 13:01:12.572812 139218 exec_runner.go:203] rm: /home/jenkins/minikube-integration/20317-81875/.minikube/cert.pem
I0127 13:01:12.572846 139218 exec_runner.go:151] cp: /home/jenkins/minikube-integration/20317-81875/.minikube/certs/cert.pem --> /home/jenkins/minikube-integration/20317-81875/.minikube/cert.pem (1123 bytes)
I0127 13:01:12.572920 139218 exec_runner.go:144] found /home/jenkins/minikube-integration/20317-81875/.minikube/key.pem, removing ...
I0127 13:01:12.572928 139218 exec_runner.go:203] rm: /home/jenkins/minikube-integration/20317-81875/.minikube/key.pem
I0127 13:01:12.572950 139218 exec_runner.go:151] cp: /home/jenkins/minikube-integration/20317-81875/.minikube/certs/key.pem --> /home/jenkins/minikube-integration/20317-81875/.minikube/key.pem (1675 bytes)
I0127 13:01:12.573014 139218 provision.go:117] generating server cert: /home/jenkins/minikube-integration/20317-81875/.minikube/machines/server.pem ca-key=/home/jenkins/minikube-integration/20317-81875/.minikube/certs/ca.pem private-key=/home/jenkins/minikube-integration/20317-81875/.minikube/certs/ca-key.pem org=jenkins.bridge-258288 san=[127.0.0.1 192.168.72.104 bridge-258288 localhost minikube]
I0127 13:01:12.716923 139218 provision.go:177] copyRemoteCerts
I0127 13:01:12.716990 139218 ssh_runner.go:195] Run: sudo mkdir -p /etc/docker /etc/docker /etc/docker
I0127 13:01:12.717016 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHHostname
I0127 13:01:12.720336 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:01:12.720746 139218 main.go:141] libmachine: (bridge-258288) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:2e:5f:95", ip: ""} in network mk-bridge-258288: {Iface:virbr4 ExpiryTime:2025-01-27 14:01:03 +0000 UTC Type:0 Mac:52:54:00:2e:5f:95 Iaid: IPaddr:192.168.72.104 Prefix:24 Hostname:bridge-258288 Clientid:01:52:54:00:2e:5f:95}
I0127 13:01:12.720779 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined IP address 192.168.72.104 and MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:01:12.720972 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHPort
I0127 13:01:12.721230 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHKeyPath
I0127 13:01:12.721404 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHUsername
I0127 13:01:12.721601 139218 sshutil.go:53] new ssh client: &{IP:192.168.72.104 Port:22 SSHKeyPath:/home/jenkins/minikube-integration/20317-81875/.minikube/machines/bridge-258288/id_rsa Username:docker}
I0127 13:01:12.809757 139218 ssh_runner.go:362] scp /home/jenkins/minikube-integration/20317-81875/.minikube/machines/server.pem --> /etc/docker/server.pem (1208 bytes)
I0127 13:01:12.836614 139218 ssh_runner.go:362] scp /home/jenkins/minikube-integration/20317-81875/.minikube/machines/server-key.pem --> /etc/docker/server-key.pem (1679 bytes)
I0127 13:01:12.863025 139218 ssh_runner.go:362] scp /home/jenkins/minikube-integration/20317-81875/.minikube/certs/ca.pem --> /etc/docker/ca.pem (1082 bytes)
I0127 13:01:12.891814 139218 provision.go:87] duration metric: took 326.044082ms to configureAuth
I0127 13:01:12.891852 139218 buildroot.go:189] setting minikube options for container-runtime
I0127 13:01:12.892110 139218 config.go:182] Loaded profile config "bridge-258288": Driver=kvm2, ContainerRuntime=docker, KubernetesVersion=v1.32.1
I0127 13:01:12.892149 139218 main.go:141] libmachine: (bridge-258288) Calling .DriverName
I0127 13:01:12.892459 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHHostname
I0127 13:01:12.895501 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:01:12.896032 139218 main.go:141] libmachine: (bridge-258288) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:2e:5f:95", ip: ""} in network mk-bridge-258288: {Iface:virbr4 ExpiryTime:2025-01-27 14:01:03 +0000 UTC Type:0 Mac:52:54:00:2e:5f:95 Iaid: IPaddr:192.168.72.104 Prefix:24 Hostname:bridge-258288 Clientid:01:52:54:00:2e:5f:95}
I0127 13:01:12.896065 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined IP address 192.168.72.104 and MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:01:12.896269 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHPort
I0127 13:01:12.896485 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHKeyPath
I0127 13:01:12.896678 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHKeyPath
I0127 13:01:12.896819 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHUsername
I0127 13:01:12.897016 139218 main.go:141] libmachine: Using SSH client type: native
I0127 13:01:12.897238 139218 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x8641c0] 0x866ea0 <nil> [] 0s} 192.168.72.104 22 <nil> <nil>}
I0127 13:01:12.897252 139218 main.go:141] libmachine: About to run SSH command:
df --output=fstype / | tail -n 1
I0127 13:01:13.015622 139218 main.go:141] libmachine: SSH cmd err, output: <nil>: tmpfs
I0127 13:01:13.015703 139218 buildroot.go:70] root file system type: tmpfs
I0127 13:01:13.015873 139218 provision.go:314] Updating docker unit: /lib/systemd/system/docker.service ...
I0127 13:01:13.015912 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHHostname
I0127 13:01:13.018941 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:01:13.019385 139218 main.go:141] libmachine: (bridge-258288) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:2e:5f:95", ip: ""} in network mk-bridge-258288: {Iface:virbr4 ExpiryTime:2025-01-27 14:01:03 +0000 UTC Type:0 Mac:52:54:00:2e:5f:95 Iaid: IPaddr:192.168.72.104 Prefix:24 Hostname:bridge-258288 Clientid:01:52:54:00:2e:5f:95}
I0127 13:01:13.019423 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined IP address 192.168.72.104 and MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:01:13.019574 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHPort
I0127 13:01:13.019760 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHKeyPath
I0127 13:01:13.019933 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHKeyPath
I0127 13:01:13.020104 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHUsername
I0127 13:01:13.020299 139218 main.go:141] libmachine: Using SSH client type: native
I0127 13:01:13.020559 139218 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x8641c0] 0x866ea0 <nil> [] 0s} 192.168.72.104 22 <nil> <nil>}
I0127 13:01:13.020689 139218 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
I0127 13:01:13.155423 139218 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
I0127 13:01:13.155456 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHHostname
I0127 13:01:13.158414 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:01:13.158745 139218 main.go:141] libmachine: (bridge-258288) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:2e:5f:95", ip: ""} in network mk-bridge-258288: {Iface:virbr4 ExpiryTime:2025-01-27 14:01:03 +0000 UTC Type:0 Mac:52:54:00:2e:5f:95 Iaid: IPaddr:192.168.72.104 Prefix:24 Hostname:bridge-258288 Clientid:01:52:54:00:2e:5f:95}
I0127 13:01:13.158776 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined IP address 192.168.72.104 and MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:01:13.158955 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHPort
I0127 13:01:13.159155 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHKeyPath
I0127 13:01:13.159351 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHKeyPath
I0127 13:01:13.159528 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHUsername
I0127 13:01:13.159730 139218 main.go:141] libmachine: Using SSH client type: native
I0127 13:01:13.159957 139218 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x8641c0] 0x866ea0 <nil> [] 0s} 192.168.72.104 22 <nil> <nil>}
I0127 13:01:13.159981 139218 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; }
I0127 13:01:15.036481 139218 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.
I0127 13:01:15.036509 139218 main.go:141] libmachine: Checking connection to Docker...
I0127 13:01:15.036536 139218 main.go:141] libmachine: (bridge-258288) Calling .GetURL
I0127 13:01:15.038125 139218 main.go:141] libmachine: (bridge-258288) DBG | using libvirt version 6000000
I0127 13:01:15.040452 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:01:15.040872 139218 main.go:141] libmachine: (bridge-258288) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:2e:5f:95", ip: ""} in network mk-bridge-258288: {Iface:virbr4 ExpiryTime:2025-01-27 14:01:03 +0000 UTC Type:0 Mac:52:54:00:2e:5f:95 Iaid: IPaddr:192.168.72.104 Prefix:24 Hostname:bridge-258288 Clientid:01:52:54:00:2e:5f:95}
I0127 13:01:15.040905 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined IP address 192.168.72.104 and MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:01:15.041087 139218 main.go:141] libmachine: Docker is up and running!
I0127 13:01:15.041103 139218 main.go:141] libmachine: Reticulating splines...
I0127 13:01:15.041112 139218 client.go:171] duration metric: took 28.266231864s to LocalClient.Create
I0127 13:01:15.041145 139218 start.go:167] duration metric: took 28.26629807s to libmachine.API.Create "bridge-258288"
I0127 13:01:15.041176 139218 start.go:293] postStartSetup for "bridge-258288" (driver="kvm2")
I0127 13:01:15.041191 139218 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]
I0127 13:01:15.041221 139218 main.go:141] libmachine: (bridge-258288) Calling .DriverName
I0127 13:01:15.041481 139218 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
I0127 13:01:15.041516 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHHostname
I0127 13:01:15.044342 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:01:15.044739 139218 main.go:141] libmachine: (bridge-258288) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:2e:5f:95", ip: ""} in network mk-bridge-258288: {Iface:virbr4 ExpiryTime:2025-01-27 14:01:03 +0000 UTC Type:0 Mac:52:54:00:2e:5f:95 Iaid: IPaddr:192.168.72.104 Prefix:24 Hostname:bridge-258288 Clientid:01:52:54:00:2e:5f:95}
I0127 13:01:15.044786 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined IP address 192.168.72.104 and MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:01:15.044982 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHPort
I0127 13:01:15.045173 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHKeyPath
I0127 13:01:15.045379 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHUsername
I0127 13:01:15.045548 139218 sshutil.go:53] new ssh client: &{IP:192.168.72.104 Port:22 SSHKeyPath:/home/jenkins/minikube-integration/20317-81875/.minikube/machines/bridge-258288/id_rsa Username:docker}
I0127 13:01:15.132611 139218 ssh_runner.go:195] Run: cat /etc/os-release
I0127 13:01:15.138615 139218 info.go:137] Remote host: Buildroot 2023.02.9
I0127 13:01:15.138651 139218 filesync.go:126] Scanning /home/jenkins/minikube-integration/20317-81875/.minikube/addons for local assets ...
I0127 13:01:15.138727 139218 filesync.go:126] Scanning /home/jenkins/minikube-integration/20317-81875/.minikube/files for local assets ...
I0127 13:01:15.138854 139218 filesync.go:149] local asset: /home/jenkins/minikube-integration/20317-81875/.minikube/files/etc/ssl/certs/890712.pem -> 890712.pem in /etc/ssl/certs
I0127 13:01:15.138992 139218 ssh_runner.go:195] Run: sudo mkdir -p /etc/ssl/certs
I0127 13:01:15.148481 139218 ssh_runner.go:362] scp /home/jenkins/minikube-integration/20317-81875/.minikube/files/etc/ssl/certs/890712.pem --> /etc/ssl/certs/890712.pem (1708 bytes)
I0127 13:01:15.178610 139218 start.go:296] duration metric: took 137.413289ms for postStartSetup
I0127 13:01:15.178701 139218 main.go:141] libmachine: (bridge-258288) Calling .GetConfigRaw
I0127 13:01:15.179332 139218 main.go:141] libmachine: (bridge-258288) Calling .GetIP
I0127 13:01:15.182293 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:01:15.182664 139218 main.go:141] libmachine: (bridge-258288) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:2e:5f:95", ip: ""} in network mk-bridge-258288: {Iface:virbr4 ExpiryTime:2025-01-27 14:01:03 +0000 UTC Type:0 Mac:52:54:00:2e:5f:95 Iaid: IPaddr:192.168.72.104 Prefix:24 Hostname:bridge-258288 Clientid:01:52:54:00:2e:5f:95}
I0127 13:01:15.182695 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined IP address 192.168.72.104 and MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:01:15.182947 139218 profile.go:143] Saving config to /home/jenkins/minikube-integration/20317-81875/.minikube/profiles/bridge-258288/config.json ...
I0127 13:01:15.183137 139218 start.go:128] duration metric: took 28.431418291s to createHost
I0127 13:01:15.183160 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHHostname
I0127 13:01:15.185840 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:01:15.186259 139218 main.go:141] libmachine: (bridge-258288) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:2e:5f:95", ip: ""} in network mk-bridge-258288: {Iface:virbr4 ExpiryTime:2025-01-27 14:01:03 +0000 UTC Type:0 Mac:52:54:00:2e:5f:95 Iaid: IPaddr:192.168.72.104 Prefix:24 Hostname:bridge-258288 Clientid:01:52:54:00:2e:5f:95}
I0127 13:01:15.186284 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined IP address 192.168.72.104 and MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:01:15.186566 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHPort
I0127 13:01:15.186783 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHKeyPath
I0127 13:01:15.186977 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHKeyPath
I0127 13:01:15.187149 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHUsername
I0127 13:01:15.187357 139218 main.go:141] libmachine: Using SSH client type: native
I0127 13:01:15.187561 139218 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x8641c0] 0x866ea0 <nil> [] 0s} 192.168.72.104 22 <nil> <nil>}
I0127 13:01:15.187574 139218 main.go:141] libmachine: About to run SSH command:
date +%s.%N
I0127 13:01:15.311771 139218 main.go:141] libmachine: SSH cmd err, output: <nil>: 1737982875.285181771
I0127 13:01:15.311800 139218 fix.go:216] guest clock: 1737982875.285181771
I0127 13:01:15.311809 139218 fix.go:229] Guest: 2025-01-27 13:01:15.285181771 +0000 UTC Remote: 2025-01-27 13:01:15.183149392 +0000 UTC m=+28.604624303 (delta=102.032379ms)
I0127 13:01:15.311847 139218 fix.go:200] guest clock delta is within tolerance: 102.032379ms
I0127 13:01:15.311853 139218 start.go:83] releasing machines lock for "bridge-258288", held for 28.560242669s
I0127 13:01:15.312413 139218 main.go:141] libmachine: (bridge-258288) Calling .DriverName
I0127 13:01:15.312778 139218 main.go:141] libmachine: (bridge-258288) Calling .GetIP
I0127 13:01:15.316583 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:01:15.317064 139218 main.go:141] libmachine: (bridge-258288) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:2e:5f:95", ip: ""} in network mk-bridge-258288: {Iface:virbr4 ExpiryTime:2025-01-27 14:01:03 +0000 UTC Type:0 Mac:52:54:00:2e:5f:95 Iaid: IPaddr:192.168.72.104 Prefix:24 Hostname:bridge-258288 Clientid:01:52:54:00:2e:5f:95}
I0127 13:01:15.317089 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined IP address 192.168.72.104 and MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:01:15.317395 139218 main.go:141] libmachine: (bridge-258288) Calling .DriverName
I0127 13:01:15.318026 139218 main.go:141] libmachine: (bridge-258288) Calling .DriverName
I0127 13:01:15.318237 139218 main.go:141] libmachine: (bridge-258288) Calling .DriverName
I0127 13:01:15.318354 139218 ssh_runner.go:195] Run: curl -sS -m 2 https://registry.k8s.io/
I0127 13:01:15.318396 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHHostname
I0127 13:01:15.318495 139218 ssh_runner.go:195] Run: cat /version.json
I0127 13:01:15.318511 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHHostname
I0127 13:01:15.321165 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:01:15.321235 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:01:15.321575 139218 main.go:141] libmachine: (bridge-258288) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:2e:5f:95", ip: ""} in network mk-bridge-258288: {Iface:virbr4 ExpiryTime:2025-01-27 14:01:03 +0000 UTC Type:0 Mac:52:54:00:2e:5f:95 Iaid: IPaddr:192.168.72.104 Prefix:24 Hostname:bridge-258288 Clientid:01:52:54:00:2e:5f:95}
I0127 13:01:15.321602 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined IP address 192.168.72.104 and MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:01:15.321629 139218 main.go:141] libmachine: (bridge-258288) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:2e:5f:95", ip: ""} in network mk-bridge-258288: {Iface:virbr4 ExpiryTime:2025-01-27 14:01:03 +0000 UTC Type:0 Mac:52:54:00:2e:5f:95 Iaid: IPaddr:192.168.72.104 Prefix:24 Hostname:bridge-258288 Clientid:01:52:54:00:2e:5f:95}
I0127 13:01:15.321643 139218 main.go:141] libmachine: (bridge-258288) DBG | domain bridge-258288 has defined IP address 192.168.72.104 and MAC address 52:54:00:2e:5f:95 in network mk-bridge-258288
I0127 13:01:15.321871 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHPort
I0127 13:01:15.322065 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHKeyPath
I0127 13:01:15.322152 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHPort
I0127 13:01:15.322295 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHKeyPath
I0127 13:01:15.322309 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHUsername
I0127 13:01:15.322459 139218 main.go:141] libmachine: (bridge-258288) Calling .GetSSHUsername
I0127 13:01:15.322512 139218 sshutil.go:53] new ssh client: &{IP:192.168.72.104 Port:22 SSHKeyPath:/home/jenkins/minikube-integration/20317-81875/.minikube/machines/bridge-258288/id_rsa Username:docker}
I0127 13:01:15.322849 139218 sshutil.go:53] new ssh client: &{IP:192.168.72.104 Port:22 SSHKeyPath:/home/jenkins/minikube-integration/20317-81875/.minikube/machines/bridge-258288/id_rsa Username:docker}
I0127 13:01:15.457091 139218 ssh_runner.go:195] Run: systemctl --version
I0127 13:01:15.464555 139218 ssh_runner.go:195] Run: sh -c "stat /etc/cni/net.d/*loopback.conf*"
W0127 13:01:15.470679 139218 cni.go:209] loopback cni configuration skipped: "/etc/cni/net.d/*loopback.conf*" not found
I0127 13:01:15.470790 139218 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" ;
I0127 13:01:15.491590 139218 cni.go:262] disabled [/etc/cni/net.d/87-podman-bridge.conflist] bridge cni config(s)
I0127 13:01:15.491623 139218 start.go:495] detecting cgroup driver to use...
I0127 13:01:15.491766 139218 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"
I0127 13:01:15.519566 139218 ssh_runner.go:195] Run: sh -c "sudo sed -i -r 's|^( *)sandbox_image = .*$|\1sandbox_image = "registry.k8s.io/pause:3.10"|' /etc/containerd/config.toml"
I0127 13:01:15.531186 139218 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"
I0127 13:01:15.548053 139218 containerd.go:146] configuring containerd to use "cgroupfs" as cgroup driver...
I0127 13:01:15.548115 139218 ssh_runner.go:195] Run: sh -c "sudo sed -i -r 's|^( *)SystemdCgroup = .*$|\1SystemdCgroup = false|g' /etc/containerd/config.toml"
I0127 13:01:15.565305 139218 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"
I0127 13:01:15.582913 139218 ssh_runner.go:195] Run: sh -c "sudo sed -i '/systemd_cgroup/d' /etc/containerd/config.toml"
I0127 13:01:15.595247 139218 ssh_runner.go:195] Run: sh -c "sudo sed -i 's|"io.containerd.runc.v1"|"io.containerd.runc.v2"|g' /etc/containerd/config.toml"
I0127 13:01:15.611431 139218 ssh_runner.go:195] Run: sh -c "sudo rm -rf /etc/cni/net.mk"
I0127 13:01:15.623915 139218 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"
I0127 13:01:15.640057 139218 ssh_runner.go:195] Run: sh -c "sudo sed -i '/^ *enable_unprivileged_ports = .*/d' /etc/containerd/config.toml"
I0127 13:01:15.656097 139218 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"
I0127 13:01:15.670280 139218 ssh_runner.go:195] Run: sudo sysctl net.bridge.bridge-nf-call-iptables
I0127 13:01:15.679869 139218 crio.go:166] couldn't verify netfilter by "sudo sysctl net.bridge.bridge-nf-call-iptables" which might be okay. error: sudo sysctl net.bridge.bridge-nf-call-iptables: Process exited with status 255
stdout:
stderr:
sysctl: cannot stat /proc/sys/net/bridge/bridge-nf-call-iptables: No such file or directory
I0127 13:01:15.679939 139218 ssh_runner.go:195] Run: sudo modprobe br_netfilter
I0127 13:01:15.691872 139218 ssh_runner.go:195] Run: sudo sh -c "echo 1 > /proc/sys/net/ipv4/ip_forward"
I0127 13:01:15.703945 139218 ssh_runner.go:195] Run: sudo systemctl daemon-reload
I0127 13:01:15.853299 139218 ssh_runner.go:195] Run: sudo systemctl restart containerd
I0127 13:01:15.881527 139218 start.go:495] detecting cgroup driver to use...
I0127 13:01:15.881632 139218 ssh_runner.go:195] Run: sudo systemctl cat docker.service
I0127 13:01:15.912377 139218 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service containerd
I0127 13:01:15.935386 139218 ssh_runner.go:195] Run: sudo systemctl stop -f containerd
I0127 13:01:15.968468 139218 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service containerd
I0127 13:01:15.984762 139218 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service crio
I0127 13:01:15.998693 139218 ssh_runner.go:195] Run: sudo systemctl stop -f crio
I0127 13:01:16.318479 139218 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service crio
I0127 13:01:16.333778 139218 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"
I0127 13:01:16.354871 139218 ssh_runner.go:195] Run: which cri-dockerd
I0127 13:01:16.359724 139218 ssh_runner.go:195] Run: sudo mkdir -p /etc/systemd/system/cri-docker.service.d
I0127 13:01:16.371382 139218 ssh_runner.go:362] scp memory --> /etc/systemd/system/cri-docker.service.d/10-cni.conf (190 bytes)
I0127 13:01:16.396236 139218 ssh_runner.go:195] Run: sudo systemctl unmask docker.service
I0127 13:01:16.530277 139218 ssh_runner.go:195] Run: sudo systemctl enable docker.socket
I0127 13:01:16.645004 139218 docker.go:574] configuring docker to use "cgroupfs" as cgroup driver...
I0127 13:01:16.645161 139218 ssh_runner.go:362] scp memory --> /etc/docker/daemon.json (130 bytes)
I0127 13:01:16.662321 139218 ssh_runner.go:195] Run: sudo systemctl daemon-reload
I0127 13:01:16.792198 139218 ssh_runner.go:195] Run: sudo systemctl restart docker
I0127 13:02:17.870531 139218 ssh_runner.go:235] Completed: sudo systemctl restart docker: (1m1.078289051s)
I0127 13:02:17.870616 139218 ssh_runner.go:195] Run: sudo journalctl --no-pager -u docker
I0127 13:02:17.904734 139218 out.go:201]
W0127 13:02:17.906271 139218 out.go:270] X Exiting due to RUNTIME_ENABLE: Failed to enable container runtime: sudo systemctl restart docker: Process exited with status 1
stdout:
stderr:
Job for docker.service failed because the control process exited with error code.
See "systemctl status docker.service" and "journalctl -xeu docker.service" for details.
sudo journalctl --no-pager -u docker:
-- stdout --
Jan 27 13:01:13 bridge-258288 systemd[1]: Starting Docker Application Container Engine...
Jan 27 13:01:13 bridge-258288 dockerd[527]: time="2025-01-27T13:01:13.591875594Z" level=info msg="Starting up"
Jan 27 13:01:13 bridge-258288 dockerd[527]: time="2025-01-27T13:01:13.592693921Z" level=info msg="containerd not running, starting managed containerd"
Jan 27 13:01:13 bridge-258288 dockerd[527]: time="2025-01-27T13:01:13.593468919Z" level=info msg="started new containerd process" address=/var/run/docker/containerd/containerd.sock module=libcontainerd pid=533
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.630481032Z" level=info msg="starting containerd" revision=57f17b0a6295a39009d861b89e3b3b87b005ca27 version=v1.7.23
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.653640479Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.653820836Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.653963634Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.654039495Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.654277517Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.654370396Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.654713325Z" 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
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.654808699Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.654871345Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.654934485Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.655150646Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.655536758Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.658376047Z" 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
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.658473698Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.658738887Z" 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
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.658817061Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.658986365Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.659089010Z" level=info msg="metadata content store policy set" policy=shared
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.672789675Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.673052641Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.673171905Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.673248429Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.673325127Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.673537098Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674087681Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674347817Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674396136Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674419016Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674439862Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674463847Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674480493Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674492858Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674505193Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674518239Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674530666Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674541325Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674577803Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674591514Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674603368Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674621225Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674637829Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674656340Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674673558Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674694094Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674712276Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674737123Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674753420Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674769528Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674788101Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674810412Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674867541Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674901076Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674942443Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.675034629Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.675080508Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.675156375Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.675182175Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.675220279Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.675242688Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.675271881Z" level=info msg="NRI interface is disabled by configuration."
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.675633777Z" level=info msg=serving... address=/var/run/docker/containerd/containerd-debug.sock
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.675711236Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock.ttrpc
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.675757387Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.675776091Z" level=info msg="containerd successfully booted in 0.046419s"
Jan 27 13:01:14 bridge-258288 dockerd[527]: time="2025-01-27T13:01:14.640290915Z" level=info msg="[graphdriver] trying configured driver: overlay2"
Jan 27 13:01:14 bridge-258288 dockerd[527]: time="2025-01-27T13:01:14.662006124Z" level=info msg="Loading containers: start."
Jan 27 13:01:14 bridge-258288 dockerd[527]: time="2025-01-27T13:01:14.782640568Z" level=warning msg="ip6tables is enabled, but cannot set up ip6tables chains" error="failed to create NAT chain DOCKER: iptables failed: ip6tables --wait -t nat -N DOCKER: ip6tables v1.8.9 (legacy): can't initialize ip6tables table `nat': Table does not exist (do you need to insmod?)\nPerhaps ip6tables or your kernel needs to be upgraded.\n (exit status 3)"
Jan 27 13:01:14 bridge-258288 dockerd[527]: time="2025-01-27T13:01:14.939728735Z" level=info msg="Loading containers: done."
Jan 27 13:01:14 bridge-258288 dockerd[527]: time="2025-01-27T13:01:14.954484572Z" level=warning msg="WARNING: bridge-nf-call-iptables is disabled"
Jan 27 13:01:14 bridge-258288 dockerd[527]: time="2025-01-27T13:01:14.954584972Z" level=warning msg="WARNING: bridge-nf-call-ip6tables is disabled"
Jan 27 13:01:14 bridge-258288 dockerd[527]: time="2025-01-27T13:01:14.954634746Z" level=info msg="Docker daemon" commit=92a8393 containerd-snapshotter=false storage-driver=overlay2 version=27.4.0
Jan 27 13:01:14 bridge-258288 dockerd[527]: time="2025-01-27T13:01:14.954776126Z" level=info msg="Daemon has completed initialization"
Jan 27 13:01:15 bridge-258288 dockerd[527]: time="2025-01-27T13:01:15.012566056Z" level=info msg="API listen on /var/run/docker.sock"
Jan 27 13:01:15 bridge-258288 systemd[1]: Started Docker Application Container Engine.
Jan 27 13:01:15 bridge-258288 dockerd[527]: time="2025-01-27T13:01:15.012773307Z" level=info msg="API listen on [::]:2376"
Jan 27 13:01:16 bridge-258288 dockerd[527]: time="2025-01-27T13:01:16.787050495Z" level=info msg="Processing signal 'terminated'"
Jan 27 13:01:16 bridge-258288 dockerd[527]: time="2025-01-27T13:01:16.788718407Z" level=info msg="stopping event stream following graceful shutdown" error="<nil>" module=libcontainerd namespace=moby
Jan 27 13:01:16 bridge-258288 systemd[1]: Stopping Docker Application Container Engine...
Jan 27 13:01:16 bridge-258288 dockerd[527]: time="2025-01-27T13:01:16.789613839Z" level=info msg="stopping healthcheck following graceful shutdown" module=libcontainerd
Jan 27 13:01:16 bridge-258288 dockerd[527]: time="2025-01-27T13:01:16.789975196Z" level=info msg="stopping event stream following graceful shutdown" error="context canceled" module=libcontainerd namespace=plugins.moby
Jan 27 13:01:16 bridge-258288 dockerd[527]: time="2025-01-27T13:01:16.790083046Z" level=info msg="Daemon shutdown complete"
Jan 27 13:01:17 bridge-258288 systemd[1]: docker.service: Deactivated successfully.
Jan 27 13:01:17 bridge-258288 systemd[1]: Stopped Docker Application Container Engine.
Jan 27 13:01:17 bridge-258288 systemd[1]: Starting Docker Application Container Engine...
Jan 27 13:01:17 bridge-258288 dockerd[854]: time="2025-01-27T13:01:17.830738239Z" level=info msg="Starting up"
Jan 27 13:02:17 bridge-258288 dockerd[854]: failed to start daemon: failed to dial "/run/containerd/containerd.sock": failed to dial "/run/containerd/containerd.sock": context deadline exceeded
Jan 27 13:02:17 bridge-258288 systemd[1]: docker.service: Main process exited, code=exited, status=1/FAILURE
Jan 27 13:02:17 bridge-258288 systemd[1]: docker.service: Failed with result 'exit-code'.
Jan 27 13:02:17 bridge-258288 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 --
Jan 27 13:01:13 bridge-258288 systemd[1]: Starting Docker Application Container Engine...
Jan 27 13:01:13 bridge-258288 dockerd[527]: time="2025-01-27T13:01:13.591875594Z" level=info msg="Starting up"
Jan 27 13:01:13 bridge-258288 dockerd[527]: time="2025-01-27T13:01:13.592693921Z" level=info msg="containerd not running, starting managed containerd"
Jan 27 13:01:13 bridge-258288 dockerd[527]: time="2025-01-27T13:01:13.593468919Z" level=info msg="started new containerd process" address=/var/run/docker/containerd/containerd.sock module=libcontainerd pid=533
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.630481032Z" level=info msg="starting containerd" revision=57f17b0a6295a39009d861b89e3b3b87b005ca27 version=v1.7.23
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.653640479Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.653820836Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.653963634Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.654039495Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.654277517Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.654370396Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.654713325Z" 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
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.654808699Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.654871345Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.654934485Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.655150646Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.655536758Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.658376047Z" 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
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.658473698Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.658738887Z" 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
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.658817061Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.658986365Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.659089010Z" level=info msg="metadata content store policy set" policy=shared
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.672789675Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.673052641Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.673171905Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.673248429Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.673325127Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.673537098Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674087681Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674347817Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674396136Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674419016Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674439862Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674463847Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674480493Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674492858Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674505193Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674518239Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674530666Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674541325Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674577803Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674591514Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674603368Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674621225Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674637829Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674656340Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674673558Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674694094Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674712276Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674737123Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674753420Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674769528Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674788101Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674810412Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674867541Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674901076Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.674942443Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.675034629Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.675080508Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.675156375Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.675182175Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.675220279Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.675242688Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.675271881Z" level=info msg="NRI interface is disabled by configuration."
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.675633777Z" level=info msg=serving... address=/var/run/docker/containerd/containerd-debug.sock
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.675711236Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock.ttrpc
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.675757387Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock
Jan 27 13:01:13 bridge-258288 dockerd[533]: time="2025-01-27T13:01:13.675776091Z" level=info msg="containerd successfully booted in 0.046419s"
Jan 27 13:01:14 bridge-258288 dockerd[527]: time="2025-01-27T13:01:14.640290915Z" level=info msg="[graphdriver] trying configured driver: overlay2"
Jan 27 13:01:14 bridge-258288 dockerd[527]: time="2025-01-27T13:01:14.662006124Z" level=info msg="Loading containers: start."
Jan 27 13:01:14 bridge-258288 dockerd[527]: time="2025-01-27T13:01:14.782640568Z" level=warning msg="ip6tables is enabled, but cannot set up ip6tables chains" error="failed to create NAT chain DOCKER: iptables failed: ip6tables --wait -t nat -N DOCKER: ip6tables v1.8.9 (legacy): can't initialize ip6tables table `nat': Table does not exist (do you need to insmod?)\nPerhaps ip6tables or your kernel needs to be upgraded.\n (exit status 3)"
Jan 27 13:01:14 bridge-258288 dockerd[527]: time="2025-01-27T13:01:14.939728735Z" level=info msg="Loading containers: done."
Jan 27 13:01:14 bridge-258288 dockerd[527]: time="2025-01-27T13:01:14.954484572Z" level=warning msg="WARNING: bridge-nf-call-iptables is disabled"
Jan 27 13:01:14 bridge-258288 dockerd[527]: time="2025-01-27T13:01:14.954584972Z" level=warning msg="WARNING: bridge-nf-call-ip6tables is disabled"
Jan 27 13:01:14 bridge-258288 dockerd[527]: time="2025-01-27T13:01:14.954634746Z" level=info msg="Docker daemon" commit=92a8393 containerd-snapshotter=false storage-driver=overlay2 version=27.4.0
Jan 27 13:01:14 bridge-258288 dockerd[527]: time="2025-01-27T13:01:14.954776126Z" level=info msg="Daemon has completed initialization"
Jan 27 13:01:15 bridge-258288 dockerd[527]: time="2025-01-27T13:01:15.012566056Z" level=info msg="API listen on /var/run/docker.sock"
Jan 27 13:01:15 bridge-258288 systemd[1]: Started Docker Application Container Engine.
Jan 27 13:01:15 bridge-258288 dockerd[527]: time="2025-01-27T13:01:15.012773307Z" level=info msg="API listen on [::]:2376"
Jan 27 13:01:16 bridge-258288 dockerd[527]: time="2025-01-27T13:01:16.787050495Z" level=info msg="Processing signal 'terminated'"
Jan 27 13:01:16 bridge-258288 dockerd[527]: time="2025-01-27T13:01:16.788718407Z" level=info msg="stopping event stream following graceful shutdown" error="<nil>" module=libcontainerd namespace=moby
Jan 27 13:01:16 bridge-258288 systemd[1]: Stopping Docker Application Container Engine...
Jan 27 13:01:16 bridge-258288 dockerd[527]: time="2025-01-27T13:01:16.789613839Z" level=info msg="stopping healthcheck following graceful shutdown" module=libcontainerd
Jan 27 13:01:16 bridge-258288 dockerd[527]: time="2025-01-27T13:01:16.789975196Z" level=info msg="stopping event stream following graceful shutdown" error="context canceled" module=libcontainerd namespace=plugins.moby
Jan 27 13:01:16 bridge-258288 dockerd[527]: time="2025-01-27T13:01:16.790083046Z" level=info msg="Daemon shutdown complete"
Jan 27 13:01:17 bridge-258288 systemd[1]: docker.service: Deactivated successfully.
Jan 27 13:01:17 bridge-258288 systemd[1]: Stopped Docker Application Container Engine.
Jan 27 13:01:17 bridge-258288 systemd[1]: Starting Docker Application Container Engine...
Jan 27 13:01:17 bridge-258288 dockerd[854]: time="2025-01-27T13:01:17.830738239Z" level=info msg="Starting up"
Jan 27 13:02:17 bridge-258288 dockerd[854]: failed to start daemon: failed to dial "/run/containerd/containerd.sock": failed to dial "/run/containerd/containerd.sock": context deadline exceeded
Jan 27 13:02:17 bridge-258288 systemd[1]: docker.service: Main process exited, code=exited, status=1/FAILURE
Jan 27 13:02:17 bridge-258288 systemd[1]: docker.service: Failed with result 'exit-code'.
Jan 27 13:02:17 bridge-258288 systemd[1]: Failed to start Docker Application Container Engine.
-- /stdout --
W0127 13:02:17.906346 139218 out.go:270] *
*
W0127 13:02:17.908765 139218 out.go:293] ╭─────────────────────────────────────────────────────────────────────────────────────────────╮
│ │
│ * If the above advice does not help, please let us know: │
│ https://github.com/kubernetes/minikube/issues/new/choose │
│ │
│ * Please run `minikube logs --file=logs.txt` and attach logs.txt to the GitHub issue. │
│ │
╰─────────────────────────────────────────────────────────────────────────────────────────────╯
╭─────────────────────────────────────────────────────────────────────────────────────────────╮
│ │
│ * If the above advice does not help, please let us know: │
│ https://github.com/kubernetes/minikube/issues/new/choose │
│ │
│ * Please run `minikube logs --file=logs.txt` and attach logs.txt to the GitHub issue. │
│ │
╰─────────────────────────────────────────────────────────────────────────────────────────────╯
I0127 13:02:17.910652 139218 out.go:201]
** /stderr **
net_test.go:114: failed start: exit status 90
--- FAIL: TestNetworkPlugins/group/bridge/Start (91.38s)
E0127 13:08:19.231478 89071 cert_rotation.go:171] "Unhandled Error" err="key failed with : open /home/jenkins/minikube-integration/20317-81875/.minikube/profiles/default-k8s-diff-port-984939/client.crt: no such file or directory" logger="UnhandledError"
E0127 13:08:19.237902 89071 cert_rotation.go:171] "Unhandled Error" err="key failed with : open /home/jenkins/minikube-integration/20317-81875/.minikube/profiles/default-k8s-diff-port-984939/client.crt: no such file or directory" logger="UnhandledError"
E0127 13:08:19.249313 89071 cert_rotation.go:171] "Unhandled Error" err="key failed with : open /home/jenkins/minikube-integration/20317-81875/.minikube/profiles/default-k8s-diff-port-984939/client.crt: no such file or directory" logger="UnhandledError"
E0127 13:08:19.270747 89071 cert_rotation.go:171] "Unhandled Error" err="key failed with : open /home/jenkins/minikube-integration/20317-81875/.minikube/profiles/default-k8s-diff-port-984939/client.crt: no such file or directory" logger="UnhandledError"
E0127 13:08:19.312222 89071 cert_rotation.go:171] "Unhandled Error" err="key failed with : open /home/jenkins/minikube-integration/20317-81875/.minikube/profiles/default-k8s-diff-port-984939/client.crt: no such file or directory" logger="UnhandledError"
E0127 13:08:19.393757 89071 cert_rotation.go:171] "Unhandled Error" err="key failed with : open /home/jenkins/minikube-integration/20317-81875/.minikube/profiles/default-k8s-diff-port-984939/client.crt: no such file or directory" logger="UnhandledError"
E0127 13:08:19.555663 89071 cert_rotation.go:171] "Unhandled Error" err="key failed with : open /home/jenkins/minikube-integration/20317-81875/.minikube/profiles/default-k8s-diff-port-984939/client.crt: no such file or directory" logger="UnhandledError"
E0127 13:08:19.876945 89071 cert_rotation.go:171] "Unhandled Error" err="key failed with : open /home/jenkins/minikube-integration/20317-81875/.minikube/profiles/default-k8s-diff-port-984939/client.crt: no such file or directory" logger="UnhandledError"
E0127 13:08:20.519051 89071 cert_rotation.go:171] "Unhandled Error" err="key failed with : open /home/jenkins/minikube-integration/20317-81875/.minikube/profiles/default-k8s-diff-port-984939/client.crt: no such file or directory" logger="UnhandledError"
E0127 13:08:21.800805 89071 cert_rotation.go:171] "Unhandled Error" err="key failed with : open /home/jenkins/minikube-integration/20317-81875/.minikube/profiles/default-k8s-diff-port-984939/client.crt: no such file or directory" logger="UnhandledError"
E0127 13:08:24.363184 89071 cert_rotation.go:171] "Unhandled Error" err="key failed with : open /home/jenkins/minikube-integration/20317-81875/.minikube/profiles/default-k8s-diff-port-984939/client.crt: no such file or directory" logger="UnhandledError"
E0127 13:08:29.485257 89071 cert_rotation.go:171] "Unhandled Error" err="key failed with : open /home/jenkins/minikube-integration/20317-81875/.minikube/profiles/default-k8s-diff-port-984939/client.crt: no such file or directory" logger="UnhandledError"
E0127 13:08:39.727558 89071 cert_rotation.go:171] "Unhandled Error" err="key failed with : open /home/jenkins/minikube-integration/20317-81875/.minikube/profiles/default-k8s-diff-port-984939/client.crt: no such file or directory" logger="UnhandledError"
E0127 13:08:41.437865 89071 cert_rotation.go:171] "Unhandled Error" err="key failed with : open /home/jenkins/minikube-integration/20317-81875/.minikube/profiles/flannel-258288/client.crt: no such file or directory" logger="UnhandledError"
E0127 13:08:46.114900 89071 cert_rotation.go:171] "Unhandled Error" err="key failed with : open /home/jenkins/minikube-integration/20317-81875/.minikube/profiles/skaffold-437485/client.crt: no such file or directory" logger="UnhandledError"
E0127 13:08:58.542907 89071 cert_rotation.go:171] "Unhandled Error" err="key failed with : open /home/jenkins/minikube-integration/20317-81875/.minikube/profiles/calico-258288/client.crt: no such file or directory" logger="UnhandledError"
E0127 13:09:00.209318 89071 cert_rotation.go:171] "Unhandled Error" err="key failed with : open /home/jenkins/minikube-integration/20317-81875/.minikube/profiles/default-k8s-diff-port-984939/client.crt: no such file or directory" logger="UnhandledError"
E0127 13:09:03.005272 89071 cert_rotation.go:171] "Unhandled Error" err="key failed with : open /home/jenkins/minikube-integration/20317-81875/.minikube/profiles/custom-flannel-258288/client.crt: no such file or directory" logger="UnhandledError"