=== RUN TestForceSystemdEnv
=== PAUSE TestForceSystemdEnv
=== CONT TestForceSystemdEnv
docker_test.go:155: (dbg) Run: out/minikube-darwin-amd64 start -p force-systemd-env-713000 --memory=2048 --alsologtostderr -v=5 --driver=hyperkit
docker_test.go:155: (dbg) Non-zero exit: out/minikube-darwin-amd64 start -p force-systemd-env-713000 --memory=2048 --alsologtostderr -v=5 --driver=hyperkit : exit status 90 (1m16.52147426s)
-- stdout --
* [force-systemd-env-713000] minikube v1.33.1 on Darwin 14.5
- MINIKUBE_LOCATION=19265
- KUBECONFIG=/Users/jenkins/minikube-integration/19265-954/kubeconfig
- MINIKUBE_BIN=out/minikube-darwin-amd64
- MINIKUBE_SUPPRESS_DOCKER_PERFORMANCE=true
- MINIKUBE_HOME=/Users/jenkins/minikube-integration/19265-954/.minikube
- MINIKUBE_FORCE_SYSTEMD=true
* Using the hyperkit driver based on user configuration
* Starting "force-systemd-env-713000" primary control-plane node in "force-systemd-env-713000" cluster
* Creating hyperkit VM (CPUs=2, Memory=2048MB, Disk=20000MB) ...
-- /stdout --
** stderr **
I0716 18:04:07.417794 5909 out.go:291] Setting OutFile to fd 1 ...
I0716 18:04:07.418064 5909 out.go:338] TERM=,COLORTERM=, which probably does not support color
I0716 18:04:07.418070 5909 out.go:304] Setting ErrFile to fd 2...
I0716 18:04:07.418073 5909 out.go:338] TERM=,COLORTERM=, which probably does not support color
I0716 18:04:07.418253 5909 root.go:338] Updating PATH: /Users/jenkins/minikube-integration/19265-954/.minikube/bin
I0716 18:04:07.419701 5909 out.go:298] Setting JSON to false
I0716 18:04:07.442013 5909 start.go:129] hostinfo: {"hostname":"MacOS-Agent-2.local","uptime":3821,"bootTime":1721174426,"procs":437,"os":"darwin","platform":"darwin","platformFamily":"Standalone Workstation","platformVersion":"14.5","kernelVersion":"23.5.0","kernelArch":"x86_64","virtualizationSystem":"","virtualizationRole":"","hostId":"2965c349-98a5-5970-aaa9-9eedd3ae5959"}
W0716 18:04:07.442102 5909 start.go:137] gopshost.Virtualization returned error: not implemented yet
I0716 18:04:07.464779 5909 out.go:177] * [force-systemd-env-713000] minikube v1.33.1 on Darwin 14.5
I0716 18:04:07.505456 5909 notify.go:220] Checking for updates...
I0716 18:04:07.526412 5909 out.go:177] - MINIKUBE_LOCATION=19265
I0716 18:04:07.568406 5909 out.go:177] - KUBECONFIG=/Users/jenkins/minikube-integration/19265-954/kubeconfig
I0716 18:04:07.589448 5909 out.go:177] - MINIKUBE_BIN=out/minikube-darwin-amd64
I0716 18:04:07.610328 5909 out.go:177] - MINIKUBE_SUPPRESS_DOCKER_PERFORMANCE=true
I0716 18:04:07.652593 5909 out.go:177] - MINIKUBE_HOME=/Users/jenkins/minikube-integration/19265-954/.minikube
I0716 18:04:07.694620 5909 out.go:177] - MINIKUBE_FORCE_SYSTEMD=true
I0716 18:04:07.716508 5909 config.go:182] Loaded profile config "offline-docker-728000": Driver=hyperkit, ContainerRuntime=docker, KubernetesVersion=v1.30.2
I0716 18:04:07.716684 5909 driver.go:392] Setting default libvirt URI to qemu:///system
I0716 18:04:07.746571 5909 out.go:177] * Using the hyperkit driver based on user configuration
I0716 18:04:07.788410 5909 start.go:297] selected driver: hyperkit
I0716 18:04:07.788444 5909 start.go:901] validating driver "hyperkit" against <nil>
I0716 18:04:07.788463 5909 start.go:912] status for hyperkit: {Installed:true Healthy:true Running:true NeedsImprovement:false Error:<nil> Reason: Fix: Doc: Version:}
I0716 18:04:07.793055 5909 install.go:52] acquiring lock: {Name:mk4023283b30b374c3f04c8805d539e68824c0b8 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I0716 18:04:07.793178 5909 install.go:117] Validating docker-machine-driver-hyperkit, PATH=/Users/jenkins/minikube-integration/19265-954/.minikube/bin:/Users/jenkins/workspace/out/:/usr/bin:/bin:/usr/sbin:/sbin:/Users/jenkins/google-cloud-sdk/bin:/usr/local/bin/:/usr/local/go/bin/:/Users/jenkins/go/bin
I0716 18:04:07.801576 5909 install.go:137] /Users/jenkins/workspace/out/docker-machine-driver-hyperkit version is 1.33.1
I0716 18:04:07.805439 5909 install.go:79] stdout: /Users/jenkins/workspace/out/docker-machine-driver-hyperkit
I0716 18:04:07.805468 5909 install.go:81] /Users/jenkins/workspace/out/docker-machine-driver-hyperkit looks good
I0716 18:04:07.805497 5909 start_flags.go:310] no existing cluster config was found, will generate one from the flags
I0716 18:04:07.805687 5909 start_flags.go:929] Wait components to verify : map[apiserver:true system_pods:true]
I0716 18:04:07.805711 5909 cni.go:84] Creating CNI manager for ""
I0716 18:04:07.805726 5909 cni.go:158] "hyperkit" driver + "docker" container runtime found on kubernetes v1.24+, recommending bridge
I0716 18:04:07.805736 5909 start_flags.go:319] Found "bridge CNI" CNI - setting NetworkPlugin=cni
I0716 18:04:07.805797 5909 start.go:340] cluster config:
{Name:force-systemd-env-713000 KeepContext:false EmbedCerts:false MinikubeISO: KicBaseImage:gcr.io/k8s-minikube/kicbase-builds:v0.0.44-1721064868-19249@sha256:f2789f25c9e51cdeb9cef760e15dc838ef08abd5bb1913311c1eabedda231e8c Memory:2048 CPUs:2 DiskSize:20000 Driver:hyperkit 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.30.2 ClusterName:force-systemd-env-713000 Namespace:default APIServerHAVIP: APIServerName:minikubeCA APIServerNames:[] APIServerIPs:[] DNSDomain:cluste
r.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.30.2 ContainerRuntime:docker ControlPlane:true Worker:true}] Addons:map[] CustomAddonImages:map[] CustomAddonRegistries:map[] VerifyComponents:map[apiserver:true system_pods:true] StartHostTimeout:6m0s ScheduledStop:<nil> ExposedPorts:[] ListenAddress: Network: Subnet: MultiNodeRequested:false ExtraDisks:0 CertExpiration:26280h0m0s Mount:false MountString:/Users:/minikube-host Mount9PVersion:9p2000.L MountGID:docker MountIP: MountMSize:262144 MountOptions:[] MountPort:0 MountType:9p MountUID:docker BinaryMirror: DisableOptimizations:false DisableMetrics:false CustomQemuFirmwarePath: SocketVMnetClientPath: SocketVMnetPath: StaticIP: SSHAuthSock: SSHAgentPID:0 GPUs: AutoPauseInterval:1m0s}
I0716 18:04:07.805879 5909 iso.go:125] acquiring lock: {Name:mkced6a806a852b61b3df9cccff08f2d1674618b Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I0716 18:04:07.848531 5909 out.go:177] * Starting "force-systemd-env-713000" primary control-plane node in "force-systemd-env-713000" cluster
I0716 18:04:07.869312 5909 preload.go:131] Checking if preload exists for k8s version v1.30.2 and runtime docker
I0716 18:04:07.869367 5909 preload.go:146] Found local preload: /Users/jenkins/minikube-integration/19265-954/.minikube/cache/preloaded-tarball/preloaded-images-k8s-v18-v1.30.2-docker-overlay2-amd64.tar.lz4
I0716 18:04:07.869389 5909 cache.go:56] Caching tarball of preloaded images
I0716 18:04:07.869526 5909 preload.go:172] Found /Users/jenkins/minikube-integration/19265-954/.minikube/cache/preloaded-tarball/preloaded-images-k8s-v18-v1.30.2-docker-overlay2-amd64.tar.lz4 in cache, skipping download
I0716 18:04:07.869538 5909 cache.go:59] Finished verifying existence of preloaded tar for v1.30.2 on docker
I0716 18:04:07.869624 5909 profile.go:143] Saving config to /Users/jenkins/minikube-integration/19265-954/.minikube/profiles/force-systemd-env-713000/config.json ...
I0716 18:04:07.869646 5909 lock.go:35] WriteFile acquiring /Users/jenkins/minikube-integration/19265-954/.minikube/profiles/force-systemd-env-713000/config.json: {Name:mk09a9f5f5420a2f338505c80589fa69897b7927 Clock:{} Delay:500ms Timeout:1m0s Cancel:<nil>}
I0716 18:04:07.870002 5909 start.go:360] acquireMachinesLock for force-systemd-env-713000: {Name:mk7f3ad521e15247d7c72c3ddc9673429d68a7fc Clock:{} Delay:500ms Timeout:13m0s Cancel:<nil>}
I0716 18:04:07.870066 5909 start.go:364] duration metric: took 51.107µs to acquireMachinesLock for "force-systemd-env-713000"
I0716 18:04:07.870098 5909 start.go:93] Provisioning new machine with config: &{Name:force-systemd-env-713000 KeepContext:false EmbedCerts:false MinikubeISO:https://storage.googleapis.com/minikube-builds/iso/19249/minikube-v1.33.1-1721037971-19249-amd64.iso KicBaseImage:gcr.io/k8s-minikube/kicbase-builds:v0.0.44-1721064868-19249@sha256:f2789f25c9e51cdeb9cef760e15dc838ef08abd5bb1913311c1eabedda231e8c Memory:2048 CPUs:2 DiskSize:20000 Driver:hyperkit 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 Kubernet
esConfig:{KubernetesVersion:v1.30.2 ClusterName:force-systemd-env-713000 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.30.2 ContainerRuntime:docker ControlPlane:true Worker:true}] Addons:map[] CustomAddonImages:map[] CustomAddonRegistries:map[] VerifyComponents:map[apiserver:true system_pods:true] StartHostTimeout:6m0s ScheduledStop:<nil> ExposedPorts:[] ListenAddress: Network: Subnet: MultiNodeRequested:false ExtraDisks:0 CertExpiration:26280h0m0s Mount:false MountString:/Users:/minikube-host Mount9PVersion:9p2000.L MountGID:docker MountIP: MountMSize:262144 MountOptions:[] MountPort:0 MountType:9p MountUID:docker BinaryMirror: DisableOp
timizations:false DisableMetrics:false CustomQemuFirmwarePath: SocketVMnetClientPath: SocketVMnetPath: StaticIP: SSHAuthSock: SSHAgentPID:0 GPUs: AutoPauseInterval:1m0s} &{Name: IP: Port:8443 KubernetesVersion:v1.30.2 ContainerRuntime:docker ControlPlane:true Worker:true}
I0716 18:04:07.870143 5909 start.go:125] createHost starting for "" (driver="hyperkit")
I0716 18:04:07.891406 5909 out.go:204] * Creating hyperkit VM (CPUs=2, Memory=2048MB, Disk=20000MB) ...
I0716 18:04:07.891659 5909 main.go:141] libmachine: Found binary path at /Users/jenkins/workspace/out/docker-machine-driver-hyperkit
I0716 18:04:07.891759 5909 main.go:141] libmachine: Launching plugin server for driver hyperkit
I0716 18:04:07.901845 5909 main.go:141] libmachine: Plugin server listening at address 127.0.0.1:53833
I0716 18:04:07.902176 5909 main.go:141] libmachine: () Calling .GetVersion
I0716 18:04:07.902593 5909 main.go:141] libmachine: Using API Version 1
I0716 18:04:07.902602 5909 main.go:141] libmachine: () Calling .SetConfigRaw
I0716 18:04:07.902795 5909 main.go:141] libmachine: () Calling .GetMachineName
I0716 18:04:07.902892 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetMachineName
I0716 18:04:07.902981 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .DriverName
I0716 18:04:07.903067 5909 start.go:159] libmachine.API.Create for "force-systemd-env-713000" (driver="hyperkit")
I0716 18:04:07.903089 5909 client.go:168] LocalClient.Create starting
I0716 18:04:07.903120 5909 main.go:141] libmachine: Reading certificate data from /Users/jenkins/minikube-integration/19265-954/.minikube/certs/ca.pem
I0716 18:04:07.903178 5909 main.go:141] libmachine: Decoding PEM data...
I0716 18:04:07.903200 5909 main.go:141] libmachine: Parsing certificate...
I0716 18:04:07.903258 5909 main.go:141] libmachine: Reading certificate data from /Users/jenkins/minikube-integration/19265-954/.minikube/certs/cert.pem
I0716 18:04:07.903296 5909 main.go:141] libmachine: Decoding PEM data...
I0716 18:04:07.903304 5909 main.go:141] libmachine: Parsing certificate...
I0716 18:04:07.903321 5909 main.go:141] libmachine: Running pre-create checks...
I0716 18:04:07.903328 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .PreCreateCheck
I0716 18:04:07.903396 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I0716 18:04:07.903577 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetConfigRaw
I0716 18:04:07.911964 5909 main.go:141] libmachine: Creating machine...
I0716 18:04:07.911982 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .Create
I0716 18:04:07.912128 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I0716 18:04:07.912360 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | I0716 18:04:07.912116 5917 common.go:145] Making disk image using store path: /Users/jenkins/minikube-integration/19265-954/.minikube
I0716 18:04:07.912467 5909 main.go:141] libmachine: (force-systemd-env-713000) Downloading /Users/jenkins/minikube-integration/19265-954/.minikube/cache/boot2docker.iso from file:///Users/jenkins/minikube-integration/19265-954/.minikube/cache/iso/amd64/minikube-v1.33.1-1721037971-19249-amd64.iso...
I0716 18:04:08.100117 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | I0716 18:04:08.100030 5917 common.go:152] Creating ssh key: /Users/jenkins/minikube-integration/19265-954/.minikube/machines/force-systemd-env-713000/id_rsa...
I0716 18:04:08.223534 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | I0716 18:04:08.223465 5917 common.go:158] Creating raw disk image: /Users/jenkins/minikube-integration/19265-954/.minikube/machines/force-systemd-env-713000/force-systemd-env-713000.rawdisk...
I0716 18:04:08.223550 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | Writing magic tar header
I0716 18:04:08.223562 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | Writing SSH key tar header
I0716 18:04:08.224016 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | I0716 18:04:08.223943 5917 common.go:172] Fixing permissions on /Users/jenkins/minikube-integration/19265-954/.minikube/machines/force-systemd-env-713000 ...
I0716 18:04:08.577618 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I0716 18:04:08.577641 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | clean start, hyperkit pid file doesn't exist: /Users/jenkins/minikube-integration/19265-954/.minikube/machines/force-systemd-env-713000/hyperkit.pid
I0716 18:04:08.577657 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | Using UUID 9412fc7a-3377-4610-89f2-c545279cf2f3
I0716 18:04:08.606045 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | Generated MAC 76:f1:36:e6:c3:fb
I0716 18:04:08.606061 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | Starting with cmdline: loglevel=3 console=ttyS0 console=tty0 noembed nomodeset norestore waitusb=10 systemd.legacy_systemd_cgroup_controller=yes random.trust_cpu=on hw_rng_model=virtio base host=force-systemd-env-713000
I0716 18:04:08.606097 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | 2024/07/16 18:04:08 DEBUG: hyperkit: Start &hyperkit.HyperKit{HyperKit:"/usr/local/bin/hyperkit", Argv0:"", StateDir:"/Users/jenkins/minikube-integration/19265-954/.minikube/machines/force-systemd-env-713000", VPNKitSock:"", VPNKitUUID:"", VPNKitPreferredIPv4:"", UUID:"9412fc7a-3377-4610-89f2-c545279cf2f3", Disks:[]hyperkit.Disk{(*hyperkit.RawDisk)(0xc0001161b0)}, ISOImages:[]string{"/Users/jenkins/minikube-integration/19265-954/.minikube/machines/force-systemd-env-713000/boot2docker.iso"}, VSock:false, VSockDir:"", VSockPorts:[]int(nil), VSockGuestCID:3, VMNet:true, Sockets9P:[]hyperkit.Socket9P(nil), Kernel:"/Users/jenkins/minikube-integration/19265-954/.minikube/machines/force-systemd-env-713000/bzimage", Initrd:"/Users/jenkins/minikube-integration/19265-954/.minikube/machines/force-systemd-env-713000/initrd", Bootrom:"", CPUs:2, Memory:2048, Console:1, Serials:[]hyperkit.Serial(nil), Pid:0, Arguments:[]string(
nil), CmdLine:"", process:(*os.Process)(nil)}
I0716 18:04:08.606136 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | 2024/07/16 18:04:08 DEBUG: hyperkit: check &hyperkit.HyperKit{HyperKit:"/usr/local/bin/hyperkit", Argv0:"", StateDir:"/Users/jenkins/minikube-integration/19265-954/.minikube/machines/force-systemd-env-713000", VPNKitSock:"", VPNKitUUID:"", VPNKitPreferredIPv4:"", UUID:"9412fc7a-3377-4610-89f2-c545279cf2f3", Disks:[]hyperkit.Disk{(*hyperkit.RawDisk)(0xc0001161b0)}, ISOImages:[]string{"/Users/jenkins/minikube-integration/19265-954/.minikube/machines/force-systemd-env-713000/boot2docker.iso"}, VSock:false, VSockDir:"", VSockPorts:[]int(nil), VSockGuestCID:3, VMNet:true, Sockets9P:[]hyperkit.Socket9P(nil), Kernel:"/Users/jenkins/minikube-integration/19265-954/.minikube/machines/force-systemd-env-713000/bzimage", Initrd:"/Users/jenkins/minikube-integration/19265-954/.minikube/machines/force-systemd-env-713000/initrd", Bootrom:"", CPUs:2, Memory:2048, Console:1, Serials:[]hyperkit.Serial(nil), Pid:0, Arguments:[]string(
nil), CmdLine:"", process:(*os.Process)(nil)}
I0716 18:04:08.606260 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | 2024/07/16 18:04:08 DEBUG: hyperkit: Arguments: []string{"-A", "-u", "-F", "/Users/jenkins/minikube-integration/19265-954/.minikube/machines/force-systemd-env-713000/hyperkit.pid", "-c", "2", "-m", "2048M", "-s", "0:0,hostbridge", "-s", "31,lpc", "-s", "1:0,virtio-net", "-U", "9412fc7a-3377-4610-89f2-c545279cf2f3", "-s", "2:0,virtio-blk,/Users/jenkins/minikube-integration/19265-954/.minikube/machines/force-systemd-env-713000/force-systemd-env-713000.rawdisk", "-s", "3,ahci-cd,/Users/jenkins/minikube-integration/19265-954/.minikube/machines/force-systemd-env-713000/boot2docker.iso", "-s", "4,virtio-rnd", "-l", "com1,autopty=/Users/jenkins/minikube-integration/19265-954/.minikube/machines/force-systemd-env-713000/tty,log=/Users/jenkins/minikube-integration/19265-954/.minikube/machines/force-systemd-env-713000/console-ring", "-f", "kexec,/Users/jenkins/minikube-integration/19265-954/.minikube/machines/force-systemd-e
nv-713000/bzimage,/Users/jenkins/minikube-integration/19265-954/.minikube/machines/force-systemd-env-713000/initrd,earlyprintk=serial loglevel=3 console=ttyS0 console=tty0 noembed nomodeset norestore waitusb=10 systemd.legacy_systemd_cgroup_controller=yes random.trust_cpu=on hw_rng_model=virtio base host=force-systemd-env-713000"}
I0716 18:04:08.606308 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | 2024/07/16 18:04:08 DEBUG: hyperkit: CmdLine: "/usr/local/bin/hyperkit -A -u -F /Users/jenkins/minikube-integration/19265-954/.minikube/machines/force-systemd-env-713000/hyperkit.pid -c 2 -m 2048M -s 0:0,hostbridge -s 31,lpc -s 1:0,virtio-net -U 9412fc7a-3377-4610-89f2-c545279cf2f3 -s 2:0,virtio-blk,/Users/jenkins/minikube-integration/19265-954/.minikube/machines/force-systemd-env-713000/force-systemd-env-713000.rawdisk -s 3,ahci-cd,/Users/jenkins/minikube-integration/19265-954/.minikube/machines/force-systemd-env-713000/boot2docker.iso -s 4,virtio-rnd -l com1,autopty=/Users/jenkins/minikube-integration/19265-954/.minikube/machines/force-systemd-env-713000/tty,log=/Users/jenkins/minikube-integration/19265-954/.minikube/machines/force-systemd-env-713000/console-ring -f kexec,/Users/jenkins/minikube-integration/19265-954/.minikube/machines/force-systemd-env-713000/bzimage,/Users/jenkins/minikube-integration/19265-95
4/.minikube/machines/force-systemd-env-713000/initrd,earlyprintk=serial loglevel=3 console=ttyS0 console=tty0 noembed nomodeset norestore waitusb=10 systemd.legacy_systemd_cgroup_controller=yes random.trust_cpu=on hw_rng_model=virtio base host=force-systemd-env-713000"
I0716 18:04:08.606324 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | 2024/07/16 18:04:08 DEBUG: hyperkit: Redirecting stdout/stderr to logger
I0716 18:04:08.609176 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | 2024/07/16 18:04:08 DEBUG: hyperkit: Pid is 5918
I0716 18:04:08.610152 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | Attempt 0
I0716 18:04:08.610164 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I0716 18:04:08.610294 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | hyperkit pid from json: 5918
I0716 18:04:08.611684 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | Searching for 76:f1:36:e6:c3:fb in /var/db/dhcpd_leases ...
I0716 18:04:08.611841 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | Found 22 entries in /var/db/dhcpd_leases!
I0716 18:04:08.611884 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.23 HWAddress:6a:72:8a:c4:53:f3 ID:1,6a:72:8a:c4:53:f3 Lease:0x669869f8}
I0716 18:04:08.611960 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.22 HWAddress:6e:e5:16:80:b8:82 ID:1,6e:e5:16:80:b8:82 Lease:0x6698698a}
I0716 18:04:08.611998 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.21 HWAddress:de:b2:9d:e5:f:e2 ID:1,de:b2:9d:e5:f:e2 Lease:0x6698691b}
I0716 18:04:08.612014 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.20 HWAddress:62:df:37:95:2f:23 ID:1,62:df:37:95:2f:23 Lease:0x669868d7}
I0716 18:04:08.612033 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.19 HWAddress:8e:d9:22:be:d9:50 ID:1,8e:d9:22:be:d9:50 Lease:0x6697165f}
I0716 18:04:08.612053 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.18 HWAddress:6:14:d5:c4:64:5 ID:1,6:14:d5:c4:64:5 Lease:0x669715a4}
I0716 18:04:08.612075 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.17 HWAddress:2a:7f:37:6e:44:c8 ID:1,2a:7f:37:6e:44:c8 Lease:0x66986793}
I0716 18:04:08.612090 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.16 HWAddress:5a:92:b5:b3:bd:ea ID:1,5a:92:b5:b3:bd:ea Lease:0x6698673f}
I0716 18:04:08.612109 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.15 HWAddress:da:1a:fe:37:5a:2a ID:1,da:1a:fe:37:5a:2a Lease:0x66971433}
I0716 18:04:08.612121 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.14 HWAddress:3e:55:d7:2a:b:8e ID:1,3e:55:d7:2a:b:8e Lease:0x6697141b}
I0716 18:04:08.612136 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.13 HWAddress:9a:59:25:1e:ff:ab ID:1,9a:59:25:1e:ff:ab Lease:0x66986549}
I0716 18:04:08.612149 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.12 HWAddress:72:99:f4:b2:60:a1 ID:1,72:99:f4:b2:60:a1 Lease:0x66986521}
I0716 18:04:08.612165 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.11 HWAddress:ae:dd:de:34:e1:e1 ID:1,ae:dd:de:34:e1:e1 Lease:0x669864b8}
I0716 18:04:08.612178 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.10 HWAddress:d6:55:45:db:27:7 ID:1,d6:55:45:db:27:7 Lease:0x6698648a}
I0716 18:04:08.612200 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.9 HWAddress:ca:51:ab:e9:d1:b5 ID:1,ca:51:ab:e9:d1:b5 Lease:0x6698642b}
I0716 18:04:08.612216 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.8 HWAddress:be:f5:6f:56:4f:92 ID:1,be:f5:6f:56:4f:92 Lease:0x6698640f}
I0716 18:04:08.612254 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.7 HWAddress:1e:35:c:33:62:34 ID:1,1e:35:c:33:62:34 Lease:0x66971211}
I0716 18:04:08.612268 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.6 HWAddress:96:ee:9f:4c:c2:59 ID:1,96:ee:9f:4c:c2:59 Lease:0x669863ca}
I0716 18:04:08.612277 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.5 HWAddress:52:99:6f:9f:78:ba ID:1,52:99:6f:9f:78:ba Lease:0x669863b5}
I0716 18:04:08.612287 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.4 HWAddress:32:b2:23:b4:df:cf ID:1,32:b2:23:b4:df:cf Lease:0x66985ee9}
I0716 18:04:08.612296 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.3 HWAddress:f6:e7:3c:7c:f4:86 ID:1,f6:e7:3c:7c:f4:86 Lease:0x66985e21}
I0716 18:04:08.612305 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.2 HWAddress:d2:b3:e1:e2:1e:d6 ID:1,d2:b3:e1:e2:1e:d6 Lease:0x66985c47}
I0716 18:04:08.617117 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | 2024/07/16 18:04:08 INFO : hyperkit: stderr: Using fd 5 for I/O notifications
I0716 18:04:08.625404 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | 2024/07/16 18:04:08 INFO : hyperkit: stderr: /Users/jenkins/minikube-integration/19265-954/.minikube/machines/force-systemd-env-713000/boot2docker.iso: fcntl(F_PUNCHHOLE) Operation not permitted: block device will not support TRIM/DISCARD
I0716 18:04:08.626411 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | 2024/07/16 18:04:08 INFO : hyperkit: stderr: vmx_set_ctlreg: cap_field: 2 bit: 22 unspecified don't care: bit is 0
I0716 18:04:08.626441 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | 2024/07/16 18:04:08 INFO : hyperkit: stderr: vmx_set_ctlreg: cap_field: 4 bit: 12 unspecified don't care: bit is 0
I0716 18:04:08.626455 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | 2024/07/16 18:04:08 INFO : hyperkit: stderr: vmx_set_ctlreg: cap_field: 4 bit: 20 unspecified don't care: bit is 0
I0716 18:04:08.626473 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | 2024/07/16 18:04:08 INFO : hyperkit: stderr: vmx_set_ctlreg: cap_field: 3 bit: 13 unspecified don't care: bit is 0
I0716 18:04:09.001561 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | 2024/07/16 18:04:09 INFO : hyperkit: stderr: rdmsr to register 0x3a on vcpu 0
I0716 18:04:09.001573 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | 2024/07/16 18:04:09 INFO : hyperkit: stderr: rdmsr to register 0x140 on vcpu 0
I0716 18:04:09.116416 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | 2024/07/16 18:04:09 INFO : hyperkit: stderr: vmx_set_ctlreg: cap_field: 2 bit: 22 unspecified don't care: bit is 0
I0716 18:04:09.116432 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | 2024/07/16 18:04:09 INFO : hyperkit: stderr: vmx_set_ctlreg: cap_field: 4 bit: 12 unspecified don't care: bit is 0
I0716 18:04:09.116442 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | 2024/07/16 18:04:09 INFO : hyperkit: stderr: vmx_set_ctlreg: cap_field: 4 bit: 20 unspecified don't care: bit is 0
I0716 18:04:09.116453 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | 2024/07/16 18:04:09 INFO : hyperkit: stderr: vmx_set_ctlreg: cap_field: 3 bit: 13 unspecified don't care: bit is 0
I0716 18:04:09.117316 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | 2024/07/16 18:04:09 INFO : hyperkit: stderr: rdmsr to register 0x3a on vcpu 1
I0716 18:04:09.117328 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | 2024/07/16 18:04:09 INFO : hyperkit: stderr: rdmsr to register 0x140 on vcpu 1
I0716 18:04:10.612762 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | Attempt 1
I0716 18:04:10.612779 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I0716 18:04:10.612877 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | hyperkit pid from json: 5918
I0716 18:04:10.613771 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | Searching for 76:f1:36:e6:c3:fb in /var/db/dhcpd_leases ...
I0716 18:04:10.613847 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | Found 22 entries in /var/db/dhcpd_leases!
I0716 18:04:10.613864 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.23 HWAddress:6a:72:8a:c4:53:f3 ID:1,6a:72:8a:c4:53:f3 Lease:0x669869f8}
I0716 18:04:10.613881 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.22 HWAddress:6e:e5:16:80:b8:82 ID:1,6e:e5:16:80:b8:82 Lease:0x6698698a}
I0716 18:04:10.613906 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.21 HWAddress:de:b2:9d:e5:f:e2 ID:1,de:b2:9d:e5:f:e2 Lease:0x6698691b}
I0716 18:04:10.613916 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.20 HWAddress:62:df:37:95:2f:23 ID:1,62:df:37:95:2f:23 Lease:0x669868d7}
I0716 18:04:10.613945 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.19 HWAddress:8e:d9:22:be:d9:50 ID:1,8e:d9:22:be:d9:50 Lease:0x6697165f}
I0716 18:04:10.613953 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.18 HWAddress:6:14:d5:c4:64:5 ID:1,6:14:d5:c4:64:5 Lease:0x669715a4}
I0716 18:04:10.613975 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.17 HWAddress:2a:7f:37:6e:44:c8 ID:1,2a:7f:37:6e:44:c8 Lease:0x66986793}
I0716 18:04:10.613988 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.16 HWAddress:5a:92:b5:b3:bd:ea ID:1,5a:92:b5:b3:bd:ea Lease:0x6698673f}
I0716 18:04:10.614003 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.15 HWAddress:da:1a:fe:37:5a:2a ID:1,da:1a:fe:37:5a:2a Lease:0x66971433}
I0716 18:04:10.614015 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.14 HWAddress:3e:55:d7:2a:b:8e ID:1,3e:55:d7:2a:b:8e Lease:0x6697141b}
I0716 18:04:10.614033 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.13 HWAddress:9a:59:25:1e:ff:ab ID:1,9a:59:25:1e:ff:ab Lease:0x66986549}
I0716 18:04:10.614047 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.12 HWAddress:72:99:f4:b2:60:a1 ID:1,72:99:f4:b2:60:a1 Lease:0x66986521}
I0716 18:04:10.614059 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.11 HWAddress:ae:dd:de:34:e1:e1 ID:1,ae:dd:de:34:e1:e1 Lease:0x669864b8}
I0716 18:04:10.614071 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.10 HWAddress:d6:55:45:db:27:7 ID:1,d6:55:45:db:27:7 Lease:0x6698648a}
I0716 18:04:10.614080 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.9 HWAddress:ca:51:ab:e9:d1:b5 ID:1,ca:51:ab:e9:d1:b5 Lease:0x6698642b}
I0716 18:04:10.614088 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.8 HWAddress:be:f5:6f:56:4f:92 ID:1,be:f5:6f:56:4f:92 Lease:0x6698640f}
I0716 18:04:10.614097 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.7 HWAddress:1e:35:c:33:62:34 ID:1,1e:35:c:33:62:34 Lease:0x66971211}
I0716 18:04:10.614110 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.6 HWAddress:96:ee:9f:4c:c2:59 ID:1,96:ee:9f:4c:c2:59 Lease:0x669863ca}
I0716 18:04:10.614126 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.5 HWAddress:52:99:6f:9f:78:ba ID:1,52:99:6f:9f:78:ba Lease:0x669863b5}
I0716 18:04:10.614135 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.4 HWAddress:32:b2:23:b4:df:cf ID:1,32:b2:23:b4:df:cf Lease:0x66985ee9}
I0716 18:04:10.614142 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.3 HWAddress:f6:e7:3c:7c:f4:86 ID:1,f6:e7:3c:7c:f4:86 Lease:0x66985e21}
I0716 18:04:10.614150 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.2 HWAddress:d2:b3:e1:e2:1e:d6 ID:1,d2:b3:e1:e2:1e:d6 Lease:0x66985c47}
I0716 18:04:12.615690 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | Attempt 2
I0716 18:04:12.615709 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I0716 18:04:12.615780 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | hyperkit pid from json: 5918
I0716 18:04:12.616623 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | Searching for 76:f1:36:e6:c3:fb in /var/db/dhcpd_leases ...
I0716 18:04:12.616690 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | Found 22 entries in /var/db/dhcpd_leases!
I0716 18:04:12.616702 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.23 HWAddress:6a:72:8a:c4:53:f3 ID:1,6a:72:8a:c4:53:f3 Lease:0x669869f8}
I0716 18:04:12.616713 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.22 HWAddress:6e:e5:16:80:b8:82 ID:1,6e:e5:16:80:b8:82 Lease:0x6698698a}
I0716 18:04:12.616721 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.21 HWAddress:de:b2:9d:e5:f:e2 ID:1,de:b2:9d:e5:f:e2 Lease:0x6698691b}
I0716 18:04:12.616727 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.20 HWAddress:62:df:37:95:2f:23 ID:1,62:df:37:95:2f:23 Lease:0x669868d7}
I0716 18:04:12.616733 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.19 HWAddress:8e:d9:22:be:d9:50 ID:1,8e:d9:22:be:d9:50 Lease:0x6697165f}
I0716 18:04:12.616740 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.18 HWAddress:6:14:d5:c4:64:5 ID:1,6:14:d5:c4:64:5 Lease:0x669715a4}
I0716 18:04:12.616745 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.17 HWAddress:2a:7f:37:6e:44:c8 ID:1,2a:7f:37:6e:44:c8 Lease:0x66986793}
I0716 18:04:12.616772 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.16 HWAddress:5a:92:b5:b3:bd:ea ID:1,5a:92:b5:b3:bd:ea Lease:0x6698673f}
I0716 18:04:12.616780 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.15 HWAddress:da:1a:fe:37:5a:2a ID:1,da:1a:fe:37:5a:2a Lease:0x66971433}
I0716 18:04:12.616787 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.14 HWAddress:3e:55:d7:2a:b:8e ID:1,3e:55:d7:2a:b:8e Lease:0x6697141b}
I0716 18:04:12.616797 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.13 HWAddress:9a:59:25:1e:ff:ab ID:1,9a:59:25:1e:ff:ab Lease:0x66986549}
I0716 18:04:12.616803 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.12 HWAddress:72:99:f4:b2:60:a1 ID:1,72:99:f4:b2:60:a1 Lease:0x66986521}
I0716 18:04:12.616809 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.11 HWAddress:ae:dd:de:34:e1:e1 ID:1,ae:dd:de:34:e1:e1 Lease:0x669864b8}
I0716 18:04:12.616815 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.10 HWAddress:d6:55:45:db:27:7 ID:1,d6:55:45:db:27:7 Lease:0x6698648a}
I0716 18:04:12.616823 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.9 HWAddress:ca:51:ab:e9:d1:b5 ID:1,ca:51:ab:e9:d1:b5 Lease:0x6698642b}
I0716 18:04:12.616846 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.8 HWAddress:be:f5:6f:56:4f:92 ID:1,be:f5:6f:56:4f:92 Lease:0x6698640f}
I0716 18:04:12.616854 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.7 HWAddress:1e:35:c:33:62:34 ID:1,1e:35:c:33:62:34 Lease:0x66971211}
I0716 18:04:12.616861 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.6 HWAddress:96:ee:9f:4c:c2:59 ID:1,96:ee:9f:4c:c2:59 Lease:0x669863ca}
I0716 18:04:12.616868 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.5 HWAddress:52:99:6f:9f:78:ba ID:1,52:99:6f:9f:78:ba Lease:0x669863b5}
I0716 18:04:12.616887 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.4 HWAddress:32:b2:23:b4:df:cf ID:1,32:b2:23:b4:df:cf Lease:0x66985ee9}
I0716 18:04:12.616901 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.3 HWAddress:f6:e7:3c:7c:f4:86 ID:1,f6:e7:3c:7c:f4:86 Lease:0x66985e21}
I0716 18:04:12.616930 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.2 HWAddress:d2:b3:e1:e2:1e:d6 ID:1,d2:b3:e1:e2:1e:d6 Lease:0x66985c47}
I0716 18:04:14.618749 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | Attempt 3
I0716 18:04:14.618767 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I0716 18:04:14.618897 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | hyperkit pid from json: 5918
I0716 18:04:14.619823 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | Searching for 76:f1:36:e6:c3:fb in /var/db/dhcpd_leases ...
I0716 18:04:14.619919 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | Found 22 entries in /var/db/dhcpd_leases!
I0716 18:04:14.619932 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.23 HWAddress:6a:72:8a:c4:53:f3 ID:1,6a:72:8a:c4:53:f3 Lease:0x669869f8}
I0716 18:04:14.619955 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.22 HWAddress:6e:e5:16:80:b8:82 ID:1,6e:e5:16:80:b8:82 Lease:0x6698698a}
I0716 18:04:14.619965 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.21 HWAddress:de:b2:9d:e5:f:e2 ID:1,de:b2:9d:e5:f:e2 Lease:0x6698691b}
I0716 18:04:14.619990 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.20 HWAddress:62:df:37:95:2f:23 ID:1,62:df:37:95:2f:23 Lease:0x669868d7}
I0716 18:04:14.620005 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.19 HWAddress:8e:d9:22:be:d9:50 ID:1,8e:d9:22:be:d9:50 Lease:0x6697165f}
I0716 18:04:14.620033 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.18 HWAddress:6:14:d5:c4:64:5 ID:1,6:14:d5:c4:64:5 Lease:0x669715a4}
I0716 18:04:14.620051 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.17 HWAddress:2a:7f:37:6e:44:c8 ID:1,2a:7f:37:6e:44:c8 Lease:0x66986793}
I0716 18:04:14.620064 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.16 HWAddress:5a:92:b5:b3:bd:ea ID:1,5a:92:b5:b3:bd:ea Lease:0x6698673f}
I0716 18:04:14.620070 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.15 HWAddress:da:1a:fe:37:5a:2a ID:1,da:1a:fe:37:5a:2a Lease:0x66971433}
I0716 18:04:14.620106 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.14 HWAddress:3e:55:d7:2a:b:8e ID:1,3e:55:d7:2a:b:8e Lease:0x6697141b}
I0716 18:04:14.620151 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.13 HWAddress:9a:59:25:1e:ff:ab ID:1,9a:59:25:1e:ff:ab Lease:0x66986549}
I0716 18:04:14.620184 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.12 HWAddress:72:99:f4:b2:60:a1 ID:1,72:99:f4:b2:60:a1 Lease:0x66986521}
I0716 18:04:14.620196 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.11 HWAddress:ae:dd:de:34:e1:e1 ID:1,ae:dd:de:34:e1:e1 Lease:0x669864b8}
I0716 18:04:14.620211 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.10 HWAddress:d6:55:45:db:27:7 ID:1,d6:55:45:db:27:7 Lease:0x6698648a}
I0716 18:04:14.620225 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.9 HWAddress:ca:51:ab:e9:d1:b5 ID:1,ca:51:ab:e9:d1:b5 Lease:0x6698642b}
I0716 18:04:14.620235 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.8 HWAddress:be:f5:6f:56:4f:92 ID:1,be:f5:6f:56:4f:92 Lease:0x6698640f}
I0716 18:04:14.620246 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.7 HWAddress:1e:35:c:33:62:34 ID:1,1e:35:c:33:62:34 Lease:0x66971211}
I0716 18:04:14.620259 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.6 HWAddress:96:ee:9f:4c:c2:59 ID:1,96:ee:9f:4c:c2:59 Lease:0x669863ca}
I0716 18:04:14.620269 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.5 HWAddress:52:99:6f:9f:78:ba ID:1,52:99:6f:9f:78:ba Lease:0x669863b5}
I0716 18:04:14.620281 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.4 HWAddress:32:b2:23:b4:df:cf ID:1,32:b2:23:b4:df:cf Lease:0x66985ee9}
I0716 18:04:14.620292 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.3 HWAddress:f6:e7:3c:7c:f4:86 ID:1,f6:e7:3c:7c:f4:86 Lease:0x66985e21}
I0716 18:04:14.620309 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.2 HWAddress:d2:b3:e1:e2:1e:d6 ID:1,d2:b3:e1:e2:1e:d6 Lease:0x66985c47}
I0716 18:04:14.691725 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | 2024/07/16 18:04:14 INFO : hyperkit: stderr: rdmsr to register 0x64d on vcpu 0
I0716 18:04:14.691822 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | 2024/07/16 18:04:14 INFO : hyperkit: stderr: rdmsr to register 0x64e on vcpu 0
I0716 18:04:14.691832 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | 2024/07/16 18:04:14 INFO : hyperkit: stderr: rdmsr to register 0x34 on vcpu 0
I0716 18:04:14.721804 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | 2024/07/16 18:04:14 INFO : hyperkit: stderr: rdmsr to register 0xc0011029 on vcpu 0
I0716 18:04:16.621332 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | Attempt 4
I0716 18:04:16.621348 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I0716 18:04:16.621450 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | hyperkit pid from json: 5918
I0716 18:04:16.622257 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | Searching for 76:f1:36:e6:c3:fb in /var/db/dhcpd_leases ...
I0716 18:04:16.622330 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | Found 22 entries in /var/db/dhcpd_leases!
I0716 18:04:16.622339 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.23 HWAddress:6a:72:8a:c4:53:f3 ID:1,6a:72:8a:c4:53:f3 Lease:0x669869f8}
I0716 18:04:16.622348 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.22 HWAddress:6e:e5:16:80:b8:82 ID:1,6e:e5:16:80:b8:82 Lease:0x6698698a}
I0716 18:04:16.622355 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.21 HWAddress:de:b2:9d:e5:f:e2 ID:1,de:b2:9d:e5:f:e2 Lease:0x6698691b}
I0716 18:04:16.622362 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.20 HWAddress:62:df:37:95:2f:23 ID:1,62:df:37:95:2f:23 Lease:0x669868d7}
I0716 18:04:16.622368 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.19 HWAddress:8e:d9:22:be:d9:50 ID:1,8e:d9:22:be:d9:50 Lease:0x6697165f}
I0716 18:04:16.622383 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.18 HWAddress:6:14:d5:c4:64:5 ID:1,6:14:d5:c4:64:5 Lease:0x669715a4}
I0716 18:04:16.622393 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.17 HWAddress:2a:7f:37:6e:44:c8 ID:1,2a:7f:37:6e:44:c8 Lease:0x66986793}
I0716 18:04:16.622407 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.16 HWAddress:5a:92:b5:b3:bd:ea ID:1,5a:92:b5:b3:bd:ea Lease:0x6698673f}
I0716 18:04:16.622426 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.15 HWAddress:da:1a:fe:37:5a:2a ID:1,da:1a:fe:37:5a:2a Lease:0x66971433}
I0716 18:04:16.622440 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.14 HWAddress:3e:55:d7:2a:b:8e ID:1,3e:55:d7:2a:b:8e Lease:0x6697141b}
I0716 18:04:16.622460 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.13 HWAddress:9a:59:25:1e:ff:ab ID:1,9a:59:25:1e:ff:ab Lease:0x66986549}
I0716 18:04:16.622469 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.12 HWAddress:72:99:f4:b2:60:a1 ID:1,72:99:f4:b2:60:a1 Lease:0x66986521}
I0716 18:04:16.622476 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.11 HWAddress:ae:dd:de:34:e1:e1 ID:1,ae:dd:de:34:e1:e1 Lease:0x669864b8}
I0716 18:04:16.622485 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.10 HWAddress:d6:55:45:db:27:7 ID:1,d6:55:45:db:27:7 Lease:0x6698648a}
I0716 18:04:16.622492 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.9 HWAddress:ca:51:ab:e9:d1:b5 ID:1,ca:51:ab:e9:d1:b5 Lease:0x6698642b}
I0716 18:04:16.622501 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.8 HWAddress:be:f5:6f:56:4f:92 ID:1,be:f5:6f:56:4f:92 Lease:0x6698640f}
I0716 18:04:16.622508 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.7 HWAddress:1e:35:c:33:62:34 ID:1,1e:35:c:33:62:34 Lease:0x66971211}
I0716 18:04:16.622517 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.6 HWAddress:96:ee:9f:4c:c2:59 ID:1,96:ee:9f:4c:c2:59 Lease:0x669863ca}
I0716 18:04:16.622523 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.5 HWAddress:52:99:6f:9f:78:ba ID:1,52:99:6f:9f:78:ba Lease:0x669863b5}
I0716 18:04:16.622531 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.4 HWAddress:32:b2:23:b4:df:cf ID:1,32:b2:23:b4:df:cf Lease:0x66985ee9}
I0716 18:04:16.622539 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.3 HWAddress:f6:e7:3c:7c:f4:86 ID:1,f6:e7:3c:7c:f4:86 Lease:0x66985e21}
I0716 18:04:16.622548 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.2 HWAddress:d2:b3:e1:e2:1e:d6 ID:1,d2:b3:e1:e2:1e:d6 Lease:0x66985c47}
I0716 18:04:18.622514 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | Attempt 5
I0716 18:04:18.622532 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I0716 18:04:18.622634 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | hyperkit pid from json: 5918
I0716 18:04:18.623504 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | Searching for 76:f1:36:e6:c3:fb in /var/db/dhcpd_leases ...
I0716 18:04:18.623562 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | Found 23 entries in /var/db/dhcpd_leases!
I0716 18:04:18.623571 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.24 HWAddress:76:f1:36:e6:c3:fb ID:1,76:f1:36:e6:c3:fb Lease:0x66986a11}
I0716 18:04:18.623579 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | Found match: 76:f1:36:e6:c3:fb
I0716 18:04:18.623588 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | IP: 192.169.0.24
I0716 18:04:18.623651 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetConfigRaw
I0716 18:04:18.624269 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .DriverName
I0716 18:04:18.624379 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .DriverName
I0716 18:04:18.624489 5909 main.go:141] libmachine: Waiting for machine to be running, this may take a few minutes...
I0716 18:04:18.624499 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetState
I0716 18:04:18.624594 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I0716 18:04:18.624653 5909 main.go:141] libmachine: (force-systemd-env-713000) DBG | hyperkit pid from json: 5918
I0716 18:04:18.625461 5909 main.go:141] libmachine: Detecting operating system of created instance...
I0716 18:04:18.625472 5909 main.go:141] libmachine: Waiting for SSH to be available...
I0716 18:04:18.625478 5909 main.go:141] libmachine: Getting to WaitForSSH function...
I0716 18:04:18.625483 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHHostname
I0716 18:04:18.625579 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHPort
I0716 18:04:18.625667 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHKeyPath
I0716 18:04:18.625748 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHKeyPath
I0716 18:04:18.625854 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHUsername
I0716 18:04:18.625981 5909 main.go:141] libmachine: Using SSH client type: native
I0716 18:04:18.626176 5909 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x1113f060] 0x11141dc0 <nil> [] 0s} 192.169.0.24 22 <nil> <nil>}
I0716 18:04:18.626188 5909 main.go:141] libmachine: About to run SSH command:
exit 0
I0716 18:04:19.675031 5909 main.go:141] libmachine: SSH cmd err, output: <nil>:
I0716 18:04:19.675046 5909 main.go:141] libmachine: Detecting the provisioner...
I0716 18:04:19.675051 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHHostname
I0716 18:04:19.675182 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHPort
I0716 18:04:19.675284 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHKeyPath
I0716 18:04:19.675372 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHKeyPath
I0716 18:04:19.675476 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHUsername
I0716 18:04:19.675628 5909 main.go:141] libmachine: Using SSH client type: native
I0716 18:04:19.675828 5909 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x1113f060] 0x11141dc0 <nil> [] 0s} 192.169.0.24 22 <nil> <nil>}
I0716 18:04:19.675835 5909 main.go:141] libmachine: About to run SSH command:
cat /etc/os-release
I0716 18:04:19.725526 5909 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"
I0716 18:04:19.725581 5909 main.go:141] libmachine: found compatible host: buildroot
I0716 18:04:19.725587 5909 main.go:141] libmachine: Provisioning with buildroot...
I0716 18:04:19.725593 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetMachineName
I0716 18:04:19.725737 5909 buildroot.go:166] provisioning hostname "force-systemd-env-713000"
I0716 18:04:19.725749 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetMachineName
I0716 18:04:19.725843 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHHostname
I0716 18:04:19.725923 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHPort
I0716 18:04:19.726010 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHKeyPath
I0716 18:04:19.726111 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHKeyPath
I0716 18:04:19.726208 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHUsername
I0716 18:04:19.726354 5909 main.go:141] libmachine: Using SSH client type: native
I0716 18:04:19.726506 5909 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x1113f060] 0x11141dc0 <nil> [] 0s} 192.169.0.24 22 <nil> <nil>}
I0716 18:04:19.726515 5909 main.go:141] libmachine: About to run SSH command:
sudo hostname force-systemd-env-713000 && echo "force-systemd-env-713000" | sudo tee /etc/hostname
I0716 18:04:19.786309 5909 main.go:141] libmachine: SSH cmd err, output: <nil>: force-systemd-env-713000
I0716 18:04:19.786352 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHHostname
I0716 18:04:19.786492 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHPort
I0716 18:04:19.786589 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHKeyPath
I0716 18:04:19.786683 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHKeyPath
I0716 18:04:19.786776 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHUsername
I0716 18:04:19.786902 5909 main.go:141] libmachine: Using SSH client type: native
I0716 18:04:19.787056 5909 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x1113f060] 0x11141dc0 <nil> [] 0s} 192.169.0.24 22 <nil> <nil>}
I0716 18:04:19.787069 5909 main.go:141] libmachine: About to run SSH command:
if ! grep -xq '.*\sforce-systemd-env-713000' /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 force-systemd-env-713000/g' /etc/hosts;
else
echo '127.0.1.1 force-systemd-env-713000' | sudo tee -a /etc/hosts;
fi
fi
I0716 18:04:19.842114 5909 main.go:141] libmachine: SSH cmd err, output: <nil>:
I0716 18:04:19.842138 5909 buildroot.go:172] set auth options {CertDir:/Users/jenkins/minikube-integration/19265-954/.minikube CaCertPath:/Users/jenkins/minikube-integration/19265-954/.minikube/certs/ca.pem CaPrivateKeyPath:/Users/jenkins/minikube-integration/19265-954/.minikube/certs/ca-key.pem CaCertRemotePath:/etc/docker/ca.pem ServerCertPath:/Users/jenkins/minikube-integration/19265-954/.minikube/machines/server.pem ServerKeyPath:/Users/jenkins/minikube-integration/19265-954/.minikube/machines/server-key.pem ClientKeyPath:/Users/jenkins/minikube-integration/19265-954/.minikube/certs/key.pem ServerCertRemotePath:/etc/docker/server.pem ServerKeyRemotePath:/etc/docker/server-key.pem ClientCertPath:/Users/jenkins/minikube-integration/19265-954/.minikube/certs/cert.pem ServerCertSANs:[] StorePath:/Users/jenkins/minikube-integration/19265-954/.minikube}
I0716 18:04:19.842155 5909 buildroot.go:174] setting up certificates
I0716 18:04:19.842164 5909 provision.go:84] configureAuth start
I0716 18:04:19.842171 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetMachineName
I0716 18:04:19.842297 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetIP
I0716 18:04:19.842406 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHHostname
I0716 18:04:19.842500 5909 provision.go:143] copyHostCerts
I0716 18:04:19.842535 5909 vm_assets.go:164] NewFileAsset: /Users/jenkins/minikube-integration/19265-954/.minikube/certs/ca.pem -> /Users/jenkins/minikube-integration/19265-954/.minikube/ca.pem
I0716 18:04:19.842598 5909 exec_runner.go:144] found /Users/jenkins/minikube-integration/19265-954/.minikube/ca.pem, removing ...
I0716 18:04:19.842606 5909 exec_runner.go:203] rm: /Users/jenkins/minikube-integration/19265-954/.minikube/ca.pem
I0716 18:04:19.842761 5909 exec_runner.go:151] cp: /Users/jenkins/minikube-integration/19265-954/.minikube/certs/ca.pem --> /Users/jenkins/minikube-integration/19265-954/.minikube/ca.pem (1082 bytes)
I0716 18:04:19.842981 5909 vm_assets.go:164] NewFileAsset: /Users/jenkins/minikube-integration/19265-954/.minikube/certs/cert.pem -> /Users/jenkins/minikube-integration/19265-954/.minikube/cert.pem
I0716 18:04:19.843016 5909 exec_runner.go:144] found /Users/jenkins/minikube-integration/19265-954/.minikube/cert.pem, removing ...
I0716 18:04:19.843021 5909 exec_runner.go:203] rm: /Users/jenkins/minikube-integration/19265-954/.minikube/cert.pem
I0716 18:04:19.843113 5909 exec_runner.go:151] cp: /Users/jenkins/minikube-integration/19265-954/.minikube/certs/cert.pem --> /Users/jenkins/minikube-integration/19265-954/.minikube/cert.pem (1123 bytes)
I0716 18:04:19.843268 5909 vm_assets.go:164] NewFileAsset: /Users/jenkins/minikube-integration/19265-954/.minikube/certs/key.pem -> /Users/jenkins/minikube-integration/19265-954/.minikube/key.pem
I0716 18:04:19.843303 5909 exec_runner.go:144] found /Users/jenkins/minikube-integration/19265-954/.minikube/key.pem, removing ...
I0716 18:04:19.843312 5909 exec_runner.go:203] rm: /Users/jenkins/minikube-integration/19265-954/.minikube/key.pem
I0716 18:04:19.843401 5909 exec_runner.go:151] cp: /Users/jenkins/minikube-integration/19265-954/.minikube/certs/key.pem --> /Users/jenkins/minikube-integration/19265-954/.minikube/key.pem (1675 bytes)
I0716 18:04:19.843561 5909 provision.go:117] generating server cert: /Users/jenkins/minikube-integration/19265-954/.minikube/machines/server.pem ca-key=/Users/jenkins/minikube-integration/19265-954/.minikube/certs/ca.pem private-key=/Users/jenkins/minikube-integration/19265-954/.minikube/certs/ca-key.pem org=jenkins.force-systemd-env-713000 san=[127.0.0.1 192.169.0.24 force-systemd-env-713000 localhost minikube]
I0716 18:04:19.924868 5909 provision.go:177] copyRemoteCerts
I0716 18:04:19.924926 5909 ssh_runner.go:195] Run: sudo mkdir -p /etc/docker /etc/docker /etc/docker
I0716 18:04:19.924957 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHHostname
I0716 18:04:19.925099 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHPort
I0716 18:04:19.925190 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHKeyPath
I0716 18:04:19.925302 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHUsername
I0716 18:04:19.925386 5909 sshutil.go:53] new ssh client: &{IP:192.169.0.24 Port:22 SSHKeyPath:/Users/jenkins/minikube-integration/19265-954/.minikube/machines/force-systemd-env-713000/id_rsa Username:docker}
I0716 18:04:19.956977 5909 vm_assets.go:164] NewFileAsset: /Users/jenkins/minikube-integration/19265-954/.minikube/certs/ca.pem -> /etc/docker/ca.pem
I0716 18:04:19.957052 5909 ssh_runner.go:362] scp /Users/jenkins/minikube-integration/19265-954/.minikube/certs/ca.pem --> /etc/docker/ca.pem (1082 bytes)
I0716 18:04:19.975850 5909 vm_assets.go:164] NewFileAsset: /Users/jenkins/minikube-integration/19265-954/.minikube/machines/server.pem -> /etc/docker/server.pem
I0716 18:04:19.975918 5909 ssh_runner.go:362] scp /Users/jenkins/minikube-integration/19265-954/.minikube/machines/server.pem --> /etc/docker/server.pem (1237 bytes)
I0716 18:04:19.994824 5909 vm_assets.go:164] NewFileAsset: /Users/jenkins/minikube-integration/19265-954/.minikube/machines/server-key.pem -> /etc/docker/server-key.pem
I0716 18:04:19.994892 5909 ssh_runner.go:362] scp /Users/jenkins/minikube-integration/19265-954/.minikube/machines/server-key.pem --> /etc/docker/server-key.pem (1675 bytes)
I0716 18:04:20.013773 5909 provision.go:87] duration metric: took 171.598937ms to configureAuth
I0716 18:04:20.013786 5909 buildroot.go:189] setting minikube options for container-runtime
I0716 18:04:20.013921 5909 config.go:182] Loaded profile config "force-systemd-env-713000": Driver=hyperkit, ContainerRuntime=docker, KubernetesVersion=v1.30.2
I0716 18:04:20.013935 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .DriverName
I0716 18:04:20.014070 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHHostname
I0716 18:04:20.014160 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHPort
I0716 18:04:20.014268 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHKeyPath
I0716 18:04:20.014350 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHKeyPath
I0716 18:04:20.014441 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHUsername
I0716 18:04:20.014549 5909 main.go:141] libmachine: Using SSH client type: native
I0716 18:04:20.014681 5909 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x1113f060] 0x11141dc0 <nil> [] 0s} 192.169.0.24 22 <nil> <nil>}
I0716 18:04:20.014689 5909 main.go:141] libmachine: About to run SSH command:
df --output=fstype / | tail -n 1
I0716 18:04:20.064141 5909 main.go:141] libmachine: SSH cmd err, output: <nil>: tmpfs
I0716 18:04:20.064153 5909 buildroot.go:70] root file system type: tmpfs
I0716 18:04:20.064229 5909 provision.go:314] Updating docker unit: /lib/systemd/system/docker.service ...
I0716 18:04:20.064247 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHHostname
I0716 18:04:20.064380 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHPort
I0716 18:04:20.064467 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHKeyPath
I0716 18:04:20.064559 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHKeyPath
I0716 18:04:20.064644 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHUsername
I0716 18:04:20.064785 5909 main.go:141] libmachine: Using SSH client type: native
I0716 18:04:20.064915 5909 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x1113f060] 0x11141dc0 <nil> [] 0s} 192.169.0.24 22 <nil> <nil>}
I0716 18:04:20.064957 5909 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=hyperkit --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
I0716 18:04:20.126226 5909 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=hyperkit --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
I0716 18:04:20.126248 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHHostname
I0716 18:04:20.126388 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHPort
I0716 18:04:20.126490 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHKeyPath
I0716 18:04:20.126588 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHKeyPath
I0716 18:04:20.126669 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHUsername
I0716 18:04:20.126796 5909 main.go:141] libmachine: Using SSH client type: native
I0716 18:04:20.126930 5909 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x1113f060] 0x11141dc0 <nil> [] 0s} 192.169.0.24 22 <nil> <nil>}
I0716 18:04:20.126942 5909 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; }
I0716 18:04:21.735902 5909 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.
I0716 18:04:21.735919 5909 main.go:141] libmachine: Checking connection to Docker...
I0716 18:04:21.735927 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetURL
I0716 18:04:21.736105 5909 main.go:141] libmachine: Docker is up and running!
I0716 18:04:21.736117 5909 main.go:141] libmachine: Reticulating splines...
I0716 18:04:21.736123 5909 client.go:171] duration metric: took 13.8331785s to LocalClient.Create
I0716 18:04:21.736143 5909 start.go:167] duration metric: took 13.833227091s to libmachine.API.Create "force-systemd-env-713000"
I0716 18:04:21.736153 5909 start.go:293] postStartSetup for "force-systemd-env-713000" (driver="hyperkit")
I0716 18:04:21.736163 5909 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]
I0716 18:04:21.736174 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .DriverName
I0716 18:04:21.736351 5909 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
I0716 18:04:21.736364 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHHostname
I0716 18:04:21.736470 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHPort
I0716 18:04:21.736556 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHKeyPath
I0716 18:04:21.736667 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHUsername
I0716 18:04:21.736773 5909 sshutil.go:53] new ssh client: &{IP:192.169.0.24 Port:22 SSHKeyPath:/Users/jenkins/minikube-integration/19265-954/.minikube/machines/force-systemd-env-713000/id_rsa Username:docker}
I0716 18:04:21.772614 5909 ssh_runner.go:195] Run: cat /etc/os-release
I0716 18:04:21.776079 5909 info.go:137] Remote host: Buildroot 2023.02.9
I0716 18:04:21.776092 5909 filesync.go:126] Scanning /Users/jenkins/minikube-integration/19265-954/.minikube/addons for local assets ...
I0716 18:04:21.776196 5909 filesync.go:126] Scanning /Users/jenkins/minikube-integration/19265-954/.minikube/files for local assets ...
I0716 18:04:21.776380 5909 filesync.go:149] local asset: /Users/jenkins/minikube-integration/19265-954/.minikube/files/etc/ssl/certs/15852.pem -> 15852.pem in /etc/ssl/certs
I0716 18:04:21.776386 5909 vm_assets.go:164] NewFileAsset: /Users/jenkins/minikube-integration/19265-954/.minikube/files/etc/ssl/certs/15852.pem -> /etc/ssl/certs/15852.pem
I0716 18:04:21.776587 5909 ssh_runner.go:195] Run: sudo mkdir -p /etc/ssl/certs
I0716 18:04:21.787917 5909 ssh_runner.go:362] scp /Users/jenkins/minikube-integration/19265-954/.minikube/files/etc/ssl/certs/15852.pem --> /etc/ssl/certs/15852.pem (1708 bytes)
I0716 18:04:21.817531 5909 start.go:296] duration metric: took 81.367641ms for postStartSetup
I0716 18:04:21.817556 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetConfigRaw
I0716 18:04:21.818177 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetIP
I0716 18:04:21.818316 5909 profile.go:143] Saving config to /Users/jenkins/minikube-integration/19265-954/.minikube/profiles/force-systemd-env-713000/config.json ...
I0716 18:04:21.818695 5909 start.go:128] duration metric: took 13.948690166s to createHost
I0716 18:04:21.818711 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHHostname
I0716 18:04:21.818803 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHPort
I0716 18:04:21.818905 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHKeyPath
I0716 18:04:21.819013 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHKeyPath
I0716 18:04:21.819103 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHUsername
I0716 18:04:21.819207 5909 main.go:141] libmachine: Using SSH client type: native
I0716 18:04:21.819333 5909 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x1113f060] 0x11141dc0 <nil> [] 0s} 192.169.0.24 22 <nil> <nil>}
I0716 18:04:21.819340 5909 main.go:141] libmachine: About to run SSH command:
date +%s.%N
I0716 18:04:21.872549 5909 main.go:141] libmachine: SSH cmd err, output: <nil>: 1721178261.985117033
I0716 18:04:21.872562 5909 fix.go:216] guest clock: 1721178261.985117033
I0716 18:04:21.872568 5909 fix.go:229] Guest: 2024-07-16 18:04:21.985117033 -0700 PDT Remote: 2024-07-16 18:04:21.818705 -0700 PDT m=+14.435679549 (delta=166.412033ms)
I0716 18:04:21.872609 5909 fix.go:200] guest clock delta is within tolerance: 166.412033ms
I0716 18:04:21.872615 5909 start.go:83] releasing machines lock for "force-systemd-env-713000", held for 14.002693806s
I0716 18:04:21.872632 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .DriverName
I0716 18:04:21.872764 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetIP
I0716 18:04:21.872855 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .DriverName
I0716 18:04:21.873136 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .DriverName
I0716 18:04:21.873244 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .DriverName
I0716 18:04:21.873320 5909 ssh_runner.go:195] Run: curl -sS -m 2 https://registry.k8s.io/
I0716 18:04:21.873352 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHHostname
I0716 18:04:21.873375 5909 ssh_runner.go:195] Run: cat /version.json
I0716 18:04:21.873387 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHHostname
I0716 18:04:21.873453 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHPort
I0716 18:04:21.873465 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHPort
I0716 18:04:21.873598 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHKeyPath
I0716 18:04:21.873606 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHKeyPath
I0716 18:04:21.873687 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHUsername
I0716 18:04:21.873710 5909 main.go:141] libmachine: (force-systemd-env-713000) Calling .GetSSHUsername
I0716 18:04:21.873770 5909 sshutil.go:53] new ssh client: &{IP:192.169.0.24 Port:22 SSHKeyPath:/Users/jenkins/minikube-integration/19265-954/.minikube/machines/force-systemd-env-713000/id_rsa Username:docker}
I0716 18:04:21.873786 5909 sshutil.go:53] new ssh client: &{IP:192.169.0.24 Port:22 SSHKeyPath:/Users/jenkins/minikube-integration/19265-954/.minikube/machines/force-systemd-env-713000/id_rsa Username:docker}
I0716 18:04:21.902099 5909 ssh_runner.go:195] Run: systemctl --version
I0716 18:04:21.952233 5909 ssh_runner.go:195] Run: sh -c "stat /etc/cni/net.d/*loopback.conf*"
W0716 18:04:21.956977 5909 cni.go:209] loopback cni configuration skipped: "/etc/cni/net.d/*loopback.conf*" not found
I0716 18:04:21.957030 5909 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" ;
I0716 18:04:21.970174 5909 cni.go:262] disabled [/etc/cni/net.d/87-podman-bridge.conflist] bridge cni config(s)
I0716 18:04:21.970188 5909 start.go:495] detecting cgroup driver to use...
I0716 18:04:21.970198 5909 start.go:499] using "systemd" cgroup driver as enforced via flags
I0716 18:04:21.970298 5909 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"
I0716 18:04:21.985567 5909 ssh_runner.go:195] Run: sh -c "sudo sed -i -r 's|^( *)sandbox_image = .*$|\1sandbox_image = "registry.k8s.io/pause:3.9"|' /etc/containerd/config.toml"
I0716 18:04:21.994058 5909 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"
I0716 18:04:22.002423 5909 containerd.go:146] configuring containerd to use "systemd" as cgroup driver...
I0716 18:04:22.002470 5909 ssh_runner.go:195] Run: sh -c "sudo sed -i -r 's|^( *)SystemdCgroup = .*$|\1SystemdCgroup = true|g' /etc/containerd/config.toml"
I0716 18:04:22.010683 5909 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"
I0716 18:04:22.019263 5909 ssh_runner.go:195] Run: sh -c "sudo sed -i '/systemd_cgroup/d' /etc/containerd/config.toml"
I0716 18:04:22.027814 5909 ssh_runner.go:195] Run: sh -c "sudo sed -i 's|"io.containerd.runc.v1"|"io.containerd.runc.v2"|g' /etc/containerd/config.toml"
I0716 18:04:22.035940 5909 ssh_runner.go:195] Run: sh -c "sudo rm -rf /etc/cni/net.mk"
I0716 18:04:22.044241 5909 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"
I0716 18:04:22.052407 5909 ssh_runner.go:195] Run: sh -c "sudo sed -i '/^ *enable_unprivileged_ports = .*/d' /etc/containerd/config.toml"
I0716 18:04:22.061213 5909 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"
I0716 18:04:22.069948 5909 ssh_runner.go:195] Run: sudo sysctl net.bridge.bridge-nf-call-iptables
I0716 18:04:22.077738 5909 ssh_runner.go:195] Run: sudo sh -c "echo 1 > /proc/sys/net/ipv4/ip_forward"
I0716 18:04:22.085347 5909 ssh_runner.go:195] Run: sudo systemctl daemon-reload
I0716 18:04:22.196405 5909 ssh_runner.go:195] Run: sudo systemctl restart containerd
I0716 18:04:22.215794 5909 start.go:495] detecting cgroup driver to use...
I0716 18:04:22.215825 5909 start.go:499] using "systemd" cgroup driver as enforced via flags
I0716 18:04:22.215895 5909 ssh_runner.go:195] Run: sudo systemctl cat docker.service
I0716 18:04:22.234248 5909 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service containerd
I0716 18:04:22.251462 5909 ssh_runner.go:195] Run: sudo systemctl stop -f containerd
I0716 18:04:22.270625 5909 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service containerd
I0716 18:04:22.282487 5909 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service crio
I0716 18:04:22.293342 5909 ssh_runner.go:195] Run: sudo systemctl stop -f crio
I0716 18:04:22.316775 5909 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service crio
I0716 18:04:22.328157 5909 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"
I0716 18:04:22.343808 5909 ssh_runner.go:195] Run: which cri-dockerd
I0716 18:04:22.346684 5909 ssh_runner.go:195] Run: sudo mkdir -p /etc/systemd/system/cri-docker.service.d
I0716 18:04:22.354835 5909 ssh_runner.go:362] scp memory --> /etc/systemd/system/cri-docker.service.d/10-cni.conf (189 bytes)
I0716 18:04:22.368467 5909 ssh_runner.go:195] Run: sudo systemctl unmask docker.service
I0716 18:04:22.467922 5909 ssh_runner.go:195] Run: sudo systemctl enable docker.socket
I0716 18:04:22.573276 5909 docker.go:574] configuring docker to use "systemd" as cgroup driver...
I0716 18:04:22.573354 5909 ssh_runner.go:362] scp memory --> /etc/docker/daemon.json (129 bytes)
I0716 18:04:22.588602 5909 ssh_runner.go:195] Run: sudo systemctl daemon-reload
I0716 18:04:22.691842 5909 ssh_runner.go:195] Run: sudo systemctl restart docker
I0716 18:05:23.721228 5909 ssh_runner.go:235] Completed: sudo systemctl restart docker: (1m1.030032208s)
I0716 18:05:23.721309 5909 ssh_runner.go:195] Run: sudo journalctl --no-pager -u docker
I0716 18:05:23.757200 5909 out.go:177]
W0716 18:05:23.778819 5909 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 17 01:04:20 force-systemd-env-713000 systemd[1]: Starting Docker Application Container Engine...
Jul 17 01:04:20 force-systemd-env-713000 dockerd[515]: time="2024-07-17T01:04:20.545663054Z" level=info msg="Starting up"
Jul 17 01:04:20 force-systemd-env-713000 dockerd[515]: time="2024-07-17T01:04:20.546122525Z" level=info msg="containerd not running, starting managed containerd"
Jul 17 01:04:20 force-systemd-env-713000 dockerd[515]: time="2024-07-17T01:04:20.546602245Z" level=info msg="started new containerd process" address=/var/run/docker/containerd/containerd.sock module=libcontainerd pid=522
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.564365524Z" level=info msg="starting containerd" revision=2bf793ef6dc9a18e00cb12efb64355c2c9d5eb41 version=v1.7.19
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.578644310Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.578728883Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.578798377Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.578834158Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.578921370Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.578960531Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.579132885Z" 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 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.579173668Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.579205290Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.579234112Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.579318859Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.579539398Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.581126594Z" 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 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.581172785Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.581316146Z" 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 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.581358524Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.581442113Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.581507290Z" level=info msg="metadata content store policy set" policy=shared
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.589867344Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.589999580Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.590049286Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.590084502Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.590116686Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.590219821Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.590435533Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.590570609Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.590609921Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.590640721Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.590672177Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.590702557Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.590732465Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.590765559Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.590803340Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.590844011Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.590882787Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.590914165Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.590951257Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.590982883Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591014023Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591046422Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591082472Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591118557Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591148107Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591177953Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591207127Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591238995Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591268049Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591298061Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591327054Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591373484Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591411788Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591442346Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591476748Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591552785Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591597512Z" 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 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591634062Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591665380Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591694130Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591728326Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591797052Z" level=info msg="NRI interface is disabled by configuration."
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591981524Z" level=info msg=serving... address=/var/run/docker/containerd/containerd-debug.sock
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.592044763Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock.ttrpc
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.592099504Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.592138207Z" level=info msg="containerd successfully booted in 0.028411s"
Jul 17 01:04:21 force-systemd-env-713000 dockerd[515]: time="2024-07-17T01:04:21.615813216Z" level=info msg="[graphdriver] trying configured driver: overlay2"
Jul 17 01:04:21 force-systemd-env-713000 dockerd[515]: time="2024-07-17T01:04:21.626189989Z" level=info msg="Loading containers: start."
Jul 17 01:04:21 force-systemd-env-713000 dockerd[515]: time="2024-07-17T01:04:21.711273810Z" 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 17 01:04:21 force-systemd-env-713000 dockerd[515]: time="2024-07-17T01:04:21.801046075Z" level=info msg="Loading containers: done."
Jul 17 01:04:21 force-systemd-env-713000 dockerd[515]: time="2024-07-17T01:04:21.812020432Z" level=info msg="Docker daemon" commit=662f78c containerd-snapshotter=false storage-driver=overlay2 version=27.0.3
Jul 17 01:04:21 force-systemd-env-713000 dockerd[515]: time="2024-07-17T01:04:21.812111986Z" level=info msg="Daemon has completed initialization"
Jul 17 01:04:21 force-systemd-env-713000 dockerd[515]: time="2024-07-17T01:04:21.845366312Z" level=info msg="API listen on /var/run/docker.sock"
Jul 17 01:04:21 force-systemd-env-713000 dockerd[515]: time="2024-07-17T01:04:21.845536667Z" level=info msg="API listen on [::]:2376"
Jul 17 01:04:21 force-systemd-env-713000 systemd[1]: Started Docker Application Container Engine.
Jul 17 01:04:22 force-systemd-env-713000 dockerd[515]: time="2024-07-17T01:04:22.817684827Z" level=info msg="Processing signal 'terminated'"
Jul 17 01:04:22 force-systemd-env-713000 systemd[1]: Stopping Docker Application Container Engine...
Jul 17 01:04:22 force-systemd-env-713000 dockerd[515]: time="2024-07-17T01:04:22.818689144Z" level=info msg="stopping event stream following graceful shutdown" error="<nil>" module=libcontainerd namespace=moby
Jul 17 01:04:22 force-systemd-env-713000 dockerd[515]: time="2024-07-17T01:04:22.819222604Z" level=info msg="Daemon shutdown complete"
Jul 17 01:04:22 force-systemd-env-713000 dockerd[515]: time="2024-07-17T01:04:22.819332231Z" level=info msg="stopping event stream following graceful shutdown" error="context canceled" module=libcontainerd namespace=plugins.moby
Jul 17 01:04:22 force-systemd-env-713000 dockerd[515]: time="2024-07-17T01:04:22.819351234Z" level=info msg="stopping healthcheck following graceful shutdown" module=libcontainerd
Jul 17 01:04:23 force-systemd-env-713000 systemd[1]: docker.service: Deactivated successfully.
Jul 17 01:04:23 force-systemd-env-713000 systemd[1]: Stopped Docker Application Container Engine.
Jul 17 01:04:23 force-systemd-env-713000 systemd[1]: Starting Docker Application Container Engine...
Jul 17 01:04:23 force-systemd-env-713000 dockerd[918]: time="2024-07-17T01:04:23.859864715Z" level=info msg="Starting up"
Jul 17 01:05:23 force-systemd-env-713000 dockerd[918]: failed to start daemon: failed to dial "/run/containerd/containerd.sock": failed to dial "/run/containerd/containerd.sock": context deadline exceeded
Jul 17 01:05:23 force-systemd-env-713000 systemd[1]: docker.service: Main process exited, code=exited, status=1/FAILURE
Jul 17 01:05:23 force-systemd-env-713000 systemd[1]: docker.service: Failed with result 'exit-code'.
Jul 17 01:05:23 force-systemd-env-713000 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 17 01:04:20 force-systemd-env-713000 systemd[1]: Starting Docker Application Container Engine...
Jul 17 01:04:20 force-systemd-env-713000 dockerd[515]: time="2024-07-17T01:04:20.545663054Z" level=info msg="Starting up"
Jul 17 01:04:20 force-systemd-env-713000 dockerd[515]: time="2024-07-17T01:04:20.546122525Z" level=info msg="containerd not running, starting managed containerd"
Jul 17 01:04:20 force-systemd-env-713000 dockerd[515]: time="2024-07-17T01:04:20.546602245Z" level=info msg="started new containerd process" address=/var/run/docker/containerd/containerd.sock module=libcontainerd pid=522
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.564365524Z" level=info msg="starting containerd" revision=2bf793ef6dc9a18e00cb12efb64355c2c9d5eb41 version=v1.7.19
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.578644310Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.578728883Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.578798377Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.578834158Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.578921370Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.578960531Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.579132885Z" 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 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.579173668Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.579205290Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.579234112Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.579318859Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.579539398Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.581126594Z" 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 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.581172785Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.581316146Z" 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 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.581358524Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.581442113Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.581507290Z" level=info msg="metadata content store policy set" policy=shared
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.589867344Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.589999580Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.590049286Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.590084502Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.590116686Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.590219821Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.590435533Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.590570609Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.590609921Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.590640721Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.590672177Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.590702557Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.590732465Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.590765559Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.590803340Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.590844011Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.590882787Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.590914165Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.590951257Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.590982883Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591014023Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591046422Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591082472Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591118557Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591148107Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591177953Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591207127Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591238995Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591268049Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591298061Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591327054Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591373484Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591411788Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591442346Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591476748Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591552785Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591597512Z" 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 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591634062Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591665380Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591694130Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591728326Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591797052Z" level=info msg="NRI interface is disabled by configuration."
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.591981524Z" level=info msg=serving... address=/var/run/docker/containerd/containerd-debug.sock
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.592044763Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock.ttrpc
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.592099504Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock
Jul 17 01:04:20 force-systemd-env-713000 dockerd[522]: time="2024-07-17T01:04:20.592138207Z" level=info msg="containerd successfully booted in 0.028411s"
Jul 17 01:04:21 force-systemd-env-713000 dockerd[515]: time="2024-07-17T01:04:21.615813216Z" level=info msg="[graphdriver] trying configured driver: overlay2"
Jul 17 01:04:21 force-systemd-env-713000 dockerd[515]: time="2024-07-17T01:04:21.626189989Z" level=info msg="Loading containers: start."
Jul 17 01:04:21 force-systemd-env-713000 dockerd[515]: time="2024-07-17T01:04:21.711273810Z" 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 17 01:04:21 force-systemd-env-713000 dockerd[515]: time="2024-07-17T01:04:21.801046075Z" level=info msg="Loading containers: done."
Jul 17 01:04:21 force-systemd-env-713000 dockerd[515]: time="2024-07-17T01:04:21.812020432Z" level=info msg="Docker daemon" commit=662f78c containerd-snapshotter=false storage-driver=overlay2 version=27.0.3
Jul 17 01:04:21 force-systemd-env-713000 dockerd[515]: time="2024-07-17T01:04:21.812111986Z" level=info msg="Daemon has completed initialization"
Jul 17 01:04:21 force-systemd-env-713000 dockerd[515]: time="2024-07-17T01:04:21.845366312Z" level=info msg="API listen on /var/run/docker.sock"
Jul 17 01:04:21 force-systemd-env-713000 dockerd[515]: time="2024-07-17T01:04:21.845536667Z" level=info msg="API listen on [::]:2376"
Jul 17 01:04:21 force-systemd-env-713000 systemd[1]: Started Docker Application Container Engine.
Jul 17 01:04:22 force-systemd-env-713000 dockerd[515]: time="2024-07-17T01:04:22.817684827Z" level=info msg="Processing signal 'terminated'"
Jul 17 01:04:22 force-systemd-env-713000 systemd[1]: Stopping Docker Application Container Engine...
Jul 17 01:04:22 force-systemd-env-713000 dockerd[515]: time="2024-07-17T01:04:22.818689144Z" level=info msg="stopping event stream following graceful shutdown" error="<nil>" module=libcontainerd namespace=moby
Jul 17 01:04:22 force-systemd-env-713000 dockerd[515]: time="2024-07-17T01:04:22.819222604Z" level=info msg="Daemon shutdown complete"
Jul 17 01:04:22 force-systemd-env-713000 dockerd[515]: time="2024-07-17T01:04:22.819332231Z" level=info msg="stopping event stream following graceful shutdown" error="context canceled" module=libcontainerd namespace=plugins.moby
Jul 17 01:04:22 force-systemd-env-713000 dockerd[515]: time="2024-07-17T01:04:22.819351234Z" level=info msg="stopping healthcheck following graceful shutdown" module=libcontainerd
Jul 17 01:04:23 force-systemd-env-713000 systemd[1]: docker.service: Deactivated successfully.
Jul 17 01:04:23 force-systemd-env-713000 systemd[1]: Stopped Docker Application Container Engine.
Jul 17 01:04:23 force-systemd-env-713000 systemd[1]: Starting Docker Application Container Engine...
Jul 17 01:04:23 force-systemd-env-713000 dockerd[918]: time="2024-07-17T01:04:23.859864715Z" level=info msg="Starting up"
Jul 17 01:05:23 force-systemd-env-713000 dockerd[918]: failed to start daemon: failed to dial "/run/containerd/containerd.sock": failed to dial "/run/containerd/containerd.sock": context deadline exceeded
Jul 17 01:05:23 force-systemd-env-713000 systemd[1]: docker.service: Main process exited, code=exited, status=1/FAILURE
Jul 17 01:05:23 force-systemd-env-713000 systemd[1]: docker.service: Failed with result 'exit-code'.
Jul 17 01:05:23 force-systemd-env-713000 systemd[1]: Failed to start Docker Application Container Engine.
-- /stdout --
W0716 18:05:23.778959 5909 out.go:239] *
*
W0716 18:05:23.780302 5909 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. │
│ │
╰─────────────────────────────────────────────────────────────────────────────────────────────╯
I0716 18:05:23.841747 5909 out.go:177]
** /stderr **
docker_test.go:157: failed to start minikube with args: "out/minikube-darwin-amd64 start -p force-systemd-env-713000 --memory=2048 --alsologtostderr -v=5 --driver=hyperkit " : exit status 90
docker_test.go:110: (dbg) Run: out/minikube-darwin-amd64 -p force-systemd-env-713000 ssh "docker info --format {{.CgroupDriver}}"
E0716 18:05:26.202691 1585 cert_rotation.go:168] key failed with : open /Users/jenkins/minikube-integration/19265-954/.minikube/profiles/addons-348000/client.crt: no such file or directory
E0716 18:05:43.150657 1585 cert_rotation.go:168] key failed with : open /Users/jenkins/minikube-integration/19265-954/.minikube/profiles/addons-348000/client.crt: no such file or directory
E0716 18:06:02.846278 1585 cert_rotation.go:168] key failed with : open /Users/jenkins/minikube-integration/19265-954/.minikube/profiles/functional-283000/client.crt: no such file or directory
docker_test.go:110: (dbg) Done: out/minikube-darwin-amd64 -p force-systemd-env-713000 ssh "docker info --format {{.CgroupDriver}}": (1m0.184569854s)
docker_test.go:115: expected systemd cgroup driver, got:
-- stdout --
Cannot connect to the Docker daemon at unix:///var/run/docker.sock. Is the docker daemon running?
-- /stdout --
panic.go:626: *** TestForceSystemdEnv FAILED at 2024-07-16 18:06:24.088326 -0700 PDT m=+3715.092224244
helpers_test.go:222: -----------------------post-mortem--------------------------------
helpers_test.go:239: (dbg) Run: out/minikube-darwin-amd64 status --format={{.Host}} -p force-systemd-env-713000 -n force-systemd-env-713000
helpers_test.go:239: (dbg) Non-zero exit: out/minikube-darwin-amd64 status --format={{.Host}} -p force-systemd-env-713000 -n force-systemd-env-713000: exit status 6 (155.548252ms)
-- stdout --
Running
WARNING: Your kubectl is pointing to stale minikube-vm.
To fix the kubectl context, run `minikube update-context`
-- /stdout --
** stderr **
E0716 18:06:24.226031 5983 status.go:417] kubeconfig endpoint: get endpoint: "force-systemd-env-713000" does not appear in /Users/jenkins/minikube-integration/19265-954/kubeconfig
** /stderr **
helpers_test.go:239: status error: exit status 6 (may be ok)
helpers_test.go:241: "force-systemd-env-713000" 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`")
helpers_test.go:175: Cleaning up "force-systemd-env-713000" profile ...
helpers_test.go:178: (dbg) Run: out/minikube-darwin-amd64 delete -p force-systemd-env-713000
helpers_test.go:178: (dbg) Done: out/minikube-darwin-amd64 delete -p force-systemd-env-713000: (5.23784229s)
--- FAIL: TestForceSystemdEnv (142.12s)