=== RUN TestForceSystemdEnv
=== PAUSE TestForceSystemdEnv
=== CONT TestForceSystemdEnv
docker_test.go:155: (dbg) Run: out/minikube-darwin-amd64 start -p force-systemd-env-992000 --memory=2048 --alsologtostderr -v=5 --driver=hyperkit
docker_test.go:155: (dbg) Non-zero exit: out/minikube-darwin-amd64 start -p force-systemd-env-992000 --memory=2048 --alsologtostderr -v=5 --driver=hyperkit : exit status 90 (15.135769475s)
-- stdout --
* [force-systemd-env-992000] minikube v1.31.2 on Darwin 13.6
- MINIKUBE_LOCATION=17297
- KUBECONFIG=/Users/jenkins/minikube-integration/17297-1019/kubeconfig
- MINIKUBE_BIN=out/minikube-darwin-amd64
- MINIKUBE_SUPPRESS_DOCKER_PERFORMANCE=true
- MINIKUBE_HOME=/Users/jenkins/minikube-integration/17297-1019/.minikube
- MINIKUBE_FORCE_SYSTEMD=true
* Using the hyperkit driver based on user configuration
* Starting control plane node force-systemd-env-992000 in cluster force-systemd-env-992000
* Creating hyperkit VM (CPUs=2, Memory=2048MB, Disk=20000MB) ...
-- /stdout --
** stderr **
I0925 04:02:44.418461 5073 out.go:296] Setting OutFile to fd 1 ...
I0925 04:02:44.419003 5073 out.go:343] TERM=,COLORTERM=, which probably does not support color
I0925 04:02:44.419014 5073 out.go:309] Setting ErrFile to fd 2...
I0925 04:02:44.419021 5073 out.go:343] TERM=,COLORTERM=, which probably does not support color
I0925 04:02:44.419622 5073 root.go:338] Updating PATH: /Users/jenkins/minikube-integration/17297-1019/.minikube/bin
I0925 04:02:44.421227 5073 out.go:303] Setting JSON to false
I0925 04:02:44.441626 5073 start.go:128] hostinfo: {"hostname":"MacOS-Agent-4.local","uptime":1938,"bootTime":1695637826,"procs":433,"os":"darwin","platform":"darwin","platformFamily":"Standalone Workstation","platformVersion":"13.6","kernelVersion":"22.6.0","kernelArch":"x86_64","virtualizationSystem":"","virtualizationRole":"","hostId":"f2f27e25-cfda-5ffd-9706-e98286194e62"}
W0925 04:02:44.441743 5073 start.go:136] gopshost.Virtualization returned error: not implemented yet
I0925 04:02:44.481715 5073 out.go:177] * [force-systemd-env-992000] minikube v1.31.2 on Darwin 13.6
I0925 04:02:44.539469 5073 notify.go:220] Checking for updates...
I0925 04:02:44.561255 5073 out.go:177] - MINIKUBE_LOCATION=17297
I0925 04:02:44.603211 5073 out.go:177] - KUBECONFIG=/Users/jenkins/minikube-integration/17297-1019/kubeconfig
I0925 04:02:44.647089 5073 out.go:177] - MINIKUBE_BIN=out/minikube-darwin-amd64
I0925 04:02:44.695040 5073 out.go:177] - MINIKUBE_SUPPRESS_DOCKER_PERFORMANCE=true
I0925 04:02:44.737190 5073 out.go:177] - MINIKUBE_HOME=/Users/jenkins/minikube-integration/17297-1019/.minikube
I0925 04:02:44.779323 5073 out.go:177] - MINIKUBE_FORCE_SYSTEMD=true
I0925 04:02:44.801305 5073 config.go:182] Loaded profile config "offline-docker-993000": Driver=hyperkit, ContainerRuntime=docker, KubernetesVersion=v1.28.2
I0925 04:02:44.801474 5073 driver.go:373] Setting default libvirt URI to qemu:///system
I0925 04:02:44.831186 5073 out.go:177] * Using the hyperkit driver based on user configuration
I0925 04:02:44.888125 5073 start.go:298] selected driver: hyperkit
I0925 04:02:44.888153 5073 start.go:902] validating driver "hyperkit" against <nil>
I0925 04:02:44.888218 5073 start.go:913] status for hyperkit: {Installed:true Healthy:true Running:true NeedsImprovement:false Error:<nil> Reason: Fix: Doc: Version:}
I0925 04:02:44.892391 5073 install.go:52] acquiring lock: {Name:mk4023283b30b374c3f04c8805d539e68824c0b8 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I0925 04:02:44.892519 5073 install.go:117] Validating docker-machine-driver-hyperkit, PATH=/Users/jenkins/minikube-integration/17297-1019/.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
I0925 04:02:44.899425 5073 install.go:137] /Users/jenkins/workspace/out/docker-machine-driver-hyperkit version is 1.31.2
I0925 04:02:44.903006 5073 install.go:79] stdout: /Users/jenkins/workspace/out/docker-machine-driver-hyperkit
I0925 04:02:44.903026 5073 install.go:81] /Users/jenkins/workspace/out/docker-machine-driver-hyperkit looks good
I0925 04:02:44.903051 5073 start_flags.go:307] no existing cluster config was found, will generate one from the flags
I0925 04:02:44.903264 5073 start_flags.go:904] Wait components to verify : map[apiserver:true system_pods:true]
I0925 04:02:44.903289 5073 cni.go:84] Creating CNI manager for ""
I0925 04:02:44.903306 5073 cni.go:158] "hyperkit" driver + "docker" container runtime found on kubernetes v1.24+, recommending bridge
I0925 04:02:44.903317 5073 start_flags.go:316] Found "bridge CNI" CNI - setting NetworkPlugin=cni
I0925 04:02:44.903323 5073 start_flags.go:321] config:
{Name:force-systemd-env-992000 KeepContext:false EmbedCerts:false MinikubeISO: KicBaseImage:gcr.io/k8s-minikube/kicbase-builds:v0.0.40-1694798187-17250@sha256:8d9a070cda8e1b1082ed355bde1aaf66fbf63d64fa6e9f553f449efc74157fe3 Memory:2048 CPUs:2 DiskSize:20000 VMDriver: 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:0 DockerOpt:[] DisableDriverMounts:false NFSShare:[] NFSSharesRoot:/nfsshares UUID: NoVTXCheck:false DNSProxy:false HostDNSResolver:true HostOnlyNicType:virtio NatNicType:virtio SSHIPAddress: SSHUser:root SSHKey: SSHPort:22 KubernetesConfig:{KubernetesVersion:v1.28.2 ClusterName:force-systemd-env-992000 Namespace:default APIServerName:minikubeCA APIServerNames:[] APIServerIPs:[] DNSDomain:cluster.local C
ontainerRuntime:docker CRISocket: NetworkPlugin:cni FeatureGates: ServiceCIDR:10.96.0.0/12 ImageRepository: LoadBalancerStartIP: LoadBalancerEndIP: CustomIngressCert: RegistryAliases: ExtraOptions:[] ShouldLoadCachedImages:true EnableDefaultCNI:false CNI: NodeIP: NodePort:8443 NodeName:} Nodes:[] 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 AutoPauseInterval:1m0s}
I0925 04:02:44.903469 5073 iso.go:125] acquiring lock: {Name:mk5685b8103aa0f952a2e44c47bdd1882fdd0bc3 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I0925 04:02:44.980925 5073 out.go:177] * Starting control plane node force-systemd-env-992000 in cluster force-systemd-env-992000
I0925 04:02:45.002391 5073 preload.go:132] Checking if preload exists for k8s version v1.28.2 and runtime docker
I0925 04:02:45.002481 5073 preload.go:148] Found local preload: /Users/jenkins/minikube-integration/17297-1019/.minikube/cache/preloaded-tarball/preloaded-images-k8s-v18-v1.28.2-docker-overlay2-amd64.tar.lz4
I0925 04:02:45.002515 5073 cache.go:57] Caching tarball of preloaded images
I0925 04:02:45.002741 5073 preload.go:174] Found /Users/jenkins/minikube-integration/17297-1019/.minikube/cache/preloaded-tarball/preloaded-images-k8s-v18-v1.28.2-docker-overlay2-amd64.tar.lz4 in cache, skipping download
I0925 04:02:45.002764 5073 cache.go:60] Finished verifying existence of preloaded tar for v1.28.2 on docker
I0925 04:02:45.002928 5073 profile.go:148] Saving config to /Users/jenkins/minikube-integration/17297-1019/.minikube/profiles/force-systemd-env-992000/config.json ...
I0925 04:02:45.002980 5073 lock.go:35] WriteFile acquiring /Users/jenkins/minikube-integration/17297-1019/.minikube/profiles/force-systemd-env-992000/config.json: {Name:mkca4eaef89c2aaded0c143c275cfdd38c807152 Clock:{} Delay:500ms Timeout:1m0s Cancel:<nil>}
I0925 04:02:45.003610 5073 start.go:365] acquiring machines lock for force-systemd-env-992000: {Name:mkc5a9c335a363bfa8f942e55cb9e7e0d08ada9f Clock:{} Delay:500ms Timeout:13m0s Cancel:<nil>}
I0925 04:02:45.003728 5073 start.go:369] acquired machines lock for "force-systemd-env-992000" in 87.656µs
I0925 04:02:45.003778 5073 start.go:93] Provisioning new machine with config: &{Name:force-systemd-env-992000 KeepContext:false EmbedCerts:false MinikubeISO:https://storage.googleapis.com/minikube-builds/iso/17240/minikube-v1.31.0-1695060926-17240-amd64.iso KicBaseImage:gcr.io/k8s-minikube/kicbase-builds:v0.0.40-1694798187-17250@sha256:8d9a070cda8e1b1082ed355bde1aaf66fbf63d64fa6e9f553f449efc74157fe3 Memory:2048 CPUs:2 DiskSize:20000 VMDriver: 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:0 DockerOpt:[] DisableDriverMounts:false NFSShare:[] NFSSharesRoot:/nfsshares UUID: NoVTXCheck:false DNSProxy:false HostDNSResolver:true HostOnlyNicType:virtio NatNicType:virtio SSHIPAddress: SSHUser:root SSHKey: SSHPort:22 K
ubernetesConfig:{KubernetesVersion:v1.28.2 ClusterName:force-systemd-env-992000 Namespace:default APIServerName:minikubeCA APIServerNames:[] APIServerIPs:[] DNSDomain:cluster.local ContainerRuntime:docker CRISocket: NetworkPlugin:cni FeatureGates: ServiceCIDR:10.96.0.0/12 ImageRepository: LoadBalancerStartIP: LoadBalancerEndIP: CustomIngressCert: RegistryAliases: ExtraOptions:[] ShouldLoadCachedImages:true EnableDefaultCNI:false CNI: NodeIP: NodePort:8443 NodeName:} Nodes:[{Name: IP: Port:8443 KubernetesVersion:v1.28.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 AutoPauseInterval:1m0s} &{Name: IP: Port:8443 KubernetesVersion:v1.28.2 ContainerRuntime:docker ControlPlane:true Worker:true}
I0925 04:02:45.003876 5073 start.go:125] createHost starting for "" (driver="hyperkit")
I0925 04:02:45.063097 5073 out.go:204] * Creating hyperkit VM (CPUs=2, Memory=2048MB, Disk=20000MB) ...
I0925 04:02:45.063544 5073 main.go:141] libmachine: Found binary path at /Users/jenkins/workspace/out/docker-machine-driver-hyperkit
I0925 04:02:45.063619 5073 main.go:141] libmachine: Launching plugin server for driver hyperkit
I0925 04:02:45.072242 5073 main.go:141] libmachine: Plugin server listening at address 127.0.0.1:52233
I0925 04:02:45.072600 5073 main.go:141] libmachine: () Calling .GetVersion
I0925 04:02:45.073027 5073 main.go:141] libmachine: Using API Version 1
I0925 04:02:45.073040 5073 main.go:141] libmachine: () Calling .SetConfigRaw
I0925 04:02:45.073288 5073 main.go:141] libmachine: () Calling .GetMachineName
I0925 04:02:45.073395 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetMachineName
I0925 04:02:45.073480 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .DriverName
I0925 04:02:45.073589 5073 start.go:159] libmachine.API.Create for "force-systemd-env-992000" (driver="hyperkit")
I0925 04:02:45.073618 5073 client.go:168] LocalClient.Create starting
I0925 04:02:45.073658 5073 main.go:141] libmachine: Reading certificate data from /Users/jenkins/minikube-integration/17297-1019/.minikube/certs/ca.pem
I0925 04:02:45.073708 5073 main.go:141] libmachine: Decoding PEM data...
I0925 04:02:45.073747 5073 main.go:141] libmachine: Parsing certificate...
I0925 04:02:45.073804 5073 main.go:141] libmachine: Reading certificate data from /Users/jenkins/minikube-integration/17297-1019/.minikube/certs/cert.pem
I0925 04:02:45.073835 5073 main.go:141] libmachine: Decoding PEM data...
I0925 04:02:45.073844 5073 main.go:141] libmachine: Parsing certificate...
I0925 04:02:45.073860 5073 main.go:141] libmachine: Running pre-create checks...
I0925 04:02:45.073866 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .PreCreateCheck
I0925 04:02:45.073945 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I0925 04:02:45.074144 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetConfigRaw
I0925 04:02:45.074536 5073 main.go:141] libmachine: Creating machine...
I0925 04:02:45.074545 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .Create
I0925 04:02:45.074615 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I0925 04:02:45.074736 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | I0925 04:02:45.074603 5081 common.go:145] Making disk image using store path: /Users/jenkins/minikube-integration/17297-1019/.minikube
I0925 04:02:45.074808 5073 main.go:141] libmachine: (force-systemd-env-992000) Downloading /Users/jenkins/minikube-integration/17297-1019/.minikube/cache/boot2docker.iso from file:///Users/jenkins/minikube-integration/17297-1019/.minikube/cache/iso/amd64/minikube-v1.31.0-1695060926-17240-amd64.iso...
I0925 04:02:45.230088 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | I0925 04:02:45.230026 5081 common.go:152] Creating ssh key: /Users/jenkins/minikube-integration/17297-1019/.minikube/machines/force-systemd-env-992000/id_rsa...
I0925 04:02:45.434137 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | I0925 04:02:45.434037 5081 common.go:158] Creating raw disk image: /Users/jenkins/minikube-integration/17297-1019/.minikube/machines/force-systemd-env-992000/force-systemd-env-992000.rawdisk...
I0925 04:02:45.434152 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | Writing magic tar header
I0925 04:02:45.434162 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | Writing SSH key tar header
I0925 04:02:45.434636 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | I0925 04:02:45.434602 5081 common.go:172] Fixing permissions on /Users/jenkins/minikube-integration/17297-1019/.minikube/machines/force-systemd-env-992000 ...
I0925 04:02:45.762583 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I0925 04:02:45.762668 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | clean start, hyperkit pid file doesn't exist: /Users/jenkins/minikube-integration/17297-1019/.minikube/machines/force-systemd-env-992000/hyperkit.pid
I0925 04:02:45.762694 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | Using UUID 0e241a66-5b93-11ee-bc5f-149d997fca88
I0925 04:02:45.791789 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | Generated MAC ee:42:fa:c9:ff:a3
I0925 04:02:45.791817 5073 main.go:141] libmachine: (force-systemd-env-992000) 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-992000
I0925 04:02:45.791850 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | 2023/09/25 04:02:45 DEBUG: hyperkit: Start &hyperkit.HyperKit{HyperKit:"/usr/local/bin/hyperkit", Argv0:"", StateDir:"/Users/jenkins/minikube-integration/17297-1019/.minikube/machines/force-systemd-env-992000", VPNKitSock:"", VPNKitUUID:"", VPNKitPreferredIPv4:"", UUID:"0e241a66-5b93-11ee-bc5f-149d997fca88", Disks:[]hyperkit.Disk{(*hyperkit.RawDisk)(0xc0000963c0)}, ISOImages:[]string{"/Users/jenkins/minikube-integration/17297-1019/.minikube/machines/force-systemd-env-992000/boot2docker.iso"}, VSock:false, VSockDir:"", VSockPorts:[]int(nil), VSockGuestCID:3, VMNet:true, Sockets9P:[]hyperkit.Socket9P(nil), Kernel:"/Users/jenkins/minikube-integration/17297-1019/.minikube/machines/force-systemd-env-992000/bzimage", Initrd:"/Users/jenkins/minikube-integration/17297-1019/.minikube/machines/force-systemd-env-992000/initrd", Bootrom:"", CPUs:2, Memory:2048, Console:1, Serials:[]hyperkit.Serial(nil), Pid:0, Arguments:[]str
ing(nil), CmdLine:"", process:(*os.Process)(nil)}
I0925 04:02:45.791879 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | 2023/09/25 04:02:45 DEBUG: hyperkit: check &hyperkit.HyperKit{HyperKit:"/usr/local/bin/hyperkit", Argv0:"", StateDir:"/Users/jenkins/minikube-integration/17297-1019/.minikube/machines/force-systemd-env-992000", VPNKitSock:"", VPNKitUUID:"", VPNKitPreferredIPv4:"", UUID:"0e241a66-5b93-11ee-bc5f-149d997fca88", Disks:[]hyperkit.Disk{(*hyperkit.RawDisk)(0xc0000963c0)}, ISOImages:[]string{"/Users/jenkins/minikube-integration/17297-1019/.minikube/machines/force-systemd-env-992000/boot2docker.iso"}, VSock:false, VSockDir:"", VSockPorts:[]int(nil), VSockGuestCID:3, VMNet:true, Sockets9P:[]hyperkit.Socket9P(nil), Kernel:"/Users/jenkins/minikube-integration/17297-1019/.minikube/machines/force-systemd-env-992000/bzimage", Initrd:"/Users/jenkins/minikube-integration/17297-1019/.minikube/machines/force-systemd-env-992000/initrd", Bootrom:"", CPUs:2, Memory:2048, Console:1, Serials:[]hyperkit.Serial(nil), Pid:0, Arguments:[]str
ing(nil), CmdLine:"", process:(*os.Process)(nil)}
I0925 04:02:45.791943 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | 2023/09/25 04:02:45 DEBUG: hyperkit: Arguments: []string{"-A", "-u", "-F", "/Users/jenkins/minikube-integration/17297-1019/.minikube/machines/force-systemd-env-992000/hyperkit.pid", "-c", "2", "-m", "2048M", "-s", "0:0,hostbridge", "-s", "31,lpc", "-s", "1:0,virtio-net", "-U", "0e241a66-5b93-11ee-bc5f-149d997fca88", "-s", "2:0,virtio-blk,/Users/jenkins/minikube-integration/17297-1019/.minikube/machines/force-systemd-env-992000/force-systemd-env-992000.rawdisk", "-s", "3,ahci-cd,/Users/jenkins/minikube-integration/17297-1019/.minikube/machines/force-systemd-env-992000/boot2docker.iso", "-s", "4,virtio-rnd", "-l", "com1,autopty=/Users/jenkins/minikube-integration/17297-1019/.minikube/machines/force-systemd-env-992000/tty,log=/Users/jenkins/minikube-integration/17297-1019/.minikube/machines/force-systemd-env-992000/console-ring", "-f", "kexec,/Users/jenkins/minikube-integration/17297-1019/.minikube/machines/force-sys
temd-env-992000/bzimage,/Users/jenkins/minikube-integration/17297-1019/.minikube/machines/force-systemd-env-992000/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-992000"}
I0925 04:02:45.791975 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | 2023/09/25 04:02:45 DEBUG: hyperkit: CmdLine: "/usr/local/bin/hyperkit -A -u -F /Users/jenkins/minikube-integration/17297-1019/.minikube/machines/force-systemd-env-992000/hyperkit.pid -c 2 -m 2048M -s 0:0,hostbridge -s 31,lpc -s 1:0,virtio-net -U 0e241a66-5b93-11ee-bc5f-149d997fca88 -s 2:0,virtio-blk,/Users/jenkins/minikube-integration/17297-1019/.minikube/machines/force-systemd-env-992000/force-systemd-env-992000.rawdisk -s 3,ahci-cd,/Users/jenkins/minikube-integration/17297-1019/.minikube/machines/force-systemd-env-992000/boot2docker.iso -s 4,virtio-rnd -l com1,autopty=/Users/jenkins/minikube-integration/17297-1019/.minikube/machines/force-systemd-env-992000/tty,log=/Users/jenkins/minikube-integration/17297-1019/.minikube/machines/force-systemd-env-992000/console-ring -f kexec,/Users/jenkins/minikube-integration/17297-1019/.minikube/machines/force-systemd-env-992000/bzimage,/Users/jenkins/minikube-integration/17
297-1019/.minikube/machines/force-systemd-env-992000/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-992000"
I0925 04:02:45.791990 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | 2023/09/25 04:02:45 DEBUG: hyperkit: Redirecting stdout/stderr to logger
I0925 04:02:45.794661 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | 2023/09/25 04:02:45 DEBUG: hyperkit: Pid is 5082
I0925 04:02:45.795038 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | Attempt 0
I0925 04:02:45.795065 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I0925 04:02:45.795124 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | hyperkit pid from json: 5082
I0925 04:02:45.796029 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | Searching for ee:42:fa:c9:ff:a3 in /var/db/dhcpd_leases ...
I0925 04:02:45.796121 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | Found 18 entries in /var/db/dhcpd_leases!
I0925 04:02:45.796154 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.19 HWAddress:3e:6d:bb:ef:93:69 ID:1,3e:6d:bb:ef:93:69 Lease:0x6512ba49}
I0925 04:02:45.796185 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.18 HWAddress:fe:b2:aa:f3:66:b3 ID:1,fe:b2:aa:f3:66:b3 Lease:0x6512b9dd}
I0925 04:02:45.796211 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.17 HWAddress:a6:6a:27:28:f5:78 ID:1,a6:6a:27:28:f5:78 Lease:0x6512b973}
I0925 04:02:45.796260 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.16 HWAddress:c6:6c:a1:83:fe:48 ID:1,c6:6c:a1:83:fe:48 Lease:0x6512b923}
I0925 04:02:45.796276 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.15 HWAddress:96:fc:b9:cf:b2:a5 ID:1,96:fc:b9:cf:b2:a5 Lease:0x6511673b}
I0925 04:02:45.796286 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.14 HWAddress:22:64:90:f4:c3:6a ID:1,22:64:90:f4:c3:6a Lease:0x651166b2}
I0925 04:02:45.796293 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.13 HWAddress:32:8:c1:c2:f0:84 ID:1,32:8:c1:c2:f0:84 Lease:0x6512b881}
I0925 04:02:45.796302 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.12 HWAddress:d2:8c:57:41:3a:9b ID:1,d2:8c:57:41:3a:9b Lease:0x6512b84d}
I0925 04:02:45.796317 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.11 HWAddress:4a:e6:41:59:5a:b3 ID:1,4a:e6:41:59:5a:b3 Lease:0x65116582}
I0925 04:02:45.796329 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.10 HWAddress:16:5c:94:4a:13:17 ID:1,16:5c:94:4a:13:17 Lease:0x6511656d}
I0925 04:02:45.796337 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.9 HWAddress:2e:f:4b:9f:7c:82 ID:1,2e:f:4b:9f:7c:82 Lease:0x6512b6b6}
I0925 04:02:45.796357 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.8 HWAddress:ba:aa:9:2:cb:33 ID:1,ba:aa:9:2:cb:33 Lease:0x6512b693}
I0925 04:02:45.796371 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.7 HWAddress:e6:90:1:72:f5:16 ID:1,e6:90:1:72:f5:16 Lease:0x6512b64d}
I0925 04:02:45.796380 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.6 HWAddress:5e:78:39:3d:9d:36 ID:1,5e:78:39:3d:9d:36 Lease:0x6512b5cb}
I0925 04:02:45.796388 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.5 HWAddress:be:df:b7:7f:25:94 ID:1,be:df:b7:7f:25:94 Lease:0x6511643a}
I0925 04:02:45.796409 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.4 HWAddress:ce:a6:ee:bb:f0:c0 ID:1,ce:a6:ee:bb:f0:c0 Lease:0x6512b4b0}
I0925 04:02:45.796429 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.3 HWAddress:4e:b5:b0:41:db:a3 ID:1,4e:b5:b0:41:db:a3 Lease:0x65116325}
I0925 04:02:45.796467 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.2 HWAddress:3a:9f:39:11:92:69 ID:1,3a:9f:39:11:92:69 Lease:0x6512b379}
I0925 04:02:45.801224 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | 2023/09/25 04:02:45 INFO : hyperkit: stderr: Using fd 5 for I/O notifications
I0925 04:02:45.808720 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | 2023/09/25 04:02:45 INFO : hyperkit: stderr: /Users/jenkins/minikube-integration/17297-1019/.minikube/machines/force-systemd-env-992000/boot2docker.iso: fcntl(F_PUNCHHOLE) Operation not permitted: block device will not support TRIM/DISCARD
I0925 04:02:45.809580 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | 2023/09/25 04:02:45 INFO : hyperkit: stderr: vmx_set_ctlreg: cap_field: 2 bit: 22 unspecified don't care: bit is 0
I0925 04:02:45.809619 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | 2023/09/25 04:02:45 INFO : hyperkit: stderr: vmx_set_ctlreg: cap_field: 4 bit: 12 unspecified don't care: bit is 0
I0925 04:02:45.809638 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | 2023/09/25 04:02:45 INFO : hyperkit: stderr: vmx_set_ctlreg: cap_field: 4 bit: 20 unspecified don't care: bit is 0
I0925 04:02:45.809653 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | 2023/09/25 04:02:45 INFO : hyperkit: stderr: vmx_set_ctlreg: cap_field: 3 bit: 13 unspecified don't care: bit is 0
I0925 04:02:46.164905 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | 2023/09/25 04:02:46 INFO : hyperkit: stderr: rdmsr to register 0x3a on vcpu 0
I0925 04:02:46.164926 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | 2023/09/25 04:02:46 INFO : hyperkit: stderr: rdmsr to register 0x140 on vcpu 0
I0925 04:02:46.269057 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | 2023/09/25 04:02:46 INFO : hyperkit: stderr: vmx_set_ctlreg: cap_field: 2 bit: 22 unspecified don't care: bit is 0
I0925 04:02:46.269086 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | 2023/09/25 04:02:46 INFO : hyperkit: stderr: vmx_set_ctlreg: cap_field: 4 bit: 12 unspecified don't care: bit is 0
I0925 04:02:46.269115 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | 2023/09/25 04:02:46 INFO : hyperkit: stderr: vmx_set_ctlreg: cap_field: 4 bit: 20 unspecified don't care: bit is 0
I0925 04:02:46.269136 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | 2023/09/25 04:02:46 INFO : hyperkit: stderr: vmx_set_ctlreg: cap_field: 3 bit: 13 unspecified don't care: bit is 0
I0925 04:02:46.269937 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | 2023/09/25 04:02:46 INFO : hyperkit: stderr: rdmsr to register 0x3a on vcpu 1
I0925 04:02:46.269947 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | 2023/09/25 04:02:46 INFO : hyperkit: stderr: rdmsr to register 0x140 on vcpu 1
I0925 04:02:47.797898 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | Attempt 1
I0925 04:02:47.797916 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I0925 04:02:47.797961 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | hyperkit pid from json: 5082
I0925 04:02:47.798839 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | Searching for ee:42:fa:c9:ff:a3 in /var/db/dhcpd_leases ...
I0925 04:02:47.798911 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | Found 18 entries in /var/db/dhcpd_leases!
I0925 04:02:47.798924 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.19 HWAddress:3e:6d:bb:ef:93:69 ID:1,3e:6d:bb:ef:93:69 Lease:0x6512ba49}
I0925 04:02:47.798934 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.18 HWAddress:fe:b2:aa:f3:66:b3 ID:1,fe:b2:aa:f3:66:b3 Lease:0x6512b9dd}
I0925 04:02:47.798943 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.17 HWAddress:a6:6a:27:28:f5:78 ID:1,a6:6a:27:28:f5:78 Lease:0x6512b973}
I0925 04:02:47.798956 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.16 HWAddress:c6:6c:a1:83:fe:48 ID:1,c6:6c:a1:83:fe:48 Lease:0x6512b923}
I0925 04:02:47.798968 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.15 HWAddress:96:fc:b9:cf:b2:a5 ID:1,96:fc:b9:cf:b2:a5 Lease:0x6511673b}
I0925 04:02:47.798978 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.14 HWAddress:22:64:90:f4:c3:6a ID:1,22:64:90:f4:c3:6a Lease:0x651166b2}
I0925 04:02:47.798986 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.13 HWAddress:32:8:c1:c2:f0:84 ID:1,32:8:c1:c2:f0:84 Lease:0x6512b881}
I0925 04:02:47.798997 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.12 HWAddress:d2:8c:57:41:3a:9b ID:1,d2:8c:57:41:3a:9b Lease:0x6512b84d}
I0925 04:02:47.799021 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.11 HWAddress:4a:e6:41:59:5a:b3 ID:1,4a:e6:41:59:5a:b3 Lease:0x65116582}
I0925 04:02:47.799034 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.10 HWAddress:16:5c:94:4a:13:17 ID:1,16:5c:94:4a:13:17 Lease:0x6511656d}
I0925 04:02:47.799042 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.9 HWAddress:2e:f:4b:9f:7c:82 ID:1,2e:f:4b:9f:7c:82 Lease:0x6512b6b6}
I0925 04:02:47.799053 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.8 HWAddress:ba:aa:9:2:cb:33 ID:1,ba:aa:9:2:cb:33 Lease:0x6512b693}
I0925 04:02:47.799065 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.7 HWAddress:e6:90:1:72:f5:16 ID:1,e6:90:1:72:f5:16 Lease:0x6512b64d}
I0925 04:02:47.799076 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.6 HWAddress:5e:78:39:3d:9d:36 ID:1,5e:78:39:3d:9d:36 Lease:0x6512b5cb}
I0925 04:02:47.799090 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.5 HWAddress:be:df:b7:7f:25:94 ID:1,be:df:b7:7f:25:94 Lease:0x6511643a}
I0925 04:02:47.799098 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.4 HWAddress:ce:a6:ee:bb:f0:c0 ID:1,ce:a6:ee:bb:f0:c0 Lease:0x6512b4b0}
I0925 04:02:47.799107 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.3 HWAddress:4e:b5:b0:41:db:a3 ID:1,4e:b5:b0:41:db:a3 Lease:0x65116325}
I0925 04:02:47.799117 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.2 HWAddress:3a:9f:39:11:92:69 ID:1,3a:9f:39:11:92:69 Lease:0x6512b379}
I0925 04:02:49.799640 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | Attempt 2
I0925 04:02:49.799658 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I0925 04:02:49.799771 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | hyperkit pid from json: 5082
I0925 04:02:49.800586 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | Searching for ee:42:fa:c9:ff:a3 in /var/db/dhcpd_leases ...
I0925 04:02:49.800649 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | Found 18 entries in /var/db/dhcpd_leases!
I0925 04:02:49.800658 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.19 HWAddress:3e:6d:bb:ef:93:69 ID:1,3e:6d:bb:ef:93:69 Lease:0x6512ba49}
I0925 04:02:49.800667 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.18 HWAddress:fe:b2:aa:f3:66:b3 ID:1,fe:b2:aa:f3:66:b3 Lease:0x6512b9dd}
I0925 04:02:49.800674 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.17 HWAddress:a6:6a:27:28:f5:78 ID:1,a6:6a:27:28:f5:78 Lease:0x6512b973}
I0925 04:02:49.800696 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.16 HWAddress:c6:6c:a1:83:fe:48 ID:1,c6:6c:a1:83:fe:48 Lease:0x6512b923}
I0925 04:02:49.800714 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.15 HWAddress:96:fc:b9:cf:b2:a5 ID:1,96:fc:b9:cf:b2:a5 Lease:0x6511673b}
I0925 04:02:49.800725 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.14 HWAddress:22:64:90:f4:c3:6a ID:1,22:64:90:f4:c3:6a Lease:0x651166b2}
I0925 04:02:49.800734 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.13 HWAddress:32:8:c1:c2:f0:84 ID:1,32:8:c1:c2:f0:84 Lease:0x6512b881}
I0925 04:02:49.800745 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.12 HWAddress:d2:8c:57:41:3a:9b ID:1,d2:8c:57:41:3a:9b Lease:0x6512b84d}
I0925 04:02:49.800754 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.11 HWAddress:4a:e6:41:59:5a:b3 ID:1,4a:e6:41:59:5a:b3 Lease:0x65116582}
I0925 04:02:49.800761 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.10 HWAddress:16:5c:94:4a:13:17 ID:1,16:5c:94:4a:13:17 Lease:0x6511656d}
I0925 04:02:49.800776 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.9 HWAddress:2e:f:4b:9f:7c:82 ID:1,2e:f:4b:9f:7c:82 Lease:0x6512b6b6}
I0925 04:02:49.800789 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.8 HWAddress:ba:aa:9:2:cb:33 ID:1,ba:aa:9:2:cb:33 Lease:0x6512b693}
I0925 04:02:49.800800 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.7 HWAddress:e6:90:1:72:f5:16 ID:1,e6:90:1:72:f5:16 Lease:0x6512b64d}
I0925 04:02:49.800815 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.6 HWAddress:5e:78:39:3d:9d:36 ID:1,5e:78:39:3d:9d:36 Lease:0x6512b5cb}
I0925 04:02:49.800828 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.5 HWAddress:be:df:b7:7f:25:94 ID:1,be:df:b7:7f:25:94 Lease:0x6511643a}
I0925 04:02:49.800837 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.4 HWAddress:ce:a6:ee:bb:f0:c0 ID:1,ce:a6:ee:bb:f0:c0 Lease:0x6512b4b0}
I0925 04:02:49.800846 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.3 HWAddress:4e:b5:b0:41:db:a3 ID:1,4e:b5:b0:41:db:a3 Lease:0x65116325}
I0925 04:02:49.800856 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.2 HWAddress:3a:9f:39:11:92:69 ID:1,3a:9f:39:11:92:69 Lease:0x6512b379}
I0925 04:02:51.238980 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | 2023/09/25 04:02:51 INFO : hyperkit: stderr: rdmsr to register 0x64d on vcpu 1
I0925 04:02:51.239057 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | 2023/09/25 04:02:51 INFO : hyperkit: stderr: rdmsr to register 0x64e on vcpu 1
I0925 04:02:51.239069 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | 2023/09/25 04:02:51 INFO : hyperkit: stderr: rdmsr to register 0x34 on vcpu 1
I0925 04:02:51.802159 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | Attempt 3
I0925 04:02:51.802179 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I0925 04:02:51.802236 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | hyperkit pid from json: 5082
I0925 04:02:51.803211 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | Searching for ee:42:fa:c9:ff:a3 in /var/db/dhcpd_leases ...
I0925 04:02:51.803286 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | Found 18 entries in /var/db/dhcpd_leases!
I0925 04:02:51.803309 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.19 HWAddress:3e:6d:bb:ef:93:69 ID:1,3e:6d:bb:ef:93:69 Lease:0x6512ba49}
I0925 04:02:51.803323 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.18 HWAddress:fe:b2:aa:f3:66:b3 ID:1,fe:b2:aa:f3:66:b3 Lease:0x6512b9dd}
I0925 04:02:51.803362 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.17 HWAddress:a6:6a:27:28:f5:78 ID:1,a6:6a:27:28:f5:78 Lease:0x6512b973}
I0925 04:02:51.803408 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.16 HWAddress:c6:6c:a1:83:fe:48 ID:1,c6:6c:a1:83:fe:48 Lease:0x6512b923}
I0925 04:02:51.803424 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.15 HWAddress:96:fc:b9:cf:b2:a5 ID:1,96:fc:b9:cf:b2:a5 Lease:0x6511673b}
I0925 04:02:51.803434 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.14 HWAddress:22:64:90:f4:c3:6a ID:1,22:64:90:f4:c3:6a Lease:0x651166b2}
I0925 04:02:51.803448 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.13 HWAddress:32:8:c1:c2:f0:84 ID:1,32:8:c1:c2:f0:84 Lease:0x6512b881}
I0925 04:02:51.803474 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.12 HWAddress:d2:8c:57:41:3a:9b ID:1,d2:8c:57:41:3a:9b Lease:0x6512b84d}
I0925 04:02:51.803492 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.11 HWAddress:4a:e6:41:59:5a:b3 ID:1,4a:e6:41:59:5a:b3 Lease:0x65116582}
I0925 04:02:51.803506 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.10 HWAddress:16:5c:94:4a:13:17 ID:1,16:5c:94:4a:13:17 Lease:0x6511656d}
I0925 04:02:51.803520 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.9 HWAddress:2e:f:4b:9f:7c:82 ID:1,2e:f:4b:9f:7c:82 Lease:0x6512b6b6}
I0925 04:02:51.803550 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.8 HWAddress:ba:aa:9:2:cb:33 ID:1,ba:aa:9:2:cb:33 Lease:0x6512b693}
I0925 04:02:51.803566 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.7 HWAddress:e6:90:1:72:f5:16 ID:1,e6:90:1:72:f5:16 Lease:0x6512b64d}
I0925 04:02:51.803579 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.6 HWAddress:5e:78:39:3d:9d:36 ID:1,5e:78:39:3d:9d:36 Lease:0x6512b5cb}
I0925 04:02:51.803595 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.5 HWAddress:be:df:b7:7f:25:94 ID:1,be:df:b7:7f:25:94 Lease:0x6511643a}
I0925 04:02:51.803609 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.4 HWAddress:ce:a6:ee:bb:f0:c0 ID:1,ce:a6:ee:bb:f0:c0 Lease:0x6512b4b0}
I0925 04:02:51.803629 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.3 HWAddress:4e:b5:b0:41:db:a3 ID:1,4e:b5:b0:41:db:a3 Lease:0x65116325}
I0925 04:02:51.803641 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.2 HWAddress:3a:9f:39:11:92:69 ID:1,3a:9f:39:11:92:69 Lease:0x6512b379}
I0925 04:02:53.804673 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | Attempt 4
I0925 04:02:53.804696 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I0925 04:02:53.804982 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | hyperkit pid from json: 5082
I0925 04:02:53.806038 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | Searching for ee:42:fa:c9:ff:a3 in /var/db/dhcpd_leases ...
I0925 04:02:53.806108 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | Found 18 entries in /var/db/dhcpd_leases!
I0925 04:02:53.806167 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.19 HWAddress:3e:6d:bb:ef:93:69 ID:1,3e:6d:bb:ef:93:69 Lease:0x6512ba49}
I0925 04:02:53.806188 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.18 HWAddress:fe:b2:aa:f3:66:b3 ID:1,fe:b2:aa:f3:66:b3 Lease:0x6512b9dd}
I0925 04:02:53.806208 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.17 HWAddress:a6:6a:27:28:f5:78 ID:1,a6:6a:27:28:f5:78 Lease:0x6512b973}
I0925 04:02:53.806227 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.16 HWAddress:c6:6c:a1:83:fe:48 ID:1,c6:6c:a1:83:fe:48 Lease:0x6512b923}
I0925 04:02:53.806242 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.15 HWAddress:96:fc:b9:cf:b2:a5 ID:1,96:fc:b9:cf:b2:a5 Lease:0x6511673b}
I0925 04:02:53.806256 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.14 HWAddress:22:64:90:f4:c3:6a ID:1,22:64:90:f4:c3:6a Lease:0x651166b2}
I0925 04:02:53.806276 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.13 HWAddress:32:8:c1:c2:f0:84 ID:1,32:8:c1:c2:f0:84 Lease:0x6512b881}
I0925 04:02:53.806292 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.12 HWAddress:d2:8c:57:41:3a:9b ID:1,d2:8c:57:41:3a:9b Lease:0x6512b84d}
I0925 04:02:53.806306 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.11 HWAddress:4a:e6:41:59:5a:b3 ID:1,4a:e6:41:59:5a:b3 Lease:0x65116582}
I0925 04:02:53.806319 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.10 HWAddress:16:5c:94:4a:13:17 ID:1,16:5c:94:4a:13:17 Lease:0x6511656d}
I0925 04:02:53.806332 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.9 HWAddress:2e:f:4b:9f:7c:82 ID:1,2e:f:4b:9f:7c:82 Lease:0x6512b6b6}
I0925 04:02:53.806355 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.8 HWAddress:ba:aa:9:2:cb:33 ID:1,ba:aa:9:2:cb:33 Lease:0x6512b693}
I0925 04:02:53.806378 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.7 HWAddress:e6:90:1:72:f5:16 ID:1,e6:90:1:72:f5:16 Lease:0x6512b64d}
I0925 04:02:53.806395 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.6 HWAddress:5e:78:39:3d:9d:36 ID:1,5e:78:39:3d:9d:36 Lease:0x6512b5cb}
I0925 04:02:53.806410 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.5 HWAddress:be:df:b7:7f:25:94 ID:1,be:df:b7:7f:25:94 Lease:0x6511643a}
I0925 04:02:53.806423 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.4 HWAddress:ce:a6:ee:bb:f0:c0 ID:1,ce:a6:ee:bb:f0:c0 Lease:0x6512b4b0}
I0925 04:02:53.806436 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.3 HWAddress:4e:b5:b0:41:db:a3 ID:1,4e:b5:b0:41:db:a3 Lease:0x65116325}
I0925 04:02:53.806452 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.2 HWAddress:3a:9f:39:11:92:69 ID:1,3a:9f:39:11:92:69 Lease:0x6512b379}
I0925 04:02:55.806854 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | Attempt 5
I0925 04:02:55.806874 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I0925 04:02:55.806973 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | hyperkit pid from json: 5082
I0925 04:02:55.807946 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | Searching for ee:42:fa:c9:ff:a3 in /var/db/dhcpd_leases ...
I0925 04:02:55.808019 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | Found 19 entries in /var/db/dhcpd_leases!
I0925 04:02:55.808030 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.20 HWAddress:ee:42:fa:c9:ff:a3 ID:1,ee:42:fa:c9:ff:a3 Lease:0x6512ba5e}
I0925 04:02:55.808039 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | Found match: ee:42:fa:c9:ff:a3
I0925 04:02:55.808049 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | IP: 192.168.64.20
I0925 04:02:55.808114 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetConfigRaw
I0925 04:02:55.808616 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .DriverName
I0925 04:02:55.808705 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .DriverName
I0925 04:02:55.808781 5073 main.go:141] libmachine: Waiting for machine to be running, this may take a few minutes...
I0925 04:02:55.808789 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetState
I0925 04:02:55.808869 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I0925 04:02:55.808921 5073 main.go:141] libmachine: (force-systemd-env-992000) DBG | hyperkit pid from json: 5082
I0925 04:02:55.809680 5073 main.go:141] libmachine: Detecting operating system of created instance...
I0925 04:02:55.809693 5073 main.go:141] libmachine: Waiting for SSH to be available...
I0925 04:02:55.809698 5073 main.go:141] libmachine: Getting to WaitForSSH function...
I0925 04:02:55.809706 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHHostname
I0925 04:02:55.809796 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHPort
I0925 04:02:55.809884 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHKeyPath
I0925 04:02:55.809960 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHKeyPath
I0925 04:02:55.810035 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHUsername
I0925 04:02:55.810151 5073 main.go:141] libmachine: Using SSH client type: native
I0925 04:02:55.810464 5073 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x13f2920] 0x13f5600 <nil> [] 0s} 192.168.64.20 22 <nil> <nil>}
I0925 04:02:55.810473 5073 main.go:141] libmachine: About to run SSH command:
exit 0
I0925 04:02:55.865795 5073 main.go:141] libmachine: SSH cmd err, output: <nil>:
I0925 04:02:55.865807 5073 main.go:141] libmachine: Detecting the provisioner...
I0925 04:02:55.865813 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHHostname
I0925 04:02:55.865950 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHPort
I0925 04:02:55.866061 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHKeyPath
I0925 04:02:55.866160 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHKeyPath
I0925 04:02:55.866251 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHUsername
I0925 04:02:55.866398 5073 main.go:141] libmachine: Using SSH client type: native
I0925 04:02:55.866663 5073 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x13f2920] 0x13f5600 <nil> [] 0s} 192.168.64.20 22 <nil> <nil>}
I0925 04:02:55.866672 5073 main.go:141] libmachine: About to run SSH command:
cat /etc/os-release
I0925 04:02:55.922121 5073 main.go:141] libmachine: SSH cmd err, output: <nil>: NAME=Buildroot
VERSION=2021.02.12-1-gb090841-dirty
ID=buildroot
VERSION_ID=2021.02.12
PRETTY_NAME="Buildroot 2021.02.12"
I0925 04:02:55.922191 5073 main.go:141] libmachine: found compatible host: buildroot
I0925 04:02:55.922198 5073 main.go:141] libmachine: Provisioning with buildroot...
I0925 04:02:55.922205 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetMachineName
I0925 04:02:55.922359 5073 buildroot.go:166] provisioning hostname "force-systemd-env-992000"
I0925 04:02:55.922373 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetMachineName
I0925 04:02:55.922465 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHHostname
I0925 04:02:55.922555 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHPort
I0925 04:02:55.922647 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHKeyPath
I0925 04:02:55.922718 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHKeyPath
I0925 04:02:55.922803 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHUsername
I0925 04:02:55.922932 5073 main.go:141] libmachine: Using SSH client type: native
I0925 04:02:55.923183 5073 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x13f2920] 0x13f5600 <nil> [] 0s} 192.168.64.20 22 <nil> <nil>}
I0925 04:02:55.923193 5073 main.go:141] libmachine: About to run SSH command:
sudo hostname force-systemd-env-992000 && echo "force-systemd-env-992000" | sudo tee /etc/hostname
I0925 04:02:55.987414 5073 main.go:141] libmachine: SSH cmd err, output: <nil>: force-systemd-env-992000
I0925 04:02:55.987436 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHHostname
I0925 04:02:55.987595 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHPort
I0925 04:02:55.987684 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHKeyPath
I0925 04:02:55.987755 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHKeyPath
I0925 04:02:55.987834 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHUsername
I0925 04:02:55.987986 5073 main.go:141] libmachine: Using SSH client type: native
I0925 04:02:55.988236 5073 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x13f2920] 0x13f5600 <nil> [] 0s} 192.168.64.20 22 <nil> <nil>}
I0925 04:02:55.988249 5073 main.go:141] libmachine: About to run SSH command:
if ! grep -xq '.*\sforce-systemd-env-992000' /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-992000/g' /etc/hosts;
else
echo '127.0.1.1 force-systemd-env-992000' | sudo tee -a /etc/hosts;
fi
fi
I0925 04:02:56.050038 5073 main.go:141] libmachine: SSH cmd err, output: <nil>:
I0925 04:02:56.050057 5073 buildroot.go:172] set auth options {CertDir:/Users/jenkins/minikube-integration/17297-1019/.minikube CaCertPath:/Users/jenkins/minikube-integration/17297-1019/.minikube/certs/ca.pem CaPrivateKeyPath:/Users/jenkins/minikube-integration/17297-1019/.minikube/certs/ca-key.pem CaCertRemotePath:/etc/docker/ca.pem ServerCertPath:/Users/jenkins/minikube-integration/17297-1019/.minikube/machines/server.pem ServerKeyPath:/Users/jenkins/minikube-integration/17297-1019/.minikube/machines/server-key.pem ClientKeyPath:/Users/jenkins/minikube-integration/17297-1019/.minikube/certs/key.pem ServerCertRemotePath:/etc/docker/server.pem ServerKeyRemotePath:/etc/docker/server-key.pem ClientCertPath:/Users/jenkins/minikube-integration/17297-1019/.minikube/certs/cert.pem ServerCertSANs:[] StorePath:/Users/jenkins/minikube-integration/17297-1019/.minikube}
I0925 04:02:56.050072 5073 buildroot.go:174] setting up certificates
I0925 04:02:56.050083 5073 provision.go:83] configureAuth start
I0925 04:02:56.050091 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetMachineName
I0925 04:02:56.050214 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetIP
I0925 04:02:56.050323 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHHostname
I0925 04:02:56.050418 5073 provision.go:138] copyHostCerts
I0925 04:02:56.050453 5073 vm_assets.go:163] NewFileAsset: /Users/jenkins/minikube-integration/17297-1019/.minikube/certs/ca.pem -> /Users/jenkins/minikube-integration/17297-1019/.minikube/ca.pem
I0925 04:02:56.050504 5073 exec_runner.go:144] found /Users/jenkins/minikube-integration/17297-1019/.minikube/ca.pem, removing ...
I0925 04:02:56.050515 5073 exec_runner.go:203] rm: /Users/jenkins/minikube-integration/17297-1019/.minikube/ca.pem
I0925 04:02:56.050646 5073 exec_runner.go:151] cp: /Users/jenkins/minikube-integration/17297-1019/.minikube/certs/ca.pem --> /Users/jenkins/minikube-integration/17297-1019/.minikube/ca.pem (1078 bytes)
I0925 04:02:56.050842 5073 vm_assets.go:163] NewFileAsset: /Users/jenkins/minikube-integration/17297-1019/.minikube/certs/cert.pem -> /Users/jenkins/minikube-integration/17297-1019/.minikube/cert.pem
I0925 04:02:56.050875 5073 exec_runner.go:144] found /Users/jenkins/minikube-integration/17297-1019/.minikube/cert.pem, removing ...
I0925 04:02:56.050880 5073 exec_runner.go:203] rm: /Users/jenkins/minikube-integration/17297-1019/.minikube/cert.pem
I0925 04:02:56.050954 5073 exec_runner.go:151] cp: /Users/jenkins/minikube-integration/17297-1019/.minikube/certs/cert.pem --> /Users/jenkins/minikube-integration/17297-1019/.minikube/cert.pem (1123 bytes)
I0925 04:02:56.051074 5073 vm_assets.go:163] NewFileAsset: /Users/jenkins/minikube-integration/17297-1019/.minikube/certs/key.pem -> /Users/jenkins/minikube-integration/17297-1019/.minikube/key.pem
I0925 04:02:56.051104 5073 exec_runner.go:144] found /Users/jenkins/minikube-integration/17297-1019/.minikube/key.pem, removing ...
I0925 04:02:56.051109 5073 exec_runner.go:203] rm: /Users/jenkins/minikube-integration/17297-1019/.minikube/key.pem
I0925 04:02:56.051180 5073 exec_runner.go:151] cp: /Users/jenkins/minikube-integration/17297-1019/.minikube/certs/key.pem --> /Users/jenkins/minikube-integration/17297-1019/.minikube/key.pem (1675 bytes)
I0925 04:02:56.051300 5073 provision.go:112] generating server cert: /Users/jenkins/minikube-integration/17297-1019/.minikube/machines/server.pem ca-key=/Users/jenkins/minikube-integration/17297-1019/.minikube/certs/ca.pem private-key=/Users/jenkins/minikube-integration/17297-1019/.minikube/certs/ca-key.pem org=jenkins.force-systemd-env-992000 san=[192.168.64.20 192.168.64.20 localhost 127.0.0.1 minikube force-systemd-env-992000]
I0925 04:02:56.202499 5073 provision.go:172] copyRemoteCerts
I0925 04:02:56.202561 5073 ssh_runner.go:195] Run: sudo mkdir -p /etc/docker /etc/docker /etc/docker
I0925 04:02:56.202579 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHHostname
I0925 04:02:56.202756 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHPort
I0925 04:02:56.202863 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHKeyPath
I0925 04:02:56.202968 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHUsername
I0925 04:02:56.203059 5073 sshutil.go:53] new ssh client: &{IP:192.168.64.20 Port:22 SSHKeyPath:/Users/jenkins/minikube-integration/17297-1019/.minikube/machines/force-systemd-env-992000/id_rsa Username:docker}
I0925 04:02:56.236610 5073 vm_assets.go:163] NewFileAsset: /Users/jenkins/minikube-integration/17297-1019/.minikube/certs/ca.pem -> /etc/docker/ca.pem
I0925 04:02:56.236697 5073 ssh_runner.go:362] scp /Users/jenkins/minikube-integration/17297-1019/.minikube/certs/ca.pem --> /etc/docker/ca.pem (1078 bytes)
I0925 04:02:56.252750 5073 vm_assets.go:163] NewFileAsset: /Users/jenkins/minikube-integration/17297-1019/.minikube/machines/server.pem -> /etc/docker/server.pem
I0925 04:02:56.252814 5073 ssh_runner.go:362] scp /Users/jenkins/minikube-integration/17297-1019/.minikube/machines/server.pem --> /etc/docker/server.pem (1245 bytes)
I0925 04:02:56.269078 5073 vm_assets.go:163] NewFileAsset: /Users/jenkins/minikube-integration/17297-1019/.minikube/machines/server-key.pem -> /etc/docker/server-key.pem
I0925 04:02:56.269147 5073 ssh_runner.go:362] scp /Users/jenkins/minikube-integration/17297-1019/.minikube/machines/server-key.pem --> /etc/docker/server-key.pem (1675 bytes)
I0925 04:02:56.285980 5073 provision.go:86] duration metric: configureAuth took 235.882142ms
I0925 04:02:56.285993 5073 buildroot.go:189] setting minikube options for container-runtime
I0925 04:02:56.286133 5073 config.go:182] Loaded profile config "force-systemd-env-992000": Driver=hyperkit, ContainerRuntime=docker, KubernetesVersion=v1.28.2
I0925 04:02:56.286151 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .DriverName
I0925 04:02:56.286279 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHHostname
I0925 04:02:56.286366 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHPort
I0925 04:02:56.286460 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHKeyPath
I0925 04:02:56.286555 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHKeyPath
I0925 04:02:56.286635 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHUsername
I0925 04:02:56.286755 5073 main.go:141] libmachine: Using SSH client type: native
I0925 04:02:56.286992 5073 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x13f2920] 0x13f5600 <nil> [] 0s} 192.168.64.20 22 <nil> <nil>}
I0925 04:02:56.287000 5073 main.go:141] libmachine: About to run SSH command:
df --output=fstype / | tail -n 1
I0925 04:02:56.343048 5073 main.go:141] libmachine: SSH cmd err, output: <nil>: tmpfs
I0925 04:02:56.343061 5073 buildroot.go:70] root file system type: tmpfs
I0925 04:02:56.343148 5073 provision.go:309] Updating docker unit: /lib/systemd/system/docker.service ...
I0925 04:02:56.343164 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHHostname
I0925 04:02:56.343298 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHPort
I0925 04:02:56.343399 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHKeyPath
I0925 04:02:56.343487 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHKeyPath
I0925 04:02:56.343577 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHUsername
I0925 04:02:56.343700 5073 main.go:141] libmachine: Using SSH client type: native
I0925 04:02:56.343977 5073 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x13f2920] 0x13f5600 <nil> [] 0s} 192.168.64.20 22 <nil> <nil>}
I0925 04:02:56.344037 5073 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
I0925 04:02:56.409199 5073 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
I0925 04:02:56.409224 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHHostname
I0925 04:02:56.409362 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHPort
I0925 04:02:56.409463 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHKeyPath
I0925 04:02:56.409568 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHKeyPath
I0925 04:02:56.409671 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHUsername
I0925 04:02:56.409815 5073 main.go:141] libmachine: Using SSH client type: native
I0925 04:02:56.410081 5073 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x13f2920] 0x13f5600 <nil> [] 0s} 192.168.64.20 22 <nil> <nil>}
I0925 04:02:56.410094 5073 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; }
I0925 04:02:56.925700 5073 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.
I0925 04:02:56.925727 5073 main.go:141] libmachine: Checking connection to Docker...
I0925 04:02:56.925734 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetURL
I0925 04:02:56.925880 5073 main.go:141] libmachine: Docker is up and running!
I0925 04:02:56.925887 5073 main.go:141] libmachine: Reticulating splines...
I0925 04:02:56.925906 5073 client.go:171] LocalClient.Create took 11.852230342s
I0925 04:02:56.925918 5073 start.go:167] duration metric: libmachine.API.Create for "force-systemd-env-992000" took 11.852292569s
I0925 04:02:56.925927 5073 start.go:300] post-start starting for "force-systemd-env-992000" (driver="hyperkit")
I0925 04:02:56.925936 5073 start.go:329] creating required directories: [/etc/kubernetes/addons /etc/kubernetes/manifests /var/tmp/minikube /var/lib/minikube /var/lib/minikube/certs /var/lib/minikube/images /var/lib/minikube/binaries /tmp/gvisor /usr/share/ca-certificates /etc/ssl/certs]
I0925 04:02:56.925947 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .DriverName
I0925 04:02:56.926089 5073 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
I0925 04:02:56.926102 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHHostname
I0925 04:02:56.926193 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHPort
I0925 04:02:56.926290 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHKeyPath
I0925 04:02:56.926377 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHUsername
I0925 04:02:56.926499 5073 sshutil.go:53] new ssh client: &{IP:192.168.64.20 Port:22 SSHKeyPath:/Users/jenkins/minikube-integration/17297-1019/.minikube/machines/force-systemd-env-992000/id_rsa Username:docker}
I0925 04:02:56.959828 5073 ssh_runner.go:195] Run: cat /etc/os-release
I0925 04:02:56.962626 5073 info.go:137] Remote host: Buildroot 2021.02.12
I0925 04:02:56.962642 5073 filesync.go:126] Scanning /Users/jenkins/minikube-integration/17297-1019/.minikube/addons for local assets ...
I0925 04:02:56.962738 5073 filesync.go:126] Scanning /Users/jenkins/minikube-integration/17297-1019/.minikube/files for local assets ...
I0925 04:02:56.962904 5073 filesync.go:149] local asset: /Users/jenkins/minikube-integration/17297-1019/.minikube/files/etc/ssl/certs/14872.pem -> 14872.pem in /etc/ssl/certs
I0925 04:02:56.962911 5073 vm_assets.go:163] NewFileAsset: /Users/jenkins/minikube-integration/17297-1019/.minikube/files/etc/ssl/certs/14872.pem -> /etc/ssl/certs/14872.pem
I0925 04:02:56.963105 5073 ssh_runner.go:195] Run: sudo mkdir -p /etc/ssl/certs
I0925 04:02:56.969079 5073 ssh_runner.go:362] scp /Users/jenkins/minikube-integration/17297-1019/.minikube/files/etc/ssl/certs/14872.pem --> /etc/ssl/certs/14872.pem (1708 bytes)
I0925 04:02:56.986706 5073 start.go:303] post-start completed in 60.768026ms
I0925 04:02:56.986746 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetConfigRaw
I0925 04:02:56.987404 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetIP
I0925 04:02:56.987580 5073 profile.go:148] Saving config to /Users/jenkins/minikube-integration/17297-1019/.minikube/profiles/force-systemd-env-992000/config.json ...
I0925 04:02:56.987897 5073 start.go:128] duration metric: createHost completed in 11.983969248s
I0925 04:02:56.987914 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHHostname
I0925 04:02:56.988022 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHPort
I0925 04:02:56.988109 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHKeyPath
I0925 04:02:56.988196 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHKeyPath
I0925 04:02:56.988279 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHUsername
I0925 04:02:56.988387 5073 main.go:141] libmachine: Using SSH client type: native
I0925 04:02:56.988636 5073 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x13f2920] 0x13f5600 <nil> [] 0s} 192.168.64.20 22 <nil> <nil>}
I0925 04:02:56.988646 5073 main.go:141] libmachine: About to run SSH command:
date +%s.%N
I0925 04:02:57.045470 5073 main.go:141] libmachine: SSH cmd err, output: <nil>: 1695639776.921420990
I0925 04:02:57.045482 5073 fix.go:206] guest clock: 1695639776.921420990
I0925 04:02:57.045488 5073 fix.go:219] Guest: 2023-09-25 04:02:56.92142099 -0700 PDT Remote: 2023-09-25 04:02:56.987907 -0700 PDT m=+12.599334362 (delta=-66.48601ms)
I0925 04:02:57.045504 5073 fix.go:190] guest clock delta is within tolerance: -66.48601ms
I0925 04:02:57.045508 5073 start.go:83] releasing machines lock for "force-systemd-env-992000", held for 12.041729584s
I0925 04:02:57.045527 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .DriverName
I0925 04:02:57.045679 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetIP
I0925 04:02:57.045780 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .DriverName
I0925 04:02:57.046123 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .DriverName
I0925 04:02:57.046246 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .DriverName
I0925 04:02:57.046356 5073 ssh_runner.go:195] Run: curl -sS -m 2 https://registry.k8s.io/
I0925 04:02:57.046392 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHHostname
I0925 04:02:57.046414 5073 ssh_runner.go:195] Run: cat /version.json
I0925 04:02:57.046425 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHHostname
I0925 04:02:57.046515 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHPort
I0925 04:02:57.046535 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHPort
I0925 04:02:57.046607 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHKeyPath
I0925 04:02:57.046630 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHKeyPath
I0925 04:02:57.046727 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHUsername
I0925 04:02:57.046761 5073 main.go:141] libmachine: (force-systemd-env-992000) Calling .GetSSHUsername
I0925 04:02:57.046829 5073 sshutil.go:53] new ssh client: &{IP:192.168.64.20 Port:22 SSHKeyPath:/Users/jenkins/minikube-integration/17297-1019/.minikube/machines/force-systemd-env-992000/id_rsa Username:docker}
I0925 04:02:57.046878 5073 sshutil.go:53] new ssh client: &{IP:192.168.64.20 Port:22 SSHKeyPath:/Users/jenkins/minikube-integration/17297-1019/.minikube/machines/force-systemd-env-992000/id_rsa Username:docker}
I0925 04:02:57.119220 5073 ssh_runner.go:195] Run: systemctl --version
I0925 04:02:57.123307 5073 ssh_runner.go:195] Run: sh -c "stat /etc/cni/net.d/*loopback.conf*"
W0925 04:02:57.127129 5073 cni.go:209] loopback cni configuration skipped: "/etc/cni/net.d/*loopback.conf*" not found
I0925 04:02:57.127211 5073 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" ;
I0925 04:02:57.139173 5073 cni.go:262] disabled [/etc/cni/net.d/87-podman-bridge.conflist] bridge cni config(s)
I0925 04:02:57.139189 5073 start.go:469] detecting cgroup driver to use...
I0925 04:02:57.139201 5073 start.go:473] using "systemd" cgroup driver as enforced via flags
I0925 04:02:57.139312 5073 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"
I0925 04:02:57.153911 5073 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"
I0925 04:02:57.161206 5073 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"
I0925 04:02:57.168371 5073 containerd.go:145] configuring containerd to use "systemd" as cgroup driver...
I0925 04:02:57.168417 5073 ssh_runner.go:195] Run: sh -c "sudo sed -i -r 's|^( *)SystemdCgroup = .*$|\1SystemdCgroup = true|g' /etc/containerd/config.toml"
I0925 04:02:57.175782 5073 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"
I0925 04:02:57.183517 5073 ssh_runner.go:195] Run: sh -c "sudo sed -i '/systemd_cgroup/d' /etc/containerd/config.toml"
I0925 04:02:57.191300 5073 ssh_runner.go:195] Run: sh -c "sudo sed -i 's|"io.containerd.runc.v1"|"io.containerd.runc.v2"|g' /etc/containerd/config.toml"
I0925 04:02:57.198881 5073 ssh_runner.go:195] Run: sh -c "sudo rm -rf /etc/cni/net.mk"
I0925 04:02:57.206804 5073 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"
I0925 04:02:57.214540 5073 ssh_runner.go:195] Run: sudo sysctl net.bridge.bridge-nf-call-iptables
I0925 04:02:57.221464 5073 ssh_runner.go:195] Run: sudo sh -c "echo 1 > /proc/sys/net/ipv4/ip_forward"
I0925 04:02:57.228624 5073 ssh_runner.go:195] Run: sudo systemctl daemon-reload
I0925 04:02:57.319372 5073 ssh_runner.go:195] Run: sudo systemctl restart containerd
I0925 04:02:57.332381 5073 start.go:469] detecting cgroup driver to use...
I0925 04:02:57.332405 5073 start.go:473] using "systemd" cgroup driver as enforced via flags
I0925 04:02:57.332503 5073 ssh_runner.go:195] Run: sudo systemctl cat docker.service
I0925 04:02:57.347258 5073 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service containerd
I0925 04:02:57.362479 5073 ssh_runner.go:195] Run: sudo systemctl stop -f containerd
I0925 04:02:57.382463 5073 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service containerd
I0925 04:02:57.391096 5073 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service crio
I0925 04:02:57.399651 5073 ssh_runner.go:195] Run: sudo systemctl stop -f crio
I0925 04:02:57.429019 5073 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service crio
I0925 04:02:57.438386 5073 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"
I0925 04:02:57.451003 5073 ssh_runner.go:195] Run: which cri-dockerd
I0925 04:02:57.453681 5073 ssh_runner.go:195] Run: sudo mkdir -p /etc/systemd/system/cri-docker.service.d
I0925 04:02:57.459854 5073 ssh_runner.go:362] scp memory --> /etc/systemd/system/cri-docker.service.d/10-cni.conf (189 bytes)
I0925 04:02:57.471139 5073 ssh_runner.go:195] Run: sudo systemctl unmask docker.service
I0925 04:02:57.558145 5073 ssh_runner.go:195] Run: sudo systemctl enable docker.socket
I0925 04:02:57.648041 5073 docker.go:554] configuring docker to use "systemd" as cgroup driver...
I0925 04:02:57.648139 5073 ssh_runner.go:362] scp memory --> /etc/docker/daemon.json (129 bytes)
I0925 04:02:57.659202 5073 ssh_runner.go:195] Run: sudo systemctl daemon-reload
I0925 04:02:57.745289 5073 ssh_runner.go:195] Run: sudo systemctl restart docker
I0925 04:02:58.978378 5073 ssh_runner.go:235] Completed: sudo systemctl restart docker: (1.23306488s)
I0925 04:02:58.978447 5073 ssh_runner.go:195] Run: sudo systemctl enable cri-docker.socket
I0925 04:02:59.068913 5073 ssh_runner.go:195] Run: sudo systemctl unmask cri-docker.socket
I0925 04:02:59.162017 5073 ssh_runner.go:195] Run: sudo systemctl enable cri-docker.socket
I0925 04:02:59.259928 5073 ssh_runner.go:195] Run: sudo systemctl daemon-reload
I0925 04:02:59.357712 5073 ssh_runner.go:195] Run: sudo systemctl restart cri-docker.socket
I0925 04:02:59.406861 5073 out.go:177]
W0925 04:02:59.427898 5073 out.go:239] X Exiting due to RUNTIME_ENABLE: Failed to enable container runtime: sudo systemctl restart cri-docker.socket: Process exited with status 1
stdout:
stderr:
Job failed. See "journalctl -xe" for details.
X Exiting due to RUNTIME_ENABLE: Failed to enable container runtime: sudo systemctl restart cri-docker.socket: Process exited with status 1
stdout:
stderr:
Job failed. See "journalctl -xe" for details.
W0925 04:02:59.427926 5073 out.go:239] *
*
W0925 04:02:59.429175 5073 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. │
│ │
╰─────────────────────────────────────────────────────────────────────────────────────────────╯
I0925 04:02:59.490918 5073 out.go:177]
** /stderr **
docker_test.go:157: failed to start minikube with args: "out/minikube-darwin-amd64 start -p force-systemd-env-992000 --memory=2048 --alsologtostderr -v=5 --driver=hyperkit " : exit status 90
docker_test.go:110: (dbg) Run: out/minikube-darwin-amd64 -p force-systemd-env-992000 ssh "docker info --format {{.CgroupDriver}}"
docker_test.go:166: *** TestForceSystemdEnv FAILED at 2023-09-25 04:02:59.673409 -0700 PDT m=+1802.131389625
helpers_test.go:222: -----------------------post-mortem--------------------------------
helpers_test.go:239: (dbg) Run: out/minikube-darwin-amd64 status --format={{.Host}} -p force-systemd-env-992000 -n force-systemd-env-992000
helpers_test.go:239: (dbg) Non-zero exit: out/minikube-darwin-amd64 status --format={{.Host}} -p force-systemd-env-992000 -n force-systemd-env-992000: exit status 6 (122.598911ms)
-- stdout --
Running
WARNING: Your kubectl is pointing to stale minikube-vm.
To fix the kubectl context, run `minikube update-context`
-- /stdout --
** stderr **
E0925 04:02:59.786722 5091 status.go:415] kubeconfig endpoint: extract IP: "force-systemd-env-992000" does not appear in /Users/jenkins/minikube-integration/17297-1019/kubeconfig
** /stderr **
helpers_test.go:239: status error: exit status 6 (may be ok)
helpers_test.go:241: "force-systemd-env-992000" 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-992000" profile ...
helpers_test.go:178: (dbg) Run: out/minikube-darwin-amd64 delete -p force-systemd-env-992000
helpers_test.go:178: (dbg) Done: out/minikube-darwin-amd64 delete -p force-systemd-env-992000: (5.265553067s)
--- FAIL: TestForceSystemdEnv (20.68s)