=== RUN TestStartStop/group/no-preload/serial/FirstStart
start_stop_delete_test.go:186: (dbg) Run: out/minikube-linux-amd64 start -p no-preload-965778 --memory=2200 --alsologtostderr --wait=true --preload=false --driver=kvm2 --kubernetes-version=v1.31.0-beta.0
start_stop_delete_test.go:186: (dbg) Non-zero exit: out/minikube-linux-amd64 start -p no-preload-965778 --memory=2200 --alsologtostderr --wait=true --preload=false --driver=kvm2 --kubernetes-version=v1.31.0-beta.0: exit status 90 (1m31.895872115s)
-- stdout --
* [no-preload-965778] minikube v1.33.1 on Ubuntu 20.04 (kvm/amd64)
- MINIKUBE_LOCATION=19338
- MINIKUBE_SUPPRESS_DOCKER_PERFORMANCE=true
- KUBECONFIG=/home/jenkins/minikube-integration/19338-179709/kubeconfig
- MINIKUBE_HOME=/home/jenkins/minikube-integration/19338-179709/.minikube
- MINIKUBE_BIN=out/minikube-linux-amd64
- MINIKUBE_FORCE_SYSTEMD=
* Using the kvm2 driver based on user configuration
* Starting "no-preload-965778" primary control-plane node in "no-preload-965778" cluster
* Creating kvm2 VM (CPUs=2, Memory=2200MB, Disk=20000MB) ...
-- /stdout --
** stderr **
I0729 13:50:33.120648 239535 out.go:291] Setting OutFile to fd 1 ...
I0729 13:50:33.120774 239535 out.go:338] TERM=,COLORTERM=, which probably does not support color
I0729 13:50:33.120785 239535 out.go:304] Setting ErrFile to fd 2...
I0729 13:50:33.120791 239535 out.go:338] TERM=,COLORTERM=, which probably does not support color
I0729 13:50:33.121058 239535 root.go:338] Updating PATH: /home/jenkins/minikube-integration/19338-179709/.minikube/bin
I0729 13:50:33.121690 239535 out.go:298] Setting JSON to false
I0729 13:50:33.122853 239535 start.go:129] hostinfo: {"hostname":"ubuntu-20-agent-2","uptime":12784,"bootTime":1722248249,"procs":304,"os":"linux","platform":"ubuntu","platformFamily":"debian","platformVersion":"20.04","kernelVersion":"5.15.0-1062-gcp","kernelArch":"x86_64","virtualizationSystem":"kvm","virtualizationRole":"guest","hostId":"591c9f12-2938-3743-e2bf-c56a050d43d1"}
I0729 13:50:33.122920 239535 start.go:139] virtualization: kvm guest
I0729 13:50:33.151628 239535 out.go:177] * [no-preload-965778] minikube v1.33.1 on Ubuntu 20.04 (kvm/amd64)
I0729 13:50:33.153161 239535 out.go:177] - MINIKUBE_LOCATION=19338
I0729 13:50:33.153169 239535 notify.go:220] Checking for updates...
I0729 13:50:33.159139 239535 out.go:177] - MINIKUBE_SUPPRESS_DOCKER_PERFORMANCE=true
I0729 13:50:33.161421 239535 out.go:177] - KUBECONFIG=/home/jenkins/minikube-integration/19338-179709/kubeconfig
I0729 13:50:33.162843 239535 out.go:177] - MINIKUBE_HOME=/home/jenkins/minikube-integration/19338-179709/.minikube
I0729 13:50:33.164384 239535 out.go:177] - MINIKUBE_BIN=out/minikube-linux-amd64
I0729 13:50:33.165903 239535 out.go:177] - MINIKUBE_FORCE_SYSTEMD=
I0729 13:50:33.167879 239535 config.go:182] Loaded profile config "bridge-263785": Driver=kvm2, ContainerRuntime=docker, KubernetesVersion=v1.30.3
I0729 13:50:33.168031 239535 config.go:182] Loaded profile config "kubenet-263785": Driver=kvm2, ContainerRuntime=docker, KubernetesVersion=v1.30.3
I0729 13:50:33.168213 239535 config.go:182] Loaded profile config "old-k8s-version-436965": Driver=kvm2, ContainerRuntime=docker, KubernetesVersion=v1.20.0
I0729 13:50:33.168354 239535 driver.go:392] Setting default libvirt URI to qemu:///system
I0729 13:50:33.214393 239535 out.go:177] * Using the kvm2 driver based on user configuration
I0729 13:50:33.215822 239535 start.go:297] selected driver: kvm2
I0729 13:50:33.215846 239535 start.go:901] validating driver "kvm2" against <nil>
I0729 13:50:33.215865 239535 start.go:912] status for kvm2: {Installed:true Healthy:true Running:true NeedsImprovement:false Error:<nil> Reason: Fix: Doc: Version:}
I0729 13:50:33.216839 239535 install.go:52] acquiring lock: {Name:mk900956b073697a4aa6c80a27c6bb0742a99a53 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I0729 13:50:33.216988 239535 install.go:117] Validating docker-machine-driver-kvm2, PATH=/home/jenkins/minikube-integration/19338-179709/.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
I0729 13:50:33.236507 239535 install.go:137] /home/jenkins/workspace/KVM_Linux_integration/out/docker-machine-driver-kvm2 version is 1.33.1
I0729 13:50:33.236622 239535 start_flags.go:310] no existing cluster config was found, will generate one from the flags
I0729 13:50:33.236908 239535 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]
I0729 13:50:33.237003 239535 cni.go:84] Creating CNI manager for ""
I0729 13:50:33.237028 239535 cni.go:158] "kvm2" driver + "docker" container runtime found on kubernetes v1.24+, recommending bridge
I0729 13:50:33.237042 239535 start_flags.go:319] Found "bridge CNI" CNI - setting NetworkPlugin=cni
I0729 13:50:33.237127 239535 start.go:340] cluster config:
{Name:no-preload-965778 KeepContext:false EmbedCerts:false MinikubeISO: KicBaseImage:gcr.io/k8s-minikube/kicbase-builds:v0.0.44-1721902582-19326@sha256:540fb5dc7f38be17ff5276a38dfe6c8a4b1d9ba1c27c62244e6eebd7e37696e7 Memory:2200 CPUs:2 DiskSize:20000 Driver:kvm2 HyperkitVpnKitSock: HyperkitVSockPorts:[] DockerEnv:[] ContainerVolumeMounts:[] InsecureRegistry:[] RegistryMirror:[] HostOnlyCIDR:192.168.59.1/24 HypervVirtualSwitch: HypervUseExternalSwitch:false HypervExternalAdapter: KVMNetwork:default KVMQemuURI:qemu:///system KVMGPU:false KVMHidden:false KVMNUMACount:1 APIServerPort:8443 DockerOpt:[] DisableDriverMounts:false NFSShare:[] NFSSharesRoot:/nfsshares UUID: NoVTXCheck:false DNSProxy:false HostDNSResolver:true HostOnlyNicType:virtio NatNicType:virtio SSHIPAddress: SSHUser:root SSHKey: SSHPort:22 KubernetesConfig:{KubernetesVersion:v1.31.0-beta.0 ClusterName:no-preload-965778 Namespace:default APIServerHAVIP: APIServerName:minikubeCA APIServerNames:[] APIServerIPs:[] DNSDomain:cluster.local Con
tainerRuntime:docker CRISocket: NetworkPlugin:cni FeatureGates: ServiceCIDR:10.96.0.0/12 ImageRepository: LoadBalancerStartIP: LoadBalancerEndIP: CustomIngressCert: RegistryAliases: ExtraOptions:[] ShouldLoadCachedImages:true EnableDefaultCNI:false CNI:} Nodes:[{Name: IP: Port:8443 KubernetesVersion:v1.31.0-beta.0 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:6m0s ScheduledStop:<nil> ExposedPorts:[] ListenAddress: Network: Subnet: MultiNodeRequested:false ExtraDisks:0 CertExpiration:26280h0m0s Mount:false MountString:/home/jenkins:/minikube-host Mount9PVersion:9p2000.L MountGID:docker MountIP: MountMSize:262144 MountOptions:[] MountPort:0 MountType:9p MountUID:docker BinaryMirror: DisableOptimizations:false DisableMetrics:false CustomQemuFirmwarePath: SocketVMnetClientPath: SocketVMnetPath: St
aticIP: SSHAuthSock: SSHAgentPID:0 GPUs: AutoPauseInterval:1m0s}
I0729 13:50:33.237282 239535 iso.go:125] acquiring lock: {Name:mkba981b31daf918fe5bcf2915c3bde7a7b27504 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I0729 13:50:33.239274 239535 out.go:177] * Starting "no-preload-965778" primary control-plane node in "no-preload-965778" cluster
I0729 13:50:33.240619 239535 preload.go:131] Checking if preload exists for k8s version v1.31.0-beta.0 and runtime docker
I0729 13:50:33.240813 239535 profile.go:143] Saving config to /home/jenkins/minikube-integration/19338-179709/.minikube/profiles/no-preload-965778/config.json ...
I0729 13:50:33.240856 239535 lock.go:35] WriteFile acquiring /home/jenkins/minikube-integration/19338-179709/.minikube/profiles/no-preload-965778/config.json: {Name:mk9b7984f914593ebd833bc76b9f06141a7b6dcf Clock:{} Delay:500ms Timeout:1m0s Cancel:<nil>}
I0729 13:50:33.240997 239535 cache.go:107] acquiring lock: {Name:mk2383c9e6b7a6915eaef03d7a80b8b4c60fea1b Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I0729 13:50:33.241028 239535 cache.go:107] acquiring lock: {Name:mk398334d3d819007fedae8661b9c661c8c44e4e Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I0729 13:50:33.241051 239535 cache.go:107] acquiring lock: {Name:mk99ddba910bfeee9b9e6e7f93864113c560ef1a Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I0729 13:50:33.241071 239535 cache.go:107] acquiring lock: {Name:mk171fee556637ae237dd69cac1919cc60198aa5 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I0729 13:50:33.241123 239535 cache.go:107] acquiring lock: {Name:mk97c941efaaf4fabb809b41b1512acca163642c Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I0729 13:50:33.241176 239535 image.go:134] retrieving image: registry.k8s.io/kube-controller-manager:v1.31.0-beta.0
I0729 13:50:33.241179 239535 cache.go:107] acquiring lock: {Name:mk1000b8dd13ae6cebec4502d49d7ca75a5271d8 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I0729 13:50:33.241216 239535 image.go:134] retrieving image: registry.k8s.io/pause:3.10
I0729 13:50:33.241237 239535 image.go:134] retrieving image: registry.k8s.io/kube-scheduler:v1.31.0-beta.0
I0729 13:50:33.241264 239535 image.go:134] retrieving image: registry.k8s.io/kube-proxy:v1.31.0-beta.0
I0729 13:50:33.241279 239535 image.go:134] retrieving image: registry.k8s.io/etcd:3.5.14-0
I0729 13:50:33.241212 239535 start.go:360] acquireMachinesLock for no-preload-965778: {Name:mk5543e9efbb5e2375a199061215cf6ce4b521a1 Clock:{} Delay:500ms Timeout:13m0s Cancel:<nil>}
I0729 13:50:33.241001 239535 cache.go:107] acquiring lock: {Name:mke6bfffaf8f1c5e0a479e46c52aea3732686c1f Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I0729 13:50:33.241455 239535 start.go:364] duration metric: took 43.85µs to acquireMachinesLock for "no-preload-965778"
I0729 13:50:33.241000 239535 cache.go:107] acquiring lock: {Name:mkb5b51dcee4dcba6dd5d3a01a45080dfbcd0e0f Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I0729 13:50:33.241486 239535 start.go:93] Provisioning new machine with config: &{Name:no-preload-965778 KeepContext:false EmbedCerts:false MinikubeISO:https://storage.googleapis.com/minikube-builds/iso/19319/minikube-v1.33.1-1721690939-19319-amd64.iso KicBaseImage:gcr.io/k8s-minikube/kicbase-builds:v0.0.44-1721902582-19326@sha256:540fb5dc7f38be17ff5276a38dfe6c8a4b1d9ba1c27c62244e6eebd7e37696e7 Memory:2200 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:{K
ubernetesVersion:v1.31.0-beta.0 ClusterName:no-preload-965778 Namespace:default APIServerHAVIP: APIServerName:minikubeCA APIServerNames:[] APIServerIPs:[] DNSDomain:cluster.local ContainerRuntime:docker CRISocket: NetworkPlugin:cni FeatureGates: ServiceCIDR:10.96.0.0/12 ImageRepository: LoadBalancerStartIP: LoadBalancerEndIP: CustomIngressCert: RegistryAliases: ExtraOptions:[] ShouldLoadCachedImages:true EnableDefaultCNI:false CNI:} Nodes:[{Name: IP: Port:8443 KubernetesVersion:v1.31.0-beta.0 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:6m0s ScheduledStop:<nil> ExposedPorts:[] ListenAddress: Network: Subnet: MultiNodeRequested:false ExtraDisks:0 CertExpiration:26280h0m0s Mount:false MountString:/home/jenkins:/minikube-host Mount9PVersion:9p2000.L MountGID:docker MountIP: MountMSize:262144 Mou
ntOptions:[] MountPort:0 MountType:9p MountUID:docker BinaryMirror: DisableOptimizations:false DisableMetrics:false CustomQemuFirmwarePath: SocketVMnetClientPath: SocketVMnetPath: StaticIP: SSHAuthSock: SSHAgentPID:0 GPUs: AutoPauseInterval:1m0s} &{Name: IP: Port:8443 KubernetesVersion:v1.31.0-beta.0 ContainerRuntime:docker ControlPlane:true Worker:true}
I0729 13:50:33.241587 239535 start.go:125] createHost starting for "" (driver="kvm2")
I0729 13:50:33.242111 239535 image.go:134] retrieving image: registry.k8s.io/coredns/coredns:v1.11.1
I0729 13:50:33.242180 239535 cache.go:115] /home/jenkins/minikube-integration/19338-179709/.minikube/cache/images/amd64/gcr.io/k8s-minikube/storage-provisioner_v5 exists
I0729 13:50:33.242197 239535 cache.go:96] cache image "gcr.io/k8s-minikube/storage-provisioner:v5" -> "/home/jenkins/minikube-integration/19338-179709/.minikube/cache/images/amd64/gcr.io/k8s-minikube/storage-provisioner_v5" took 1.204009ms
I0729 13:50:33.242209 239535 cache.go:80] save to tar file gcr.io/k8s-minikube/storage-provisioner:v5 -> /home/jenkins/minikube-integration/19338-179709/.minikube/cache/images/amd64/gcr.io/k8s-minikube/storage-provisioner_v5 succeeded
I0729 13:50:33.242111 239535 image.go:134] retrieving image: registry.k8s.io/kube-apiserver:v1.31.0-beta.0
I0729 13:50:33.242956 239535 image.go:177] daemon lookup for registry.k8s.io/kube-proxy:v1.31.0-beta.0: Error response from daemon: No such image: registry.k8s.io/kube-proxy:v1.31.0-beta.0
I0729 13:50:33.243083 239535 image.go:177] daemon lookup for registry.k8s.io/pause:3.10: Error response from daemon: No such image: registry.k8s.io/pause:3.10
I0729 13:50:33.243266 239535 image.go:177] daemon lookup for registry.k8s.io/kube-controller-manager:v1.31.0-beta.0: Error response from daemon: No such image: registry.k8s.io/kube-controller-manager:v1.31.0-beta.0
I0729 13:50:33.243402 239535 image.go:177] daemon lookup for registry.k8s.io/etcd:3.5.14-0: Error response from daemon: No such image: registry.k8s.io/etcd:3.5.14-0
I0729 13:50:33.243638 239535 image.go:177] daemon lookup for registry.k8s.io/kube-scheduler:v1.31.0-beta.0: Error response from daemon: No such image: registry.k8s.io/kube-scheduler:v1.31.0-beta.0
I0729 13:50:33.243823 239535 image.go:177] daemon lookup for registry.k8s.io/coredns/coredns:v1.11.1: Error response from daemon: No such image: registry.k8s.io/coredns/coredns:v1.11.1
I0729 13:50:33.244119 239535 out.go:204] * Creating kvm2 VM (CPUs=2, Memory=2200MB, Disk=20000MB) ...
I0729 13:50:33.244254 239535 image.go:177] daemon lookup for registry.k8s.io/kube-apiserver:v1.31.0-beta.0: Error response from daemon: No such image: registry.k8s.io/kube-apiserver:v1.31.0-beta.0
I0729 13:50:33.244361 239535 main.go:141] libmachine: Found binary path at /home/jenkins/workspace/KVM_Linux_integration/out/docker-machine-driver-kvm2
I0729 13:50:33.244406 239535 main.go:141] libmachine: Launching plugin server for driver kvm2
I0729 13:50:33.265402 239535 main.go:141] libmachine: Plugin server listening at address 127.0.0.1:43639
I0729 13:50:33.266828 239535 main.go:141] libmachine: () Calling .GetVersion
I0729 13:50:33.267584 239535 main.go:141] libmachine: Using API Version 1
I0729 13:50:33.267610 239535 main.go:141] libmachine: () Calling .SetConfigRaw
I0729 13:50:33.267990 239535 main.go:141] libmachine: () Calling .GetMachineName
I0729 13:50:33.268303 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetMachineName
I0729 13:50:33.268489 239535 main.go:141] libmachine: (no-preload-965778) Calling .DriverName
I0729 13:50:33.268677 239535 start.go:159] libmachine.API.Create for "no-preload-965778" (driver="kvm2")
I0729 13:50:33.268702 239535 client.go:168] LocalClient.Create starting
I0729 13:50:33.268737 239535 main.go:141] libmachine: Reading certificate data from /home/jenkins/minikube-integration/19338-179709/.minikube/certs/ca.pem
I0729 13:50:33.268780 239535 main.go:141] libmachine: Decoding PEM data...
I0729 13:50:33.268796 239535 main.go:141] libmachine: Parsing certificate...
I0729 13:50:33.268857 239535 main.go:141] libmachine: Reading certificate data from /home/jenkins/minikube-integration/19338-179709/.minikube/certs/cert.pem
I0729 13:50:33.268885 239535 main.go:141] libmachine: Decoding PEM data...
I0729 13:50:33.268898 239535 main.go:141] libmachine: Parsing certificate...
I0729 13:50:33.268926 239535 main.go:141] libmachine: Running pre-create checks...
I0729 13:50:33.268938 239535 main.go:141] libmachine: (no-preload-965778) Calling .PreCreateCheck
I0729 13:50:33.270647 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetConfigRaw
I0729 13:50:33.271143 239535 main.go:141] libmachine: Creating machine...
I0729 13:50:33.271179 239535 main.go:141] libmachine: (no-preload-965778) Calling .Create
I0729 13:50:33.271357 239535 main.go:141] libmachine: (no-preload-965778) Creating KVM machine...
I0729 13:50:33.272884 239535 main.go:141] libmachine: (no-preload-965778) DBG | found existing default KVM network
I0729 13:50:33.274282 239535 main.go:141] libmachine: (no-preload-965778) DBG | I0729 13:50:33.274130 239558 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:virbr4 IfaceIPv4:192.168.39.1 IfaceMTU:1500 IfaceMAC:52:54:00:e8:74:98} reservation:<nil>}
I0729 13:50:33.275557 239535 main.go:141] libmachine: (no-preload-965778) DBG | I0729 13:50:33.275348 239558 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:virbr2 IfaceIPv4:192.168.50.1 IfaceMTU:1500 IfaceMAC:52:54:00:40:b9:00} reservation:<nil>}
I0729 13:50:33.276633 239535 main.go:141] libmachine: (no-preload-965778) DBG | I0729 13:50:33.276578 239558 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:virbr3 IfaceIPv4:192.168.61.1 IfaceMTU:1500 IfaceMAC:52:54:00:3a:65:f6} reservation:<nil>}
I0729 13:50:33.278051 239535 main.go:141] libmachine: (no-preload-965778) DBG | I0729 13:50:33.277723 239558 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:0xc00030bf00}
I0729 13:50:33.278114 239535 main.go:141] libmachine: (no-preload-965778) DBG | created network xml:
I0729 13:50:33.278127 239535 main.go:141] libmachine: (no-preload-965778) DBG | <network>
I0729 13:50:33.278135 239535 main.go:141] libmachine: (no-preload-965778) DBG | <name>mk-no-preload-965778</name>
I0729 13:50:33.278144 239535 main.go:141] libmachine: (no-preload-965778) DBG | <dns enable='no'/>
I0729 13:50:33.278150 239535 main.go:141] libmachine: (no-preload-965778) DBG |
I0729 13:50:33.278159 239535 main.go:141] libmachine: (no-preload-965778) DBG | <ip address='192.168.72.1' netmask='255.255.255.0'>
I0729 13:50:33.278167 239535 main.go:141] libmachine: (no-preload-965778) DBG | <dhcp>
I0729 13:50:33.278176 239535 main.go:141] libmachine: (no-preload-965778) DBG | <range start='192.168.72.2' end='192.168.72.253'/>
I0729 13:50:33.278182 239535 main.go:141] libmachine: (no-preload-965778) DBG | </dhcp>
I0729 13:50:33.278190 239535 main.go:141] libmachine: (no-preload-965778) DBG | </ip>
I0729 13:50:33.278196 239535 main.go:141] libmachine: (no-preload-965778) DBG |
I0729 13:50:33.278204 239535 main.go:141] libmachine: (no-preload-965778) DBG | </network>
I0729 13:50:33.278210 239535 main.go:141] libmachine: (no-preload-965778) DBG |
I0729 13:50:33.284755 239535 main.go:141] libmachine: (no-preload-965778) DBG | trying to create private KVM network mk-no-preload-965778 192.168.72.0/24...
I0729 13:50:33.392508 239535 main.go:141] libmachine: (no-preload-965778) Setting up store path in /home/jenkins/minikube-integration/19338-179709/.minikube/machines/no-preload-965778 ...
I0729 13:50:33.392541 239535 main.go:141] libmachine: (no-preload-965778) DBG | private KVM network mk-no-preload-965778 192.168.72.0/24 created
I0729 13:50:33.392563 239535 main.go:141] libmachine: (no-preload-965778) Building disk image from file:///home/jenkins/minikube-integration/19338-179709/.minikube/cache/iso/amd64/minikube-v1.33.1-1721690939-19319-amd64.iso
I0729 13:50:33.392584 239535 main.go:141] libmachine: (no-preload-965778) Downloading /home/jenkins/minikube-integration/19338-179709/.minikube/cache/boot2docker.iso from file:///home/jenkins/minikube-integration/19338-179709/.minikube/cache/iso/amd64/minikube-v1.33.1-1721690939-19319-amd64.iso...
I0729 13:50:33.392609 239535 main.go:141] libmachine: (no-preload-965778) DBG | I0729 13:50:33.391731 239558 common.go:145] Making disk image using store path: /home/jenkins/minikube-integration/19338-179709/.minikube
I0729 13:50:33.398994 239535 cache.go:162] opening: /home/jenkins/minikube-integration/19338-179709/.minikube/cache/images/amd64/registry.k8s.io/coredns/coredns_v1.11.1
I0729 13:50:33.407559 239535 cache.go:162] opening: /home/jenkins/minikube-integration/19338-179709/.minikube/cache/images/amd64/registry.k8s.io/kube-apiserver_v1.31.0-beta.0
I0729 13:50:33.412668 239535 cache.go:162] opening: /home/jenkins/minikube-integration/19338-179709/.minikube/cache/images/amd64/registry.k8s.io/etcd_3.5.14-0
I0729 13:50:33.418793 239535 cache.go:162] opening: /home/jenkins/minikube-integration/19338-179709/.minikube/cache/images/amd64/registry.k8s.io/pause_3.10
I0729 13:50:33.436413 239535 cache.go:162] opening: /home/jenkins/minikube-integration/19338-179709/.minikube/cache/images/amd64/registry.k8s.io/kube-scheduler_v1.31.0-beta.0
I0729 13:50:33.438349 239535 cache.go:162] opening: /home/jenkins/minikube-integration/19338-179709/.minikube/cache/images/amd64/registry.k8s.io/kube-proxy_v1.31.0-beta.0
I0729 13:50:33.448720 239535 cache.go:162] opening: /home/jenkins/minikube-integration/19338-179709/.minikube/cache/images/amd64/registry.k8s.io/kube-controller-manager_v1.31.0-beta.0
I0729 13:50:33.494211 239535 cache.go:157] /home/jenkins/minikube-integration/19338-179709/.minikube/cache/images/amd64/registry.k8s.io/pause_3.10 exists
I0729 13:50:33.494245 239535 cache.go:96] cache image "registry.k8s.io/pause:3.10" -> "/home/jenkins/minikube-integration/19338-179709/.minikube/cache/images/amd64/registry.k8s.io/pause_3.10" took 253.233608ms
I0729 13:50:33.494260 239535 cache.go:80] save to tar file registry.k8s.io/pause:3.10 -> /home/jenkins/minikube-integration/19338-179709/.minikube/cache/images/amd64/registry.k8s.io/pause_3.10 succeeded
I0729 13:50:33.690752 239535 main.go:141] libmachine: (no-preload-965778) DBG | I0729 13:50:33.690601 239558 common.go:152] Creating ssh key: /home/jenkins/minikube-integration/19338-179709/.minikube/machines/no-preload-965778/id_rsa...
I0729 13:50:33.897366 239535 main.go:141] libmachine: (no-preload-965778) DBG | I0729 13:50:33.897277 239558 common.go:158] Creating raw disk image: /home/jenkins/minikube-integration/19338-179709/.minikube/machines/no-preload-965778/no-preload-965778.rawdisk...
I0729 13:50:33.897402 239535 main.go:141] libmachine: (no-preload-965778) DBG | Writing magic tar header
I0729 13:50:33.897462 239535 main.go:141] libmachine: (no-preload-965778) DBG | Writing SSH key tar header
I0729 13:50:33.897478 239535 main.go:141] libmachine: (no-preload-965778) DBG | I0729 13:50:33.897409 239558 common.go:172] Fixing permissions on /home/jenkins/minikube-integration/19338-179709/.minikube/machines/no-preload-965778 ...
I0729 13:50:33.897532 239535 main.go:141] libmachine: (no-preload-965778) DBG | Checking permissions on dir: /home/jenkins/minikube-integration/19338-179709/.minikube/machines/no-preload-965778
I0729 13:50:33.897557 239535 main.go:141] libmachine: (no-preload-965778) Setting executable bit set on /home/jenkins/minikube-integration/19338-179709/.minikube/machines/no-preload-965778 (perms=drwx------)
I0729 13:50:33.897577 239535 main.go:141] libmachine: (no-preload-965778) Setting executable bit set on /home/jenkins/minikube-integration/19338-179709/.minikube/machines (perms=drwxr-xr-x)
I0729 13:50:33.897605 239535 main.go:141] libmachine: (no-preload-965778) DBG | Checking permissions on dir: /home/jenkins/minikube-integration/19338-179709/.minikube/machines
I0729 13:50:33.897615 239535 main.go:141] libmachine: (no-preload-965778) DBG | Checking permissions on dir: /home/jenkins/minikube-integration/19338-179709/.minikube
I0729 13:50:33.897625 239535 main.go:141] libmachine: (no-preload-965778) DBG | Checking permissions on dir: /home/jenkins/minikube-integration/19338-179709
I0729 13:50:33.897630 239535 main.go:141] libmachine: (no-preload-965778) DBG | Checking permissions on dir: /home/jenkins/minikube-integration
I0729 13:50:33.897645 239535 main.go:141] libmachine: (no-preload-965778) DBG | Checking permissions on dir: /home/jenkins
I0729 13:50:33.897655 239535 main.go:141] libmachine: (no-preload-965778) Setting executable bit set on /home/jenkins/minikube-integration/19338-179709/.minikube (perms=drwxr-xr-x)
I0729 13:50:33.897664 239535 main.go:141] libmachine: (no-preload-965778) DBG | Checking permissions on dir: /home
I0729 13:50:33.897681 239535 main.go:141] libmachine: (no-preload-965778) DBG | Skipping /home - not owner
I0729 13:50:33.897740 239535 main.go:141] libmachine: (no-preload-965778) Setting executable bit set on /home/jenkins/minikube-integration/19338-179709 (perms=drwxrwxr-x)
I0729 13:50:33.897773 239535 main.go:141] libmachine: (no-preload-965778) Setting executable bit set on /home/jenkins/minikube-integration (perms=drwxrwxr-x)
I0729 13:50:33.897859 239535 main.go:141] libmachine: (no-preload-965778) Setting executable bit set on /home/jenkins (perms=drwxr-xr-x)
I0729 13:50:33.897908 239535 main.go:141] libmachine: (no-preload-965778) Creating domain...
I0729 13:50:33.899145 239535 main.go:141] libmachine: (no-preload-965778) define libvirt domain using xml:
I0729 13:50:33.899182 239535 main.go:141] libmachine: (no-preload-965778) <domain type='kvm'>
I0729 13:50:33.899228 239535 main.go:141] libmachine: (no-preload-965778) <name>no-preload-965778</name>
I0729 13:50:33.899252 239535 main.go:141] libmachine: (no-preload-965778) <memory unit='MiB'>2200</memory>
I0729 13:50:33.899264 239535 main.go:141] libmachine: (no-preload-965778) <vcpu>2</vcpu>
I0729 13:50:33.899275 239535 main.go:141] libmachine: (no-preload-965778) <features>
I0729 13:50:33.899284 239535 main.go:141] libmachine: (no-preload-965778) <acpi/>
I0729 13:50:33.899291 239535 main.go:141] libmachine: (no-preload-965778) <apic/>
I0729 13:50:33.899302 239535 main.go:141] libmachine: (no-preload-965778) <pae/>
I0729 13:50:33.899312 239535 main.go:141] libmachine: (no-preload-965778)
I0729 13:50:33.899321 239535 main.go:141] libmachine: (no-preload-965778) </features>
I0729 13:50:33.899333 239535 main.go:141] libmachine: (no-preload-965778) <cpu mode='host-passthrough'>
I0729 13:50:33.899344 239535 main.go:141] libmachine: (no-preload-965778)
I0729 13:50:33.899356 239535 main.go:141] libmachine: (no-preload-965778) </cpu>
I0729 13:50:33.899365 239535 main.go:141] libmachine: (no-preload-965778) <os>
I0729 13:50:33.899372 239535 main.go:141] libmachine: (no-preload-965778) <type>hvm</type>
I0729 13:50:33.899380 239535 main.go:141] libmachine: (no-preload-965778) <boot dev='cdrom'/>
I0729 13:50:33.899396 239535 main.go:141] libmachine: (no-preload-965778) <boot dev='hd'/>
I0729 13:50:33.899410 239535 main.go:141] libmachine: (no-preload-965778) <bootmenu enable='no'/>
I0729 13:50:33.899417 239535 main.go:141] libmachine: (no-preload-965778) </os>
I0729 13:50:33.899426 239535 main.go:141] libmachine: (no-preload-965778) <devices>
I0729 13:50:33.899435 239535 main.go:141] libmachine: (no-preload-965778) <disk type='file' device='cdrom'>
I0729 13:50:33.899450 239535 main.go:141] libmachine: (no-preload-965778) <source file='/home/jenkins/minikube-integration/19338-179709/.minikube/machines/no-preload-965778/boot2docker.iso'/>
I0729 13:50:33.899466 239535 main.go:141] libmachine: (no-preload-965778) <target dev='hdc' bus='scsi'/>
I0729 13:50:33.899484 239535 main.go:141] libmachine: (no-preload-965778) <readonly/>
I0729 13:50:33.899503 239535 main.go:141] libmachine: (no-preload-965778) </disk>
I0729 13:50:33.899514 239535 main.go:141] libmachine: (no-preload-965778) <disk type='file' device='disk'>
I0729 13:50:33.899523 239535 main.go:141] libmachine: (no-preload-965778) <driver name='qemu' type='raw' cache='default' io='threads' />
I0729 13:50:33.899536 239535 main.go:141] libmachine: (no-preload-965778) <source file='/home/jenkins/minikube-integration/19338-179709/.minikube/machines/no-preload-965778/no-preload-965778.rawdisk'/>
I0729 13:50:33.899548 239535 main.go:141] libmachine: (no-preload-965778) <target dev='hda' bus='virtio'/>
I0729 13:50:33.899556 239535 main.go:141] libmachine: (no-preload-965778) </disk>
I0729 13:50:33.899564 239535 main.go:141] libmachine: (no-preload-965778) <interface type='network'>
I0729 13:50:33.899570 239535 main.go:141] libmachine: (no-preload-965778) <source network='mk-no-preload-965778'/>
I0729 13:50:33.899577 239535 main.go:141] libmachine: (no-preload-965778) <model type='virtio'/>
I0729 13:50:33.899582 239535 main.go:141] libmachine: (no-preload-965778) </interface>
I0729 13:50:33.899590 239535 main.go:141] libmachine: (no-preload-965778) <interface type='network'>
I0729 13:50:33.899595 239535 main.go:141] libmachine: (no-preload-965778) <source network='default'/>
I0729 13:50:33.899600 239535 main.go:141] libmachine: (no-preload-965778) <model type='virtio'/>
I0729 13:50:33.899605 239535 main.go:141] libmachine: (no-preload-965778) </interface>
I0729 13:50:33.899613 239535 main.go:141] libmachine: (no-preload-965778) <serial type='pty'>
I0729 13:50:33.899618 239535 main.go:141] libmachine: (no-preload-965778) <target port='0'/>
I0729 13:50:33.899625 239535 main.go:141] libmachine: (no-preload-965778) </serial>
I0729 13:50:33.899630 239535 main.go:141] libmachine: (no-preload-965778) <console type='pty'>
I0729 13:50:33.899637 239535 main.go:141] libmachine: (no-preload-965778) <target type='serial' port='0'/>
I0729 13:50:33.899642 239535 main.go:141] libmachine: (no-preload-965778) </console>
I0729 13:50:33.899649 239535 main.go:141] libmachine: (no-preload-965778) <rng model='virtio'>
I0729 13:50:33.899655 239535 main.go:141] libmachine: (no-preload-965778) <backend model='random'>/dev/random</backend>
I0729 13:50:33.899662 239535 main.go:141] libmachine: (no-preload-965778) </rng>
I0729 13:50:33.899667 239535 main.go:141] libmachine: (no-preload-965778)
I0729 13:50:33.899673 239535 main.go:141] libmachine: (no-preload-965778)
I0729 13:50:33.899678 239535 main.go:141] libmachine: (no-preload-965778) </devices>
I0729 13:50:33.899687 239535 main.go:141] libmachine: (no-preload-965778) </domain>
I0729 13:50:33.899693 239535 main.go:141] libmachine: (no-preload-965778)
I0729 13:50:33.904481 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined MAC address 52:54:00:ba:04:b6 in network default
I0729 13:50:33.905746 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:50:33.905768 239535 main.go:141] libmachine: (no-preload-965778) Ensuring networks are active...
I0729 13:50:33.906643 239535 main.go:141] libmachine: (no-preload-965778) Ensuring network default is active
I0729 13:50:33.908386 239535 main.go:141] libmachine: (no-preload-965778) Ensuring network mk-no-preload-965778 is active
I0729 13:50:33.908753 239535 main.go:141] libmachine: (no-preload-965778) Getting domain xml...
I0729 13:50:33.910087 239535 main.go:141] libmachine: (no-preload-965778) Creating domain...
I0729 13:50:33.958566 239535 cache.go:157] /home/jenkins/minikube-integration/19338-179709/.minikube/cache/images/amd64/registry.k8s.io/kube-proxy_v1.31.0-beta.0 exists
I0729 13:50:33.958599 239535 cache.go:96] cache image "registry.k8s.io/kube-proxy:v1.31.0-beta.0" -> "/home/jenkins/minikube-integration/19338-179709/.minikube/cache/images/amd64/registry.k8s.io/kube-proxy_v1.31.0-beta.0" took 717.422316ms
I0729 13:50:33.958623 239535 cache.go:80] save to tar file registry.k8s.io/kube-proxy:v1.31.0-beta.0 -> /home/jenkins/minikube-integration/19338-179709/.minikube/cache/images/amd64/registry.k8s.io/kube-proxy_v1.31.0-beta.0 succeeded
I0729 13:50:34.593730 239535 cache.go:157] /home/jenkins/minikube-integration/19338-179709/.minikube/cache/images/amd64/registry.k8s.io/coredns/coredns_v1.11.1 exists
I0729 13:50:34.593758 239535 cache.go:96] cache image "registry.k8s.io/coredns/coredns:v1.11.1" -> "/home/jenkins/minikube-integration/19338-179709/.minikube/cache/images/amd64/registry.k8s.io/coredns/coredns_v1.11.1" took 1.352638897s
I0729 13:50:34.593788 239535 cache.go:80] save to tar file registry.k8s.io/coredns/coredns:v1.11.1 -> /home/jenkins/minikube-integration/19338-179709/.minikube/cache/images/amd64/registry.k8s.io/coredns/coredns_v1.11.1 succeeded
I0729 13:50:34.830980 239535 cache.go:157] /home/jenkins/minikube-integration/19338-179709/.minikube/cache/images/amd64/registry.k8s.io/kube-scheduler_v1.31.0-beta.0 exists
I0729 13:50:34.831024 239535 cache.go:96] cache image "registry.k8s.io/kube-scheduler:v1.31.0-beta.0" -> "/home/jenkins/minikube-integration/19338-179709/.minikube/cache/images/amd64/registry.k8s.io/kube-scheduler_v1.31.0-beta.0" took 1.589973786s
I0729 13:50:34.831040 239535 cache.go:80] save to tar file registry.k8s.io/kube-scheduler:v1.31.0-beta.0 -> /home/jenkins/minikube-integration/19338-179709/.minikube/cache/images/amd64/registry.k8s.io/kube-scheduler_v1.31.0-beta.0 succeeded
I0729 13:50:34.923079 239535 cache.go:157] /home/jenkins/minikube-integration/19338-179709/.minikube/cache/images/amd64/registry.k8s.io/kube-controller-manager_v1.31.0-beta.0 exists
I0729 13:50:34.923106 239535 cache.go:96] cache image "registry.k8s.io/kube-controller-manager:v1.31.0-beta.0" -> "/home/jenkins/minikube-integration/19338-179709/.minikube/cache/images/amd64/registry.k8s.io/kube-controller-manager_v1.31.0-beta.0" took 1.682158826s
I0729 13:50:34.923120 239535 cache.go:80] save to tar file registry.k8s.io/kube-controller-manager:v1.31.0-beta.0 -> /home/jenkins/minikube-integration/19338-179709/.minikube/cache/images/amd64/registry.k8s.io/kube-controller-manager_v1.31.0-beta.0 succeeded
I0729 13:50:35.285735 239535 cache.go:157] /home/jenkins/minikube-integration/19338-179709/.minikube/cache/images/amd64/registry.k8s.io/kube-apiserver_v1.31.0-beta.0 exists
I0729 13:50:35.285800 239535 cache.go:96] cache image "registry.k8s.io/kube-apiserver:v1.31.0-beta.0" -> "/home/jenkins/minikube-integration/19338-179709/.minikube/cache/images/amd64/registry.k8s.io/kube-apiserver_v1.31.0-beta.0" took 2.044836045s
I0729 13:50:35.285824 239535 cache.go:80] save to tar file registry.k8s.io/kube-apiserver:v1.31.0-beta.0 -> /home/jenkins/minikube-integration/19338-179709/.minikube/cache/images/amd64/registry.k8s.io/kube-apiserver_v1.31.0-beta.0 succeeded
I0729 13:50:35.579198 239535 main.go:141] libmachine: (no-preload-965778) Waiting to get IP...
I0729 13:50:35.580268 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:50:35.580852 239535 main.go:141] libmachine: (no-preload-965778) DBG | unable to find current IP address of domain no-preload-965778 in network mk-no-preload-965778
I0729 13:50:35.580879 239535 main.go:141] libmachine: (no-preload-965778) DBG | I0729 13:50:35.580839 239558 retry.go:31] will retry after 206.95331ms: waiting for machine to come up
I0729 13:50:35.789450 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:50:35.789482 239535 cache.go:157] /home/jenkins/minikube-integration/19338-179709/.minikube/cache/images/amd64/registry.k8s.io/etcd_3.5.14-0 exists
I0729 13:50:35.789508 239535 cache.go:96] cache image "registry.k8s.io/etcd:3.5.14-0" -> "/home/jenkins/minikube-integration/19338-179709/.minikube/cache/images/amd64/registry.k8s.io/etcd_3.5.14-0" took 2.548460766s
I0729 13:50:35.789531 239535 cache.go:80] save to tar file registry.k8s.io/etcd:3.5.14-0 -> /home/jenkins/minikube-integration/19338-179709/.minikube/cache/images/amd64/registry.k8s.io/etcd_3.5.14-0 succeeded
I0729 13:50:35.789555 239535 cache.go:87] Successfully saved all images to host disk.
I0729 13:50:35.790122 239535 main.go:141] libmachine: (no-preload-965778) DBG | unable to find current IP address of domain no-preload-965778 in network mk-no-preload-965778
I0729 13:50:35.790149 239535 main.go:141] libmachine: (no-preload-965778) DBG | I0729 13:50:35.790066 239558 retry.go:31] will retry after 288.621473ms: waiting for machine to come up
I0729 13:50:36.080680 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:50:36.081392 239535 main.go:141] libmachine: (no-preload-965778) DBG | unable to find current IP address of domain no-preload-965778 in network mk-no-preload-965778
I0729 13:50:36.081425 239535 main.go:141] libmachine: (no-preload-965778) DBG | I0729 13:50:36.081342 239558 retry.go:31] will retry after 436.689219ms: waiting for machine to come up
I0729 13:50:36.520103 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:50:36.520712 239535 main.go:141] libmachine: (no-preload-965778) DBG | unable to find current IP address of domain no-preload-965778 in network mk-no-preload-965778
I0729 13:50:36.520736 239535 main.go:141] libmachine: (no-preload-965778) DBG | I0729 13:50:36.520662 239558 retry.go:31] will retry after 589.225807ms: waiting for machine to come up
I0729 13:50:37.111302 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:50:37.111997 239535 main.go:141] libmachine: (no-preload-965778) DBG | unable to find current IP address of domain no-preload-965778 in network mk-no-preload-965778
I0729 13:50:37.112034 239535 main.go:141] libmachine: (no-preload-965778) DBG | I0729 13:50:37.111906 239558 retry.go:31] will retry after 542.055563ms: waiting for machine to come up
I0729 13:50:37.655727 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:50:37.656332 239535 main.go:141] libmachine: (no-preload-965778) DBG | unable to find current IP address of domain no-preload-965778 in network mk-no-preload-965778
I0729 13:50:37.656359 239535 main.go:141] libmachine: (no-preload-965778) DBG | I0729 13:50:37.656253 239558 retry.go:31] will retry after 615.026063ms: waiting for machine to come up
I0729 13:50:38.272573 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:50:38.273144 239535 main.go:141] libmachine: (no-preload-965778) DBG | unable to find current IP address of domain no-preload-965778 in network mk-no-preload-965778
I0729 13:50:38.273176 239535 main.go:141] libmachine: (no-preload-965778) DBG | I0729 13:50:38.273054 239558 retry.go:31] will retry after 993.957791ms: waiting for machine to come up
I0729 13:50:39.268255 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:50:39.269027 239535 main.go:141] libmachine: (no-preload-965778) DBG | unable to find current IP address of domain no-preload-965778 in network mk-no-preload-965778
I0729 13:50:39.269056 239535 main.go:141] libmachine: (no-preload-965778) DBG | I0729 13:50:39.268982 239558 retry.go:31] will retry after 1.319638539s: waiting for machine to come up
I0729 13:50:40.590003 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:50:40.590635 239535 main.go:141] libmachine: (no-preload-965778) DBG | unable to find current IP address of domain no-preload-965778 in network mk-no-preload-965778
I0729 13:50:40.590662 239535 main.go:141] libmachine: (no-preload-965778) DBG | I0729 13:50:40.590549 239558 retry.go:31] will retry after 1.203604987s: waiting for machine to come up
I0729 13:50:41.796149 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:50:41.796737 239535 main.go:141] libmachine: (no-preload-965778) DBG | unable to find current IP address of domain no-preload-965778 in network mk-no-preload-965778
I0729 13:50:41.796769 239535 main.go:141] libmachine: (no-preload-965778) DBG | I0729 13:50:41.796683 239558 retry.go:31] will retry after 2.113339091s: waiting for machine to come up
I0729 13:50:43.917499 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:50:43.919875 239535 main.go:141] libmachine: (no-preload-965778) DBG | unable to find current IP address of domain no-preload-965778 in network mk-no-preload-965778
I0729 13:50:43.919901 239535 main.go:141] libmachine: (no-preload-965778) DBG | I0729 13:50:43.919787 239558 retry.go:31] will retry after 2.268854268s: waiting for machine to come up
I0729 13:50:46.189942 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:50:46.190484 239535 main.go:141] libmachine: (no-preload-965778) DBG | unable to find current IP address of domain no-preload-965778 in network mk-no-preload-965778
I0729 13:50:46.190503 239535 main.go:141] libmachine: (no-preload-965778) DBG | I0729 13:50:46.190434 239558 retry.go:31] will retry after 3.437836645s: waiting for machine to come up
I0729 13:50:49.630067 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:50:49.630670 239535 main.go:141] libmachine: (no-preload-965778) DBG | unable to find current IP address of domain no-preload-965778 in network mk-no-preload-965778
I0729 13:50:49.630702 239535 main.go:141] libmachine: (no-preload-965778) DBG | I0729 13:50:49.630612 239558 retry.go:31] will retry after 3.436088486s: waiting for machine to come up
I0729 13:50:53.070764 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:50:53.071399 239535 main.go:141] libmachine: (no-preload-965778) DBG | unable to find current IP address of domain no-preload-965778 in network mk-no-preload-965778
I0729 13:50:53.071450 239535 main.go:141] libmachine: (no-preload-965778) DBG | I0729 13:50:53.071366 239558 retry.go:31] will retry after 5.57695795s: waiting for machine to come up
I0729 13:50:58.650358 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:50:58.650949 239535 main.go:141] libmachine: (no-preload-965778) Found IP for machine: 192.168.72.204
I0729 13:50:58.650975 239535 main.go:141] libmachine: (no-preload-965778) Reserving static IP address...
I0729 13:50:58.650992 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has current primary IP address 192.168.72.204 and MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:50:58.651464 239535 main.go:141] libmachine: (no-preload-965778) DBG | unable to find host DHCP lease matching {name: "no-preload-965778", mac: "52:54:00:1b:43:04", ip: "192.168.72.204"} in network mk-no-preload-965778
I0729 13:50:58.734544 239535 main.go:141] libmachine: (no-preload-965778) DBG | Getting to WaitForSSH function...
I0729 13:50:58.734572 239535 main.go:141] libmachine: (no-preload-965778) Reserved static IP address: 192.168.72.204
I0729 13:50:58.734586 239535 main.go:141] libmachine: (no-preload-965778) Waiting for SSH to be available...
I0729 13:50:58.737499 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:50:58.737933 239535 main.go:141] libmachine: (no-preload-965778) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:1b:43:04", ip: ""} in network mk-no-preload-965778: {Iface:virbr1 ExpiryTime:2024-07-29 14:50:49 +0000 UTC Type:0 Mac:52:54:00:1b:43:04 Iaid: IPaddr:192.168.72.204 Prefix:24 Hostname:minikube Clientid:01:52:54:00:1b:43:04}
I0729 13:50:58.737968 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined IP address 192.168.72.204 and MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:50:58.738290 239535 main.go:141] libmachine: (no-preload-965778) DBG | Using SSH client type: external
I0729 13:50:58.738324 239535 main.go:141] libmachine: (no-preload-965778) DBG | Using SSH private key: /home/jenkins/minikube-integration/19338-179709/.minikube/machines/no-preload-965778/id_rsa (-rw-------)
I0729 13:50:58.738353 239535 main.go:141] libmachine: (no-preload-965778) 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.204 -o IdentitiesOnly=yes -i /home/jenkins/minikube-integration/19338-179709/.minikube/machines/no-preload-965778/id_rsa -p 22] /usr/bin/ssh <nil>}
I0729 13:50:58.738374 239535 main.go:141] libmachine: (no-preload-965778) DBG | About to run SSH command:
I0729 13:50:58.738387 239535 main.go:141] libmachine: (no-preload-965778) DBG | exit 0
I0729 13:50:58.873581 239535 main.go:141] libmachine: (no-preload-965778) DBG | SSH cmd err, output: <nil>:
I0729 13:50:58.873881 239535 main.go:141] libmachine: (no-preload-965778) KVM machine creation complete!
I0729 13:50:58.874213 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetConfigRaw
I0729 13:50:58.874829 239535 main.go:141] libmachine: (no-preload-965778) Calling .DriverName
I0729 13:50:58.875042 239535 main.go:141] libmachine: (no-preload-965778) Calling .DriverName
I0729 13:50:58.875244 239535 main.go:141] libmachine: Waiting for machine to be running, this may take a few minutes...
I0729 13:50:58.875261 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetState
I0729 13:50:58.876874 239535 main.go:141] libmachine: Detecting operating system of created instance...
I0729 13:50:58.876891 239535 main.go:141] libmachine: Waiting for SSH to be available...
I0729 13:50:58.876898 239535 main.go:141] libmachine: Getting to WaitForSSH function...
I0729 13:50:58.876907 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHHostname
I0729 13:50:58.879788 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:50:58.880153 239535 main.go:141] libmachine: (no-preload-965778) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:1b:43:04", ip: ""} in network mk-no-preload-965778: {Iface:virbr1 ExpiryTime:2024-07-29 14:50:49 +0000 UTC Type:0 Mac:52:54:00:1b:43:04 Iaid: IPaddr:192.168.72.204 Prefix:24 Hostname:no-preload-965778 Clientid:01:52:54:00:1b:43:04}
I0729 13:50:58.880178 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined IP address 192.168.72.204 and MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:50:58.880300 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHPort
I0729 13:50:58.880575 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHKeyPath
I0729 13:50:58.880782 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHKeyPath
I0729 13:50:58.880943 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHUsername
I0729 13:50:58.881127 239535 main.go:141] libmachine: Using SSH client type: native
I0729 13:50:58.881351 239535 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x82da80] 0x8307e0 <nil> [] 0s} 192.168.72.204 22 <nil> <nil>}
I0729 13:50:58.881363 239535 main.go:141] libmachine: About to run SSH command:
exit 0
I0729 13:50:58.988069 239535 main.go:141] libmachine: SSH cmd err, output: <nil>:
I0729 13:50:58.988095 239535 main.go:141] libmachine: Detecting the provisioner...
I0729 13:50:58.988105 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHHostname
I0729 13:50:58.990840 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:50:58.991202 239535 main.go:141] libmachine: (no-preload-965778) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:1b:43:04", ip: ""} in network mk-no-preload-965778: {Iface:virbr1 ExpiryTime:2024-07-29 14:50:49 +0000 UTC Type:0 Mac:52:54:00:1b:43:04 Iaid: IPaddr:192.168.72.204 Prefix:24 Hostname:no-preload-965778 Clientid:01:52:54:00:1b:43:04}
I0729 13:50:58.991231 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined IP address 192.168.72.204 and MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:50:58.991386 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHPort
I0729 13:50:58.991598 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHKeyPath
I0729 13:50:58.991825 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHKeyPath
I0729 13:50:58.991991 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHUsername
I0729 13:50:58.992144 239535 main.go:141] libmachine: Using SSH client type: native
I0729 13:50:58.992302 239535 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x82da80] 0x8307e0 <nil> [] 0s} 192.168.72.204 22 <nil> <nil>}
I0729 13:50:58.992312 239535 main.go:141] libmachine: About to run SSH command:
cat /etc/os-release
I0729 13:50:59.101295 239535 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"
I0729 13:50:59.101380 239535 main.go:141] libmachine: found compatible host: buildroot
I0729 13:50:59.101395 239535 main.go:141] libmachine: Provisioning with buildroot...
I0729 13:50:59.101405 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetMachineName
I0729 13:50:59.101695 239535 buildroot.go:166] provisioning hostname "no-preload-965778"
I0729 13:50:59.101726 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetMachineName
I0729 13:50:59.101905 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHHostname
I0729 13:50:59.104618 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:50:59.105027 239535 main.go:141] libmachine: (no-preload-965778) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:1b:43:04", ip: ""} in network mk-no-preload-965778: {Iface:virbr1 ExpiryTime:2024-07-29 14:50:49 +0000 UTC Type:0 Mac:52:54:00:1b:43:04 Iaid: IPaddr:192.168.72.204 Prefix:24 Hostname:no-preload-965778 Clientid:01:52:54:00:1b:43:04}
I0729 13:50:59.105056 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined IP address 192.168.72.204 and MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:50:59.105237 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHPort
I0729 13:50:59.105434 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHKeyPath
I0729 13:50:59.105595 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHKeyPath
I0729 13:50:59.105754 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHUsername
I0729 13:50:59.105954 239535 main.go:141] libmachine: Using SSH client type: native
I0729 13:50:59.106120 239535 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x82da80] 0x8307e0 <nil> [] 0s} 192.168.72.204 22 <nil> <nil>}
I0729 13:50:59.106132 239535 main.go:141] libmachine: About to run SSH command:
sudo hostname no-preload-965778 && echo "no-preload-965778" | sudo tee /etc/hostname
I0729 13:50:59.233001 239535 main.go:141] libmachine: SSH cmd err, output: <nil>: no-preload-965778
I0729 13:50:59.233027 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHHostname
I0729 13:50:59.235974 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:50:59.236373 239535 main.go:141] libmachine: (no-preload-965778) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:1b:43:04", ip: ""} in network mk-no-preload-965778: {Iface:virbr1 ExpiryTime:2024-07-29 14:50:49 +0000 UTC Type:0 Mac:52:54:00:1b:43:04 Iaid: IPaddr:192.168.72.204 Prefix:24 Hostname:no-preload-965778 Clientid:01:52:54:00:1b:43:04}
I0729 13:50:59.236397 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined IP address 192.168.72.204 and MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:50:59.236561 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHPort
I0729 13:50:59.236770 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHKeyPath
I0729 13:50:59.236989 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHKeyPath
I0729 13:50:59.237142 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHUsername
I0729 13:50:59.237330 239535 main.go:141] libmachine: Using SSH client type: native
I0729 13:50:59.237499 239535 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x82da80] 0x8307e0 <nil> [] 0s} 192.168.72.204 22 <nil> <nil>}
I0729 13:50:59.237515 239535 main.go:141] libmachine: About to run SSH command:
if ! grep -xq '.*\sno-preload-965778' /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 no-preload-965778/g' /etc/hosts;
else
echo '127.0.1.1 no-preload-965778' | sudo tee -a /etc/hosts;
fi
fi
I0729 13:50:59.353226 239535 main.go:141] libmachine: SSH cmd err, output: <nil>:
I0729 13:50:59.353267 239535 buildroot.go:172] set auth options {CertDir:/home/jenkins/minikube-integration/19338-179709/.minikube CaCertPath:/home/jenkins/minikube-integration/19338-179709/.minikube/certs/ca.pem CaPrivateKeyPath:/home/jenkins/minikube-integration/19338-179709/.minikube/certs/ca-key.pem CaCertRemotePath:/etc/docker/ca.pem ServerCertPath:/home/jenkins/minikube-integration/19338-179709/.minikube/machines/server.pem ServerKeyPath:/home/jenkins/minikube-integration/19338-179709/.minikube/machines/server-key.pem ClientKeyPath:/home/jenkins/minikube-integration/19338-179709/.minikube/certs/key.pem ServerCertRemotePath:/etc/docker/server.pem ServerKeyRemotePath:/etc/docker/server-key.pem ClientCertPath:/home/jenkins/minikube-integration/19338-179709/.minikube/certs/cert.pem ServerCertSANs:[] StorePath:/home/jenkins/minikube-integration/19338-179709/.minikube}
I0729 13:50:59.353336 239535 buildroot.go:174] setting up certificates
I0729 13:50:59.353352 239535 provision.go:84] configureAuth start
I0729 13:50:59.353372 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetMachineName
I0729 13:50:59.353692 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetIP
I0729 13:50:59.356530 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:50:59.356943 239535 main.go:141] libmachine: (no-preload-965778) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:1b:43:04", ip: ""} in network mk-no-preload-965778: {Iface:virbr1 ExpiryTime:2024-07-29 14:50:49 +0000 UTC Type:0 Mac:52:54:00:1b:43:04 Iaid: IPaddr:192.168.72.204 Prefix:24 Hostname:no-preload-965778 Clientid:01:52:54:00:1b:43:04}
I0729 13:50:59.356987 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined IP address 192.168.72.204 and MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:50:59.357187 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHHostname
I0729 13:50:59.360029 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:50:59.360513 239535 main.go:141] libmachine: (no-preload-965778) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:1b:43:04", ip: ""} in network mk-no-preload-965778: {Iface:virbr1 ExpiryTime:2024-07-29 14:50:49 +0000 UTC Type:0 Mac:52:54:00:1b:43:04 Iaid: IPaddr:192.168.72.204 Prefix:24 Hostname:no-preload-965778 Clientid:01:52:54:00:1b:43:04}
I0729 13:50:59.360541 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined IP address 192.168.72.204 and MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:50:59.360699 239535 provision.go:143] copyHostCerts
I0729 13:50:59.360768 239535 exec_runner.go:144] found /home/jenkins/minikube-integration/19338-179709/.minikube/ca.pem, removing ...
I0729 13:50:59.360783 239535 exec_runner.go:203] rm: /home/jenkins/minikube-integration/19338-179709/.minikube/ca.pem
I0729 13:50:59.360871 239535 exec_runner.go:151] cp: /home/jenkins/minikube-integration/19338-179709/.minikube/certs/ca.pem --> /home/jenkins/minikube-integration/19338-179709/.minikube/ca.pem (1078 bytes)
I0729 13:50:59.360999 239535 exec_runner.go:144] found /home/jenkins/minikube-integration/19338-179709/.minikube/cert.pem, removing ...
I0729 13:50:59.361011 239535 exec_runner.go:203] rm: /home/jenkins/minikube-integration/19338-179709/.minikube/cert.pem
I0729 13:50:59.361048 239535 exec_runner.go:151] cp: /home/jenkins/minikube-integration/19338-179709/.minikube/certs/cert.pem --> /home/jenkins/minikube-integration/19338-179709/.minikube/cert.pem (1123 bytes)
I0729 13:50:59.361108 239535 exec_runner.go:144] found /home/jenkins/minikube-integration/19338-179709/.minikube/key.pem, removing ...
I0729 13:50:59.361115 239535 exec_runner.go:203] rm: /home/jenkins/minikube-integration/19338-179709/.minikube/key.pem
I0729 13:50:59.361136 239535 exec_runner.go:151] cp: /home/jenkins/minikube-integration/19338-179709/.minikube/certs/key.pem --> /home/jenkins/minikube-integration/19338-179709/.minikube/key.pem (1679 bytes)
I0729 13:50:59.361185 239535 provision.go:117] generating server cert: /home/jenkins/minikube-integration/19338-179709/.minikube/machines/server.pem ca-key=/home/jenkins/minikube-integration/19338-179709/.minikube/certs/ca.pem private-key=/home/jenkins/minikube-integration/19338-179709/.minikube/certs/ca-key.pem org=jenkins.no-preload-965778 san=[127.0.0.1 192.168.72.204 localhost minikube no-preload-965778]
I0729 13:50:59.812245 239535 provision.go:177] copyRemoteCerts
I0729 13:50:59.812338 239535 ssh_runner.go:195] Run: sudo mkdir -p /etc/docker /etc/docker /etc/docker
I0729 13:50:59.812381 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHHostname
I0729 13:50:59.816096 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:50:59.816549 239535 main.go:141] libmachine: (no-preload-965778) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:1b:43:04", ip: ""} in network mk-no-preload-965778: {Iface:virbr1 ExpiryTime:2024-07-29 14:50:49 +0000 UTC Type:0 Mac:52:54:00:1b:43:04 Iaid: IPaddr:192.168.72.204 Prefix:24 Hostname:no-preload-965778 Clientid:01:52:54:00:1b:43:04}
I0729 13:50:59.816577 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined IP address 192.168.72.204 and MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:50:59.816760 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHPort
I0729 13:50:59.817000 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHKeyPath
I0729 13:50:59.817163 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHUsername
I0729 13:50:59.817347 239535 sshutil.go:53] new ssh client: &{IP:192.168.72.204 Port:22 SSHKeyPath:/home/jenkins/minikube-integration/19338-179709/.minikube/machines/no-preload-965778/id_rsa Username:docker}
I0729 13:50:59.899636 239535 ssh_runner.go:362] scp /home/jenkins/minikube-integration/19338-179709/.minikube/certs/ca.pem --> /etc/docker/ca.pem (1078 bytes)
I0729 13:50:59.926956 239535 ssh_runner.go:362] scp /home/jenkins/minikube-integration/19338-179709/.minikube/machines/server.pem --> /etc/docker/server.pem (1220 bytes)
I0729 13:50:59.955486 239535 ssh_runner.go:362] scp /home/jenkins/minikube-integration/19338-179709/.minikube/machines/server-key.pem --> /etc/docker/server-key.pem (1679 bytes)
I0729 13:50:59.978729 239535 provision.go:87] duration metric: took 625.360909ms to configureAuth
I0729 13:50:59.978758 239535 buildroot.go:189] setting minikube options for container-runtime
I0729 13:50:59.978934 239535 config.go:182] Loaded profile config "no-preload-965778": Driver=kvm2, ContainerRuntime=docker, KubernetesVersion=v1.31.0-beta.0
I0729 13:50:59.978960 239535 main.go:141] libmachine: (no-preload-965778) Calling .DriverName
I0729 13:50:59.979198 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHHostname
I0729 13:50:59.981797 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:50:59.982201 239535 main.go:141] libmachine: (no-preload-965778) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:1b:43:04", ip: ""} in network mk-no-preload-965778: {Iface:virbr1 ExpiryTime:2024-07-29 14:50:49 +0000 UTC Type:0 Mac:52:54:00:1b:43:04 Iaid: IPaddr:192.168.72.204 Prefix:24 Hostname:no-preload-965778 Clientid:01:52:54:00:1b:43:04}
I0729 13:50:59.982240 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined IP address 192.168.72.204 and MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:50:59.982412 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHPort
I0729 13:50:59.982604 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHKeyPath
I0729 13:50:59.982799 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHKeyPath
I0729 13:50:59.982963 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHUsername
I0729 13:50:59.983160 239535 main.go:141] libmachine: Using SSH client type: native
I0729 13:50:59.983336 239535 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x82da80] 0x8307e0 <nil> [] 0s} 192.168.72.204 22 <nil> <nil>}
I0729 13:50:59.983348 239535 main.go:141] libmachine: About to run SSH command:
df --output=fstype / | tail -n 1
I0729 13:51:00.094340 239535 main.go:141] libmachine: SSH cmd err, output: <nil>: tmpfs
I0729 13:51:00.094367 239535 buildroot.go:70] root file system type: tmpfs
I0729 13:51:00.094502 239535 provision.go:314] Updating docker unit: /lib/systemd/system/docker.service ...
I0729 13:51:00.094527 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHHostname
I0729 13:51:00.097741 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:51:00.098190 239535 main.go:141] libmachine: (no-preload-965778) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:1b:43:04", ip: ""} in network mk-no-preload-965778: {Iface:virbr1 ExpiryTime:2024-07-29 14:50:49 +0000 UTC Type:0 Mac:52:54:00:1b:43:04 Iaid: IPaddr:192.168.72.204 Prefix:24 Hostname:no-preload-965778 Clientid:01:52:54:00:1b:43:04}
I0729 13:51:00.098220 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined IP address 192.168.72.204 and MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:51:00.098360 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHPort
I0729 13:51:00.098601 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHKeyPath
I0729 13:51:00.098795 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHKeyPath
I0729 13:51:00.098944 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHUsername
I0729 13:51:00.099102 239535 main.go:141] libmachine: Using SSH client type: native
I0729 13:51:00.099293 239535 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x82da80] 0x8307e0 <nil> [] 0s} 192.168.72.204 22 <nil> <nil>}
I0729 13:51:00.099356 239535 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
I0729 13:51:00.234013 239535 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
I0729 13:51:00.234075 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHHostname
I0729 13:51:00.237433 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:51:00.237830 239535 main.go:141] libmachine: (no-preload-965778) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:1b:43:04", ip: ""} in network mk-no-preload-965778: {Iface:virbr1 ExpiryTime:2024-07-29 14:50:49 +0000 UTC Type:0 Mac:52:54:00:1b:43:04 Iaid: IPaddr:192.168.72.204 Prefix:24 Hostname:no-preload-965778 Clientid:01:52:54:00:1b:43:04}
I0729 13:51:00.237856 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined IP address 192.168.72.204 and MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:51:00.238051 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHPort
I0729 13:51:00.238243 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHKeyPath
I0729 13:51:00.238442 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHKeyPath
I0729 13:51:00.238569 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHUsername
I0729 13:51:00.238752 239535 main.go:141] libmachine: Using SSH client type: native
I0729 13:51:00.238967 239535 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x82da80] 0x8307e0 <nil> [] 0s} 192.168.72.204 22 <nil> <nil>}
I0729 13:51:00.238994 239535 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; }
I0729 13:51:02.080738 239535 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.
I0729 13:51:02.080796 239535 main.go:141] libmachine: Checking connection to Docker...
I0729 13:51:02.080812 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetURL
I0729 13:51:02.082214 239535 main.go:141] libmachine: (no-preload-965778) DBG | Using libvirt version 6000000
I0729 13:51:02.084852 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:51:02.085251 239535 main.go:141] libmachine: (no-preload-965778) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:1b:43:04", ip: ""} in network mk-no-preload-965778: {Iface:virbr1 ExpiryTime:2024-07-29 14:50:49 +0000 UTC Type:0 Mac:52:54:00:1b:43:04 Iaid: IPaddr:192.168.72.204 Prefix:24 Hostname:no-preload-965778 Clientid:01:52:54:00:1b:43:04}
I0729 13:51:02.085282 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined IP address 192.168.72.204 and MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:51:02.085467 239535 main.go:141] libmachine: Docker is up and running!
I0729 13:51:02.085487 239535 main.go:141] libmachine: Reticulating splines...
I0729 13:51:02.085497 239535 client.go:171] duration metric: took 28.816786221s to LocalClient.Create
I0729 13:51:02.085526 239535 start.go:167] duration metric: took 28.816849347s to libmachine.API.Create "no-preload-965778"
I0729 13:51:02.085538 239535 start.go:293] postStartSetup for "no-preload-965778" (driver="kvm2")
I0729 13:51:02.085555 239535 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]
I0729 13:51:02.085578 239535 main.go:141] libmachine: (no-preload-965778) Calling .DriverName
I0729 13:51:02.085846 239535 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
I0729 13:51:02.085874 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHHostname
I0729 13:51:02.087743 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:51:02.088101 239535 main.go:141] libmachine: (no-preload-965778) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:1b:43:04", ip: ""} in network mk-no-preload-965778: {Iface:virbr1 ExpiryTime:2024-07-29 14:50:49 +0000 UTC Type:0 Mac:52:54:00:1b:43:04 Iaid: IPaddr:192.168.72.204 Prefix:24 Hostname:no-preload-965778 Clientid:01:52:54:00:1b:43:04}
I0729 13:51:02.088121 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined IP address 192.168.72.204 and MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:51:02.088276 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHPort
I0729 13:51:02.088493 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHKeyPath
I0729 13:51:02.088666 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHUsername
I0729 13:51:02.088841 239535 sshutil.go:53] new ssh client: &{IP:192.168.72.204 Port:22 SSHKeyPath:/home/jenkins/minikube-integration/19338-179709/.minikube/machines/no-preload-965778/id_rsa Username:docker}
I0729 13:51:02.175046 239535 ssh_runner.go:195] Run: cat /etc/os-release
I0729 13:51:02.179954 239535 info.go:137] Remote host: Buildroot 2023.02.9
I0729 13:51:02.180022 239535 filesync.go:126] Scanning /home/jenkins/minikube-integration/19338-179709/.minikube/addons for local assets ...
I0729 13:51:02.180098 239535 filesync.go:126] Scanning /home/jenkins/minikube-integration/19338-179709/.minikube/files for local assets ...
I0729 13:51:02.180196 239535 filesync.go:149] local asset: /home/jenkins/minikube-integration/19338-179709/.minikube/files/etc/ssl/certs/1869512.pem -> 1869512.pem in /etc/ssl/certs
I0729 13:51:02.180305 239535 ssh_runner.go:195] Run: sudo mkdir -p /etc/ssl/certs
I0729 13:51:02.189514 239535 ssh_runner.go:362] scp /home/jenkins/minikube-integration/19338-179709/.minikube/files/etc/ssl/certs/1869512.pem --> /etc/ssl/certs/1869512.pem (1708 bytes)
I0729 13:51:02.212462 239535 start.go:296] duration metric: took 126.905287ms for postStartSetup
I0729 13:51:02.212515 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetConfigRaw
I0729 13:51:02.213180 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetIP
I0729 13:51:02.216086 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:51:02.216575 239535 main.go:141] libmachine: (no-preload-965778) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:1b:43:04", ip: ""} in network mk-no-preload-965778: {Iface:virbr1 ExpiryTime:2024-07-29 14:50:49 +0000 UTC Type:0 Mac:52:54:00:1b:43:04 Iaid: IPaddr:192.168.72.204 Prefix:24 Hostname:no-preload-965778 Clientid:01:52:54:00:1b:43:04}
I0729 13:51:02.216614 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined IP address 192.168.72.204 and MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:51:02.216843 239535 profile.go:143] Saving config to /home/jenkins/minikube-integration/19338-179709/.minikube/profiles/no-preload-965778/config.json ...
I0729 13:51:02.217060 239535 start.go:128] duration metric: took 28.975460758s to createHost
I0729 13:51:02.217095 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHHostname
I0729 13:51:02.219753 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:51:02.220050 239535 main.go:141] libmachine: (no-preload-965778) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:1b:43:04", ip: ""} in network mk-no-preload-965778: {Iface:virbr1 ExpiryTime:2024-07-29 14:50:49 +0000 UTC Type:0 Mac:52:54:00:1b:43:04 Iaid: IPaddr:192.168.72.204 Prefix:24 Hostname:no-preload-965778 Clientid:01:52:54:00:1b:43:04}
I0729 13:51:02.220090 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined IP address 192.168.72.204 and MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:51:02.220217 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHPort
I0729 13:51:02.220412 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHKeyPath
I0729 13:51:02.220571 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHKeyPath
I0729 13:51:02.220734 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHUsername
I0729 13:51:02.220912 239535 main.go:141] libmachine: Using SSH client type: native
I0729 13:51:02.221107 239535 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x82da80] 0x8307e0 <nil> [] 0s} 192.168.72.204 22 <nil> <nil>}
I0729 13:51:02.221119 239535 main.go:141] libmachine: About to run SSH command:
date +%s.%N
I0729 13:51:02.334415 239535 main.go:141] libmachine: SSH cmd err, output: <nil>: 1722261062.285416261
I0729 13:51:02.334441 239535 fix.go:216] guest clock: 1722261062.285416261
I0729 13:51:02.334451 239535 fix.go:229] Guest: 2024-07-29 13:51:02.285416261 +0000 UTC Remote: 2024-07-29 13:51:02.217076962 +0000 UTC m=+29.138140018 (delta=68.339299ms)
I0729 13:51:02.334489 239535 fix.go:200] guest clock delta is within tolerance: 68.339299ms
I0729 13:51:02.334497 239535 start.go:83] releasing machines lock for "no-preload-965778", held for 29.093026118s
I0729 13:51:02.334526 239535 main.go:141] libmachine: (no-preload-965778) Calling .DriverName
I0729 13:51:02.334813 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetIP
I0729 13:51:02.337911 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:51:02.338334 239535 main.go:141] libmachine: (no-preload-965778) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:1b:43:04", ip: ""} in network mk-no-preload-965778: {Iface:virbr1 ExpiryTime:2024-07-29 14:50:49 +0000 UTC Type:0 Mac:52:54:00:1b:43:04 Iaid: IPaddr:192.168.72.204 Prefix:24 Hostname:no-preload-965778 Clientid:01:52:54:00:1b:43:04}
I0729 13:51:02.338361 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined IP address 192.168.72.204 and MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:51:02.338545 239535 main.go:141] libmachine: (no-preload-965778) Calling .DriverName
I0729 13:51:02.339114 239535 main.go:141] libmachine: (no-preload-965778) Calling .DriverName
I0729 13:51:02.339336 239535 main.go:141] libmachine: (no-preload-965778) Calling .DriverName
I0729 13:51:02.339434 239535 ssh_runner.go:195] Run: curl -sS -m 2 https://registry.k8s.io/
I0729 13:51:02.339472 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHHostname
I0729 13:51:02.339563 239535 ssh_runner.go:195] Run: cat /version.json
I0729 13:51:02.339579 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHHostname
I0729 13:51:02.344145 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:51:02.344359 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:51:02.344739 239535 main.go:141] libmachine: (no-preload-965778) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:1b:43:04", ip: ""} in network mk-no-preload-965778: {Iface:virbr1 ExpiryTime:2024-07-29 14:50:49 +0000 UTC Type:0 Mac:52:54:00:1b:43:04 Iaid: IPaddr:192.168.72.204 Prefix:24 Hostname:no-preload-965778 Clientid:01:52:54:00:1b:43:04}
I0729 13:51:02.344789 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined IP address 192.168.72.204 and MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:51:02.344646 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHPort
I0729 13:51:02.345012 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHPort
I0729 13:51:02.345054 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHKeyPath
I0729 13:51:02.345088 239535 main.go:141] libmachine: (no-preload-965778) DBG | found host DHCP lease matching {name: "", mac: "52:54:00:1b:43:04", ip: ""} in network mk-no-preload-965778: {Iface:virbr1 ExpiryTime:2024-07-29 14:50:49 +0000 UTC Type:0 Mac:52:54:00:1b:43:04 Iaid: IPaddr:192.168.72.204 Prefix:24 Hostname:no-preload-965778 Clientid:01:52:54:00:1b:43:04}
I0729 13:51:02.345101 239535 main.go:141] libmachine: (no-preload-965778) DBG | domain no-preload-965778 has defined IP address 192.168.72.204 and MAC address 52:54:00:1b:43:04 in network mk-no-preload-965778
I0729 13:51:02.345220 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHUsername
I0729 13:51:02.345279 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHKeyPath
I0729 13:51:02.345474 239535 sshutil.go:53] new ssh client: &{IP:192.168.72.204 Port:22 SSHKeyPath:/home/jenkins/minikube-integration/19338-179709/.minikube/machines/no-preload-965778/id_rsa Username:docker}
I0729 13:51:02.345490 239535 main.go:141] libmachine: (no-preload-965778) Calling .GetSSHUsername
I0729 13:51:02.345659 239535 sshutil.go:53] new ssh client: &{IP:192.168.72.204 Port:22 SSHKeyPath:/home/jenkins/minikube-integration/19338-179709/.minikube/machines/no-preload-965778/id_rsa Username:docker}
I0729 13:51:02.452201 239535 ssh_runner.go:195] Run: systemctl --version
I0729 13:51:02.460308 239535 ssh_runner.go:195] Run: sh -c "stat /etc/cni/net.d/*loopback.conf*"
W0729 13:51:02.467490 239535 cni.go:209] loopback cni configuration skipped: "/etc/cni/net.d/*loopback.conf*" not found
I0729 13:51:02.467564 239535 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" ;
I0729 13:51:02.490939 239535 cni.go:262] disabled [/etc/cni/net.d/87-podman-bridge.conflist] bridge cni config(s)
I0729 13:51:02.490970 239535 start.go:495] detecting cgroup driver to use...
I0729 13:51:02.491104 239535 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"
I0729 13:51:02.513658 239535 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"
I0729 13:51:02.527350 239535 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"
I0729 13:51:02.541237 239535 containerd.go:146] configuring containerd to use "cgroupfs" as cgroup driver...
I0729 13:51:02.541311 239535 ssh_runner.go:195] Run: sh -c "sudo sed -i -r 's|^( *)SystemdCgroup = .*$|\1SystemdCgroup = false|g' /etc/containerd/config.toml"
I0729 13:51:02.558737 239535 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"
I0729 13:51:02.574484 239535 ssh_runner.go:195] Run: sh -c "sudo sed -i '/systemd_cgroup/d' /etc/containerd/config.toml"
I0729 13:51:02.590798 239535 ssh_runner.go:195] Run: sh -c "sudo sed -i 's|"io.containerd.runc.v1"|"io.containerd.runc.v2"|g' /etc/containerd/config.toml"
I0729 13:51:02.607617 239535 ssh_runner.go:195] Run: sh -c "sudo rm -rf /etc/cni/net.mk"
I0729 13:51:02.623326 239535 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"
I0729 13:51:02.643331 239535 ssh_runner.go:195] Run: sh -c "sudo sed -i '/^ *enable_unprivileged_ports = .*/d' /etc/containerd/config.toml"
I0729 13:51:02.659399 239535 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"
I0729 13:51:02.671087 239535 ssh_runner.go:195] Run: sudo sysctl net.bridge.bridge-nf-call-iptables
I0729 13:51:02.684697 239535 ssh_runner.go:195] Run: sudo sh -c "echo 1 > /proc/sys/net/ipv4/ip_forward"
I0729 13:51:02.699343 239535 ssh_runner.go:195] Run: sudo systemctl daemon-reload
I0729 13:51:02.849789 239535 ssh_runner.go:195] Run: sudo systemctl restart containerd
I0729 13:51:02.875868 239535 start.go:495] detecting cgroup driver to use...
I0729 13:51:02.875970 239535 ssh_runner.go:195] Run: sudo systemctl cat docker.service
I0729 13:51:02.897189 239535 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service containerd
I0729 13:51:02.922557 239535 ssh_runner.go:195] Run: sudo systemctl stop -f containerd
I0729 13:51:02.946444 239535 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service containerd
I0729 13:51:02.961791 239535 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service crio
I0729 13:51:02.977774 239535 ssh_runner.go:195] Run: sudo systemctl stop -f crio
I0729 13:51:03.013197 239535 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service crio
I0729 13:51:03.030115 239535 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"
I0729 13:51:03.054960 239535 ssh_runner.go:195] Run: which cri-dockerd
I0729 13:51:03.060543 239535 ssh_runner.go:195] Run: sudo mkdir -p /etc/systemd/system/cri-docker.service.d
I0729 13:51:03.073518 239535 ssh_runner.go:362] scp memory --> /etc/systemd/system/cri-docker.service.d/10-cni.conf (190 bytes)
I0729 13:51:03.094246 239535 ssh_runner.go:195] Run: sudo systemctl unmask docker.service
I0729 13:51:03.225729 239535 ssh_runner.go:195] Run: sudo systemctl enable docker.socket
I0729 13:51:03.384106 239535 docker.go:574] configuring docker to use "cgroupfs" as cgroup driver...
I0729 13:51:03.384260 239535 ssh_runner.go:362] scp memory --> /etc/docker/daemon.json (130 bytes)
I0729 13:51:03.411409 239535 ssh_runner.go:195] Run: sudo systemctl daemon-reload
I0729 13:51:03.549884 239535 ssh_runner.go:195] Run: sudo systemctl restart docker
I0729 13:52:04.597697 239535 ssh_runner.go:235] Completed: sudo systemctl restart docker: (1m1.047769066s)
I0729 13:52:04.597782 239535 ssh_runner.go:195] Run: sudo journalctl --no-pager -u docker
I0729 13:52:04.746753 239535 out.go:177]
W0729 13:52:04.870648 239535 out.go:239] X Exiting due to RUNTIME_ENABLE: Failed to enable container runtime: sudo systemctl restart docker: Process exited with status 1
stdout:
stderr:
Job for docker.service failed because the control process exited with error code.
See "systemctl status docker.service" and "journalctl -xeu docker.service" for details.
sudo journalctl --no-pager -u docker:
-- stdout --
Jul 29 13:51:00 no-preload-965778 systemd[1]: Starting Docker Application Container Engine...
Jul 29 13:51:00 no-preload-965778 dockerd[529]: time="2024-07-29T13:51:00.627506302Z" level=info msg="Starting up"
Jul 29 13:51:00 no-preload-965778 dockerd[529]: time="2024-07-29T13:51:00.629138475Z" level=info msg="containerd not running, starting managed containerd"
Jul 29 13:51:00 no-preload-965778 dockerd[529]: time="2024-07-29T13:51:00.630146803Z" level=info msg="started new containerd process" address=/var/run/docker/containerd/containerd.sock module=libcontainerd pid=536
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.658171476Z" level=info msg="starting containerd" revision=8fc6bcff51318944179630522a095cc9dbf9f353 version=v1.7.20
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.682441609Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.682592824Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.682682986Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.682723536Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.682851910Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.682972952Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.683241537Z" 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
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.683310771Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.683358196Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.683393791Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.683505962Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.683719400Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.685810341Z" 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
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.685959551Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.686230657Z" 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
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.686306833Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.686422352Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.686495161Z" level=info msg="metadata content store policy set" policy=shared
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.699799385Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.700018632Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.701009763Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.701122471Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.701157636Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.701322472Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.701972360Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702124211Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702159811Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702178133Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702193728Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702210850Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702230278Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702247043Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702263945Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702279337Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702293898Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702306886Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702331758Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702348565Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702363887Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702379414Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702393504Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702408714Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702420653Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702440028Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702456838Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702473483Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702487859Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702501206Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702514923Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702535731Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702558768Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702573120Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702585579Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702638743Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702659881Z" 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
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702698953Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702724259Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702747846Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702783217Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702810904Z" level=info msg="NRI interface is disabled by configuration."
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.704332729Z" level=info msg=serving... address=/var/run/docker/containerd/containerd-debug.sock
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.704607880Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock.ttrpc
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.704831155Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.704976119Z" level=info msg="containerd successfully booted in 0.047789s"
Jul 29 13:51:01 no-preload-965778 dockerd[529]: time="2024-07-29T13:51:01.670730056Z" level=info msg="[graphdriver] trying configured driver: overlay2"
Jul 29 13:51:01 no-preload-965778 dockerd[529]: time="2024-07-29T13:51:01.688200493Z" level=info msg="Loading containers: start."
Jul 29 13:51:01 no-preload-965778 dockerd[529]: time="2024-07-29T13:51:01.800631892Z" 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)"
Jul 29 13:51:01 no-preload-965778 dockerd[529]: time="2024-07-29T13:51:01.934133681Z" level=info msg="Loading containers: done."
Jul 29 13:51:01 no-preload-965778 dockerd[529]: time="2024-07-29T13:51:01.950396882Z" level=info msg="Docker daemon" commit=a21b1a2 containerd-snapshotter=false storage-driver=overlay2 version=27.1.0
Jul 29 13:51:01 no-preload-965778 dockerd[529]: time="2024-07-29T13:51:01.950555211Z" level=info msg="Daemon has completed initialization"
Jul 29 13:51:02 no-preload-965778 dockerd[529]: time="2024-07-29T13:51:02.028374157Z" level=info msg="API listen on /var/run/docker.sock"
Jul 29 13:51:02 no-preload-965778 dockerd[529]: time="2024-07-29T13:51:02.028612453Z" level=info msg="API listen on [::]:2376"
Jul 29 13:51:02 no-preload-965778 systemd[1]: Started Docker Application Container Engine.
Jul 29 13:51:03 no-preload-965778 dockerd[529]: time="2024-07-29T13:51:03.523458428Z" level=info msg="Processing signal 'terminated'"
Jul 29 13:51:03 no-preload-965778 systemd[1]: Stopping Docker Application Container Engine...
Jul 29 13:51:03 no-preload-965778 dockerd[529]: time="2024-07-29T13:51:03.524910780Z" level=info msg="stopping event stream following graceful shutdown" error="<nil>" module=libcontainerd namespace=moby
Jul 29 13:51:03 no-preload-965778 dockerd[529]: time="2024-07-29T13:51:03.525491715Z" level=info msg="Daemon shutdown complete"
Jul 29 13:51:03 no-preload-965778 dockerd[529]: time="2024-07-29T13:51:03.525559617Z" level=info msg="stopping healthcheck following graceful shutdown" module=libcontainerd
Jul 29 13:51:03 no-preload-965778 dockerd[529]: time="2024-07-29T13:51:03.525626121Z" level=info msg="stopping event stream following graceful shutdown" error="context canceled" module=libcontainerd namespace=plugins.moby
Jul 29 13:51:04 no-preload-965778 systemd[1]: docker.service: Deactivated successfully.
Jul 29 13:51:04 no-preload-965778 systemd[1]: Stopped Docker Application Container Engine.
Jul 29 13:51:04 no-preload-965778 systemd[1]: Starting Docker Application Container Engine...
Jul 29 13:51:04 no-preload-965778 dockerd[844]: time="2024-07-29T13:51:04.571173609Z" level=info msg="Starting up"
Jul 29 13:52:04 no-preload-965778 dockerd[844]: failed to start daemon: failed to dial "/run/containerd/containerd.sock": failed to dial "/run/containerd/containerd.sock": context deadline exceeded
Jul 29 13:52:04 no-preload-965778 systemd[1]: docker.service: Main process exited, code=exited, status=1/FAILURE
Jul 29 13:52:04 no-preload-965778 systemd[1]: docker.service: Failed with result 'exit-code'.
Jul 29 13:52:04 no-preload-965778 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 --
Jul 29 13:51:00 no-preload-965778 systemd[1]: Starting Docker Application Container Engine...
Jul 29 13:51:00 no-preload-965778 dockerd[529]: time="2024-07-29T13:51:00.627506302Z" level=info msg="Starting up"
Jul 29 13:51:00 no-preload-965778 dockerd[529]: time="2024-07-29T13:51:00.629138475Z" level=info msg="containerd not running, starting managed containerd"
Jul 29 13:51:00 no-preload-965778 dockerd[529]: time="2024-07-29T13:51:00.630146803Z" level=info msg="started new containerd process" address=/var/run/docker/containerd/containerd.sock module=libcontainerd pid=536
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.658171476Z" level=info msg="starting containerd" revision=8fc6bcff51318944179630522a095cc9dbf9f353 version=v1.7.20
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.682441609Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.682592824Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.682682986Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.682723536Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.682851910Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.682972952Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.683241537Z" 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
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.683310771Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.683358196Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.683393791Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.683505962Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.683719400Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.685810341Z" 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
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.685959551Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.686230657Z" 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
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.686306833Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.686422352Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.686495161Z" level=info msg="metadata content store policy set" policy=shared
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.699799385Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.700018632Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.701009763Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.701122471Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.701157636Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.701322472Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.701972360Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702124211Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702159811Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702178133Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702193728Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702210850Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702230278Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702247043Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702263945Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702279337Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702293898Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702306886Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702331758Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702348565Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702363887Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702379414Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702393504Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702408714Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702420653Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702440028Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702456838Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702473483Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702487859Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702501206Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702514923Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702535731Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702558768Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702573120Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702585579Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702638743Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702659881Z" 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
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702698953Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702724259Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702747846Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702783217Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.702810904Z" level=info msg="NRI interface is disabled by configuration."
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.704332729Z" level=info msg=serving... address=/var/run/docker/containerd/containerd-debug.sock
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.704607880Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock.ttrpc
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.704831155Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock
Jul 29 13:51:00 no-preload-965778 dockerd[536]: time="2024-07-29T13:51:00.704976119Z" level=info msg="containerd successfully booted in 0.047789s"
Jul 29 13:51:01 no-preload-965778 dockerd[529]: time="2024-07-29T13:51:01.670730056Z" level=info msg="[graphdriver] trying configured driver: overlay2"
Jul 29 13:51:01 no-preload-965778 dockerd[529]: time="2024-07-29T13:51:01.688200493Z" level=info msg="Loading containers: start."
Jul 29 13:51:01 no-preload-965778 dockerd[529]: time="2024-07-29T13:51:01.800631892Z" 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)"
Jul 29 13:51:01 no-preload-965778 dockerd[529]: time="2024-07-29T13:51:01.934133681Z" level=info msg="Loading containers: done."
Jul 29 13:51:01 no-preload-965778 dockerd[529]: time="2024-07-29T13:51:01.950396882Z" level=info msg="Docker daemon" commit=a21b1a2 containerd-snapshotter=false storage-driver=overlay2 version=27.1.0
Jul 29 13:51:01 no-preload-965778 dockerd[529]: time="2024-07-29T13:51:01.950555211Z" level=info msg="Daemon has completed initialization"
Jul 29 13:51:02 no-preload-965778 dockerd[529]: time="2024-07-29T13:51:02.028374157Z" level=info msg="API listen on /var/run/docker.sock"
Jul 29 13:51:02 no-preload-965778 dockerd[529]: time="2024-07-29T13:51:02.028612453Z" level=info msg="API listen on [::]:2376"
Jul 29 13:51:02 no-preload-965778 systemd[1]: Started Docker Application Container Engine.
Jul 29 13:51:03 no-preload-965778 dockerd[529]: time="2024-07-29T13:51:03.523458428Z" level=info msg="Processing signal 'terminated'"
Jul 29 13:51:03 no-preload-965778 systemd[1]: Stopping Docker Application Container Engine...
Jul 29 13:51:03 no-preload-965778 dockerd[529]: time="2024-07-29T13:51:03.524910780Z" level=info msg="stopping event stream following graceful shutdown" error="<nil>" module=libcontainerd namespace=moby
Jul 29 13:51:03 no-preload-965778 dockerd[529]: time="2024-07-29T13:51:03.525491715Z" level=info msg="Daemon shutdown complete"
Jul 29 13:51:03 no-preload-965778 dockerd[529]: time="2024-07-29T13:51:03.525559617Z" level=info msg="stopping healthcheck following graceful shutdown" module=libcontainerd
Jul 29 13:51:03 no-preload-965778 dockerd[529]: time="2024-07-29T13:51:03.525626121Z" level=info msg="stopping event stream following graceful shutdown" error="context canceled" module=libcontainerd namespace=plugins.moby
Jul 29 13:51:04 no-preload-965778 systemd[1]: docker.service: Deactivated successfully.
Jul 29 13:51:04 no-preload-965778 systemd[1]: Stopped Docker Application Container Engine.
Jul 29 13:51:04 no-preload-965778 systemd[1]: Starting Docker Application Container Engine...
Jul 29 13:51:04 no-preload-965778 dockerd[844]: time="2024-07-29T13:51:04.571173609Z" level=info msg="Starting up"
Jul 29 13:52:04 no-preload-965778 dockerd[844]: failed to start daemon: failed to dial "/run/containerd/containerd.sock": failed to dial "/run/containerd/containerd.sock": context deadline exceeded
Jul 29 13:52:04 no-preload-965778 systemd[1]: docker.service: Main process exited, code=exited, status=1/FAILURE
Jul 29 13:52:04 no-preload-965778 systemd[1]: docker.service: Failed with result 'exit-code'.
Jul 29 13:52:04 no-preload-965778 systemd[1]: Failed to start Docker Application Container Engine.
-- /stdout --
W0729 13:52:04.870745 239535 out.go:239] *
*
W0729 13:52:04.871916 239535 out.go:239] ╭─────────────────────────────────────────────────────────────────────────────────────────────╮
│ │
│ * If the above advice does not help, please let us know: │
│ https://github.com/kubernetes/minikube/issues/new/choose │
│ │
│ * Please run `minikube logs --file=logs.txt` and attach logs.txt to the GitHub issue. │
│ │
╰─────────────────────────────────────────────────────────────────────────────────────────────╯
╭─────────────────────────────────────────────────────────────────────────────────────────────╮
│ │
│ * If the above advice does not help, please let us know: │
│ https://github.com/kubernetes/minikube/issues/new/choose │
│ │
│ * Please run `minikube logs --file=logs.txt` and attach logs.txt to the GitHub issue. │
│ │
╰─────────────────────────────────────────────────────────────────────────────────────────────╯
I0729 13:52:04.910143 239535 out.go:177]
** /stderr **
start_stop_delete_test.go:188: failed starting minikube -first start-. args "out/minikube-linux-amd64 start -p no-preload-965778 --memory=2200 --alsologtostderr --wait=true --preload=false --driver=kvm2 --kubernetes-version=v1.31.0-beta.0": exit status 90
helpers_test.go:222: -----------------------post-mortem--------------------------------
helpers_test.go:239: (dbg) Run: out/minikube-linux-amd64 status --format={{.Host}} -p no-preload-965778 -n no-preload-965778
helpers_test.go:239: (dbg) Non-zero exit: out/minikube-linux-amd64 status --format={{.Host}} -p no-preload-965778 -n no-preload-965778: exit status 6 (268.885566ms)
-- stdout --
Running
WARNING: Your kubectl is pointing to stale minikube-vm.
To fix the kubectl context, run `minikube update-context`
-- /stdout --
** stderr **
E0729 13:52:05.245899 243030 status.go:417] kubeconfig endpoint: get endpoint: "no-preload-965778" does not appear in /home/jenkins/minikube-integration/19338-179709/kubeconfig
** /stderr **
helpers_test.go:239: status error: exit status 6 (may be ok)
helpers_test.go:241: "no-preload-965778" host is not running, skipping log retrieval (state="Running\nWARNING: Your kubectl is pointing to stale minikube-vm.\nTo fix the kubectl context, run `minikube update-context`")
--- FAIL: TestStartStop/group/no-preload/serial/FirstStart (92.19s)