=== RUN TestForceSystemdEnv
=== PAUSE TestForceSystemdEnv
=== CONT TestForceSystemdEnv
docker_test.go:155: (dbg) Run: out/minikube-darwin-amd64 start -p force-systemd-env-327000 --memory=2048 --alsologtostderr -v=5 --driver=hyperkit
docker_test.go:155: (dbg) Non-zero exit: out/minikube-darwin-amd64 start -p force-systemd-env-327000 --memory=2048 --alsologtostderr -v=5 --driver=hyperkit : exit status 90 (14.941204922s)
-- stdout --
* [force-systemd-env-327000] minikube v1.30.1 on Darwin 13.4.1
- MINIKUBE_LOCATION=15452
- KUBECONFIG=/Users/jenkins/minikube-integration/15452-1292/kubeconfig
- MINIKUBE_BIN=out/minikube-darwin-amd64
- MINIKUBE_SUPPRESS_DOCKER_PERFORMANCE=true
- MINIKUBE_HOME=/Users/jenkins/minikube-integration/15452-1292/.minikube
- MINIKUBE_FORCE_SYSTEMD=true
* Using the hyperkit driver based on user configuration
* Starting control plane node force-systemd-env-327000 in cluster force-systemd-env-327000
* Creating hyperkit VM (CPUs=2, Memory=2048MB, Disk=20000MB) ...
-- /stdout --
** stderr **
I0706 11:29:50.128780 5620 out.go:296] Setting OutFile to fd 1 ...
I0706 11:29:50.128980 5620 out.go:343] TERM=,COLORTERM=, which probably does not support color
I0706 11:29:50.128986 5620 out.go:309] Setting ErrFile to fd 2...
I0706 11:29:50.128990 5620 out.go:343] TERM=,COLORTERM=, which probably does not support color
I0706 11:29:50.129124 5620 root.go:336] Updating PATH: /Users/jenkins/minikube-integration/15452-1292/.minikube/bin
I0706 11:29:50.130855 5620 out.go:303] Setting JSON to false
I0706 11:29:50.149995 5620 start.go:127] hostinfo: {"hostname":"MacOS-Agent-4.local","uptime":3561,"bootTime":1688664629,"procs":394,"os":"darwin","platform":"darwin","platformFamily":"Standalone Workstation","platformVersion":"13.4.1","kernelVersion":"22.5.0","kernelArch":"x86_64","virtualizationSystem":"","virtualizationRole":"","hostId":"f2f27e25-cfda-5ffd-9706-e98286194e62"}
W0706 11:29:50.150080 5620 start.go:135] gopshost.Virtualization returned error: not implemented yet
I0706 11:29:50.171957 5620 out.go:177] * [force-systemd-env-327000] minikube v1.30.1 on Darwin 13.4.1
I0706 11:29:50.229881 5620 notify.go:220] Checking for updates...
I0706 11:29:50.252594 5620 out.go:177] - MINIKUBE_LOCATION=15452
I0706 11:29:50.294421 5620 out.go:177] - KUBECONFIG=/Users/jenkins/minikube-integration/15452-1292/kubeconfig
I0706 11:29:50.336244 5620 out.go:177] - MINIKUBE_BIN=out/minikube-darwin-amd64
I0706 11:29:50.378432 5620 out.go:177] - MINIKUBE_SUPPRESS_DOCKER_PERFORMANCE=true
I0706 11:29:50.399300 5620 out.go:177] - MINIKUBE_HOME=/Users/jenkins/minikube-integration/15452-1292/.minikube
I0706 11:29:50.441408 5620 out.go:177] - MINIKUBE_FORCE_SYSTEMD=true
I0706 11:29:50.462708 5620 config.go:182] Loaded profile config "offline-docker-384000": Driver=hyperkit, ContainerRuntime=docker, KubernetesVersion=v1.27.3
I0706 11:29:50.462796 5620 driver.go:373] Setting default libvirt URI to qemu:///system
I0706 11:29:50.490483 5620 out.go:177] * Using the hyperkit driver based on user configuration
I0706 11:29:50.532340 5620 start.go:297] selected driver: hyperkit
I0706 11:29:50.532383 5620 start.go:944] validating driver "hyperkit" against <nil>
I0706 11:29:50.532403 5620 start.go:955] status for hyperkit: {Installed:true Healthy:true Running:true NeedsImprovement:false Error:<nil> Reason: Fix: Doc: Version:}
I0706 11:29:50.536468 5620 install.go:52] acquiring lock: {Name:mk4023283b30b374c3f04c8805d539e68824c0b8 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I0706 11:29:50.536597 5620 install.go:117] Validating docker-machine-driver-hyperkit, PATH=/Users/jenkins/minikube-integration/15452-1292/.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
I0706 11:29:50.543416 5620 install.go:137] /Users/jenkins/workspace/out/docker-machine-driver-hyperkit version is 1.30.1
I0706 11:29:50.546934 5620 install.go:79] stdout: /Users/jenkins/workspace/out/docker-machine-driver-hyperkit
I0706 11:29:50.546963 5620 install.go:81] /Users/jenkins/workspace/out/docker-machine-driver-hyperkit looks good
I0706 11:29:50.546996 5620 start_flags.go:305] no existing cluster config was found, will generate one from the flags
I0706 11:29:50.547196 5620 start_flags.go:901] Wait components to verify : map[apiserver:true system_pods:true]
I0706 11:29:50.547217 5620 cni.go:84] Creating CNI manager for ""
I0706 11:29:50.547236 5620 cni.go:152] "hyperkit" driver + "docker" runtime found, recommending bridge
I0706 11:29:50.547243 5620 start_flags.go:314] Found "bridge CNI" CNI - setting NetworkPlugin=cni
I0706 11:29:50.547251 5620 start_flags.go:319] config:
{Name:force-systemd-env-327000 KeepContext:false EmbedCerts:false MinikubeISO: KicBaseImage:gcr.io/k8s-minikube/kicbase-builds:v0.0.39-1686675164-15452@sha256:1b5dd777e073cc98bda2dc463cdc550cd7c5b3dcdbff2b89d285943191470e34 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.27.3 ClusterName:force-systemd-env-327000 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}
I0706 11:29:50.547398 5620 iso.go:125] acquiring lock: {Name:mk2c626a2299b31078f68588f466f1c7959cb3cc Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I0706 11:29:50.568508 5620 out.go:177] * Starting control plane node force-systemd-env-327000 in cluster force-systemd-env-327000
I0706 11:29:50.589798 5620 preload.go:132] Checking if preload exists for k8s version v1.27.3 and runtime docker
I0706 11:29:50.589961 5620 preload.go:148] Found local preload: /Users/jenkins/minikube-integration/15452-1292/.minikube/cache/preloaded-tarball/preloaded-images-k8s-v18-v1.27.3-docker-overlay2-amd64.tar.lz4
I0706 11:29:50.589999 5620 cache.go:57] Caching tarball of preloaded images
I0706 11:29:50.590266 5620 preload.go:174] Found /Users/jenkins/minikube-integration/15452-1292/.minikube/cache/preloaded-tarball/preloaded-images-k8s-v18-v1.27.3-docker-overlay2-amd64.tar.lz4 in cache, skipping download
I0706 11:29:50.590288 5620 cache.go:60] Finished verifying existence of preloaded tar for v1.27.3 on docker
I0706 11:29:50.590477 5620 profile.go:148] Saving config to /Users/jenkins/minikube-integration/15452-1292/.minikube/profiles/force-systemd-env-327000/config.json ...
I0706 11:29:50.590544 5620 lock.go:35] WriteFile acquiring /Users/jenkins/minikube-integration/15452-1292/.minikube/profiles/force-systemd-env-327000/config.json: {Name:mkcdadf1ce93c8c8578095f026d7019b63a5a2d1 Clock:{} Delay:500ms Timeout:1m0s Cancel:<nil>}
I0706 11:29:50.591142 5620 start.go:365] acquiring machines lock for force-systemd-env-327000: {Name:mk53c912cdee7c8b38c22f01c9fc81fde1f07276 Clock:{} Delay:500ms Timeout:13m0s Cancel:<nil>}
I0706 11:29:50.591253 5620 start.go:369] acquired machines lock for "force-systemd-env-327000" in 83.025µs
I0706 11:29:50.591292 5620 start.go:93] Provisioning new machine with config: &{Name:force-systemd-env-327000 KeepContext:false EmbedCerts:false MinikubeISO:https://storage.googleapis.com/minikube-builds/iso/16765/minikube-v1.30.1-1688144767-16765-amd64.iso KicBaseImage:gcr.io/k8s-minikube/kicbase-builds:v0.0.39-1686675164-15452@sha256:1b5dd777e073cc98bda2dc463cdc550cd7c5b3dcdbff2b89d285943191470e34 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.27.3 ClusterName:force-systemd-env-327000 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.27.3 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} &{Name: IP: Port:8443 KubernetesVersion:v1.27.3 ContainerRuntime:docker ControlPlane:true Worker:true}
I0706 11:29:50.591376 5620 start.go:125] createHost starting for "" (driver="hyperkit")
I0706 11:29:50.612355 5620 out.go:204] * Creating hyperkit VM (CPUs=2, Memory=2048MB, Disk=20000MB) ...
I0706 11:29:50.612613 5620 main.go:141] libmachine: Found binary path at /Users/jenkins/workspace/out/docker-machine-driver-hyperkit
I0706 11:29:50.612642 5620 main.go:141] libmachine: Launching plugin server for driver hyperkit
I0706 11:29:50.619750 5620 main.go:141] libmachine: Plugin server listening at address 127.0.0.1:52222
I0706 11:29:50.620114 5620 main.go:141] libmachine: () Calling .GetVersion
I0706 11:29:50.620546 5620 main.go:141] libmachine: Using API Version 1
I0706 11:29:50.620557 5620 main.go:141] libmachine: () Calling .SetConfigRaw
I0706 11:29:50.620760 5620 main.go:141] libmachine: () Calling .GetMachineName
I0706 11:29:50.620856 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetMachineName
I0706 11:29:50.620930 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .DriverName
I0706 11:29:50.621021 5620 start.go:159] libmachine.API.Create for "force-systemd-env-327000" (driver="hyperkit")
I0706 11:29:50.621039 5620 client.go:168] LocalClient.Create starting
I0706 11:29:50.621076 5620 main.go:141] libmachine: Reading certificate data from /Users/jenkins/minikube-integration/15452-1292/.minikube/certs/ca.pem
I0706 11:29:50.621121 5620 main.go:141] libmachine: Decoding PEM data...
I0706 11:29:50.621137 5620 main.go:141] libmachine: Parsing certificate...
I0706 11:29:50.621171 5620 main.go:141] libmachine: Reading certificate data from /Users/jenkins/minikube-integration/15452-1292/.minikube/certs/cert.pem
I0706 11:29:50.621195 5620 main.go:141] libmachine: Decoding PEM data...
I0706 11:29:50.621203 5620 main.go:141] libmachine: Parsing certificate...
I0706 11:29:50.621216 5620 main.go:141] libmachine: Running pre-create checks...
I0706 11:29:50.621242 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .PreCreateCheck
I0706 11:29:50.621319 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I0706 11:29:50.621479 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetConfigRaw
I0706 11:29:50.621902 5620 main.go:141] libmachine: Creating machine...
I0706 11:29:50.621913 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .Create
I0706 11:29:50.622016 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I0706 11:29:50.622133 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | I0706 11:29:50.621998 5628 common.go:145] Making disk image using store path: /Users/jenkins/minikube-integration/15452-1292/.minikube
I0706 11:29:50.622172 5620 main.go:141] libmachine: (force-systemd-env-327000) Downloading /Users/jenkins/minikube-integration/15452-1292/.minikube/cache/boot2docker.iso from file:///Users/jenkins/minikube-integration/15452-1292/.minikube/cache/iso/amd64/minikube-v1.30.1-1688144767-16765-amd64.iso...
I0706 11:29:50.801370 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | I0706 11:29:50.801271 5628 common.go:152] Creating ssh key: /Users/jenkins/minikube-integration/15452-1292/.minikube/machines/force-systemd-env-327000/id_rsa...
I0706 11:29:50.985455 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | I0706 11:29:50.985397 5628 common.go:158] Creating raw disk image: /Users/jenkins/minikube-integration/15452-1292/.minikube/machines/force-systemd-env-327000/force-systemd-env-327000.rawdisk...
I0706 11:29:50.985471 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | Writing magic tar header
I0706 11:29:50.985484 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | Writing SSH key tar header
I0706 11:29:50.985859 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | I0706 11:29:50.985813 5628 common.go:172] Fixing permissions on /Users/jenkins/minikube-integration/15452-1292/.minikube/machines/force-systemd-env-327000 ...
I0706 11:29:51.310454 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I0706 11:29:51.310476 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | clean start, hyperkit pid file doesn't exist: /Users/jenkins/minikube-integration/15452-1292/.minikube/machines/force-systemd-env-327000/hyperkit.pid
I0706 11:29:51.310487 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | Using UUID 17f453f0-1c2b-11ee-af76-149d997fca88
I0706 11:29:51.331821 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | Generated MAC 5a:9:9b:b:10:19
I0706 11:29:51.331845 5620 main.go:141] libmachine: (force-systemd-env-327000) 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-327000
I0706 11:29:51.331920 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | 2023/07/06 11:29:51 DEBUG: hyperkit: Start &hyperkit.HyperKit{HyperKit:"/usr/local/bin/hyperkit", Argv0:"", StateDir:"/Users/jenkins/minikube-integration/15452-1292/.minikube/machines/force-systemd-env-327000", VPNKitSock:"", VPNKitUUID:"", VPNKitPreferredIPv4:"", UUID:"17f453f0-1c2b-11ee-af76-149d997fca88", Disks:[]hyperkit.Disk{(*hyperkit.RawDisk)(0xc0001251d0)}, ISOImages:[]string{"/Users/jenkins/minikube-integration/15452-1292/.minikube/machines/force-systemd-env-327000/boot2docker.iso"}, VSock:false, VSockDir:"", VSockPorts:[]int(nil), VSockGuestCID:3, VMNet:true, Sockets9P:[]hyperkit.Socket9P(nil), Kernel:"/Users/jenkins/minikube-integration/15452-1292/.minikube/machines/force-systemd-env-327000/bzimage", Initrd:"/Users/jenkins/minikube-integration/15452-1292/.minikube/machines/force-systemd-env-327000/initrd", Bootrom:"", CPUs:2, Memory:2048, Console:1, Serials:[]hyperkit.Serial(nil), Pid:0, Arguments:[]str
ing(nil), CmdLine:"", process:(*os.Process)(nil)}
I0706 11:29:51.331950 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | 2023/07/06 11:29:51 DEBUG: hyperkit: check &hyperkit.HyperKit{HyperKit:"/usr/local/bin/hyperkit", Argv0:"", StateDir:"/Users/jenkins/minikube-integration/15452-1292/.minikube/machines/force-systemd-env-327000", VPNKitSock:"", VPNKitUUID:"", VPNKitPreferredIPv4:"", UUID:"17f453f0-1c2b-11ee-af76-149d997fca88", Disks:[]hyperkit.Disk{(*hyperkit.RawDisk)(0xc0001251d0)}, ISOImages:[]string{"/Users/jenkins/minikube-integration/15452-1292/.minikube/machines/force-systemd-env-327000/boot2docker.iso"}, VSock:false, VSockDir:"", VSockPorts:[]int(nil), VSockGuestCID:3, VMNet:true, Sockets9P:[]hyperkit.Socket9P(nil), Kernel:"/Users/jenkins/minikube-integration/15452-1292/.minikube/machines/force-systemd-env-327000/bzimage", Initrd:"/Users/jenkins/minikube-integration/15452-1292/.minikube/machines/force-systemd-env-327000/initrd", Bootrom:"", CPUs:2, Memory:2048, Console:1, Serials:[]hyperkit.Serial(nil), Pid:0, Arguments:[]str
ing(nil), CmdLine:"", process:(*os.Process)(nil)}
I0706 11:29:51.332005 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | 2023/07/06 11:29:51 DEBUG: hyperkit: Arguments: []string{"-A", "-u", "-F", "/Users/jenkins/minikube-integration/15452-1292/.minikube/machines/force-systemd-env-327000/hyperkit.pid", "-c", "2", "-m", "2048M", "-s", "0:0,hostbridge", "-s", "31,lpc", "-s", "1:0,virtio-net", "-U", "17f453f0-1c2b-11ee-af76-149d997fca88", "-s", "2:0,virtio-blk,/Users/jenkins/minikube-integration/15452-1292/.minikube/machines/force-systemd-env-327000/force-systemd-env-327000.rawdisk", "-s", "3,ahci-cd,/Users/jenkins/minikube-integration/15452-1292/.minikube/machines/force-systemd-env-327000/boot2docker.iso", "-s", "4,virtio-rnd", "-l", "com1,autopty=/Users/jenkins/minikube-integration/15452-1292/.minikube/machines/force-systemd-env-327000/tty,log=/Users/jenkins/minikube-integration/15452-1292/.minikube/machines/force-systemd-env-327000/console-ring", "-f", "kexec,/Users/jenkins/minikube-integration/15452-1292/.minikube/machines/force-sys
temd-env-327000/bzimage,/Users/jenkins/minikube-integration/15452-1292/.minikube/machines/force-systemd-env-327000/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-327000"}
I0706 11:29:51.332045 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | 2023/07/06 11:29:51 DEBUG: hyperkit: CmdLine: "/usr/local/bin/hyperkit -A -u -F /Users/jenkins/minikube-integration/15452-1292/.minikube/machines/force-systemd-env-327000/hyperkit.pid -c 2 -m 2048M -s 0:0,hostbridge -s 31,lpc -s 1:0,virtio-net -U 17f453f0-1c2b-11ee-af76-149d997fca88 -s 2:0,virtio-blk,/Users/jenkins/minikube-integration/15452-1292/.minikube/machines/force-systemd-env-327000/force-systemd-env-327000.rawdisk -s 3,ahci-cd,/Users/jenkins/minikube-integration/15452-1292/.minikube/machines/force-systemd-env-327000/boot2docker.iso -s 4,virtio-rnd -l com1,autopty=/Users/jenkins/minikube-integration/15452-1292/.minikube/machines/force-systemd-env-327000/tty,log=/Users/jenkins/minikube-integration/15452-1292/.minikube/machines/force-systemd-env-327000/console-ring -f kexec,/Users/jenkins/minikube-integration/15452-1292/.minikube/machines/force-systemd-env-327000/bzimage,/Users/jenkins/minikube-integration/15
452-1292/.minikube/machines/force-systemd-env-327000/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-327000"
I0706 11:29:51.332055 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | 2023/07/06 11:29:51 DEBUG: hyperkit: Redirecting stdout/stderr to logger
I0706 11:29:51.334949 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | 2023/07/06 11:29:51 DEBUG: hyperkit: Pid is 5629
I0706 11:29:51.335331 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | Attempt 0
I0706 11:29:51.335349 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I0706 11:29:51.335429 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | hyperkit pid from json: 5629
I0706 11:29:51.336222 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | Searching for 5a:9:9b:b:10:19 in /var/db/dhcpd_leases ...
I0706 11:29:51.336251 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | Found 18 entries in /var/db/dhcpd_leases!
I0706 11:29:51.336262 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.19 HWAddress:36:8f:10:6b:a5:26 ID:1,36:8f:10:6b:a5:26 Lease:0x64a85992}
I0706 11:29:51.336290 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.18 HWAddress:4a:fd:e0:64:8:1b ID:1,4a:fd:e0:64:8:1b Lease:0x64a85926}
I0706 11:29:51.336310 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.17 HWAddress:aa:e9:64:86:a6:77 ID:1,aa:e9:64:86:a6:77 Lease:0x64a858b9}
I0706 11:29:51.336326 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.16 HWAddress:fe:bd:e2:30:9:9c ID:1,fe:bd:e2:30:9:9c Lease:0x64a8586a}
I0706 11:29:51.336339 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.15 HWAddress:ee:89:ef:2e:88:a2 ID:1,ee:89:ef:2e:88:a2 Lease:0x64a857d7}
I0706 11:29:51.336350 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.14 HWAddress:1e:77:5e:a:5b:76 ID:1,1e:77:5e:a:5b:76 Lease:0x64a705bb}
I0706 11:29:51.336359 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.13 HWAddress:3a:6:2d:3b:99:ee ID:1,3a:6:2d:3b:99:ee Lease:0x64a857a1}
I0706 11:29:51.336367 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.12 HWAddress:2e:48:a:75:36:d9 ID:1,2e:48:a:75:36:d9 Lease:0x64a85756}
I0706 11:29:51.336378 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.11 HWAddress:a:78:ca:16:ec:b2 ID:1,a:78:ca:16:ec:b2 Lease:0x64a70474}
I0706 11:29:51.336386 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.10 HWAddress:2a:5e:c3:51:61:f1 ID:1,2a:5e:c3:51:61:f1 Lease:0x64a70445}
I0706 11:29:51.336393 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.9 HWAddress:ce:c0:c5:93:71:f ID:1,ce:c0:c5:93:71:f Lease:0x64a7041c}
I0706 11:29:51.336409 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.8 HWAddress:ca:1f:af:38:26:7 ID:1,ca:1f:af:38:26:7 Lease:0x64a8555a}
I0706 11:29:51.336419 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.7 HWAddress:56:c4:af:c0:5a:5c ID:1,56:c4:af:c0:5a:5c Lease:0x64a85513}
I0706 11:29:51.336446 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.6 HWAddress:ee:53:97:eb:4c:2d ID:1,ee:53:97:eb:4c:2d Lease:0x64a85473}
I0706 11:29:51.336460 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.5 HWAddress:ce:2e:68:4e:d8:ef ID:1,ce:2e:68:4e:d8:ef Lease:0x64a702e0}
I0706 11:29:51.336473 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.4 HWAddress:36:8d:55:3e:e9:99 ID:1,36:8d:55:3e:e9:99 Lease:0x64a8535c}
I0706 11:29:51.336483 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.3 HWAddress:ce:41:4c:ec:48:36 ID:1,ce:41:4c:ec:48:36 Lease:0x64a701d1}
I0706 11:29:51.336504 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.2 HWAddress:3a:39:ed:0:b2:a3 ID:1,3a:39:ed:0:b2:a3 Lease:0x64a851e4}
I0706 11:29:51.341743 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | 2023/07/06 11:29:51 INFO : hyperkit: stderr: Using fd 5 for I/O notifications
I0706 11:29:51.351354 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | 2023/07/06 11:29:51 INFO : hyperkit: stderr: /Users/jenkins/minikube-integration/15452-1292/.minikube/machines/force-systemd-env-327000/boot2docker.iso: fcntl(F_PUNCHHOLE) Operation not permitted: block device will not support TRIM/DISCARD
I0706 11:29:51.352110 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | 2023/07/06 11:29:51 INFO : hyperkit: stderr: vmx_set_ctlreg: cap_field: 2 bit: 22 unspecified don't care: bit is 0
I0706 11:29:51.352121 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | 2023/07/06 11:29:51 INFO : hyperkit: stderr: vmx_set_ctlreg: cap_field: 4 bit: 12 unspecified don't care: bit is 0
I0706 11:29:51.352139 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | 2023/07/06 11:29:51 INFO : hyperkit: stderr: vmx_set_ctlreg: cap_field: 4 bit: 20 unspecified don't care: bit is 0
I0706 11:29:51.352155 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | 2023/07/06 11:29:51 INFO : hyperkit: stderr: vmx_set_ctlreg: cap_field: 3 bit: 13 unspecified don't care: bit is 0
I0706 11:29:51.707975 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | 2023/07/06 11:29:51 INFO : hyperkit: stderr: rdmsr to register 0x3a on vcpu 0
I0706 11:29:51.707991 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | 2023/07/06 11:29:51 INFO : hyperkit: stderr: rdmsr to register 0x140 on vcpu 0
I0706 11:29:51.812028 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | 2023/07/06 11:29:51 INFO : hyperkit: stderr: vmx_set_ctlreg: cap_field: 2 bit: 22 unspecified don't care: bit is 0
I0706 11:29:51.812075 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | 2023/07/06 11:29:51 INFO : hyperkit: stderr: vmx_set_ctlreg: cap_field: 4 bit: 12 unspecified don't care: bit is 0
I0706 11:29:51.812136 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | 2023/07/06 11:29:51 INFO : hyperkit: stderr: vmx_set_ctlreg: cap_field: 4 bit: 20 unspecified don't care: bit is 0
I0706 11:29:51.812165 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | 2023/07/06 11:29:51 INFO : hyperkit: stderr: vmx_set_ctlreg: cap_field: 3 bit: 13 unspecified don't care: bit is 0
I0706 11:29:51.812939 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | 2023/07/06 11:29:51 INFO : hyperkit: stderr: rdmsr to register 0x3a on vcpu 1
I0706 11:29:51.812951 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | 2023/07/06 11:29:51 INFO : hyperkit: stderr: rdmsr to register 0x140 on vcpu 1
I0706 11:29:53.337489 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | Attempt 1
I0706 11:29:53.337506 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I0706 11:29:53.337589 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | hyperkit pid from json: 5629
I0706 11:29:53.338369 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | Searching for 5a:9:9b:b:10:19 in /var/db/dhcpd_leases ...
I0706 11:29:53.338453 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | Found 18 entries in /var/db/dhcpd_leases!
I0706 11:29:53.338477 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.19 HWAddress:36:8f:10:6b:a5:26 ID:1,36:8f:10:6b:a5:26 Lease:0x64a85992}
I0706 11:29:53.338491 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.18 HWAddress:4a:fd:e0:64:8:1b ID:1,4a:fd:e0:64:8:1b Lease:0x64a85926}
I0706 11:29:53.338525 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.17 HWAddress:aa:e9:64:86:a6:77 ID:1,aa:e9:64:86:a6:77 Lease:0x64a858b9}
I0706 11:29:53.338540 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.16 HWAddress:fe:bd:e2:30:9:9c ID:1,fe:bd:e2:30:9:9c Lease:0x64a8586a}
I0706 11:29:53.338551 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.15 HWAddress:ee:89:ef:2e:88:a2 ID:1,ee:89:ef:2e:88:a2 Lease:0x64a857d7}
I0706 11:29:53.338559 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.14 HWAddress:1e:77:5e:a:5b:76 ID:1,1e:77:5e:a:5b:76 Lease:0x64a705bb}
I0706 11:29:53.338568 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.13 HWAddress:3a:6:2d:3b:99:ee ID:1,3a:6:2d:3b:99:ee Lease:0x64a857a1}
I0706 11:29:53.338578 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.12 HWAddress:2e:48:a:75:36:d9 ID:1,2e:48:a:75:36:d9 Lease:0x64a85756}
I0706 11:29:53.338586 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.11 HWAddress:a:78:ca:16:ec:b2 ID:1,a:78:ca:16:ec:b2 Lease:0x64a70474}
I0706 11:29:53.338596 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.10 HWAddress:2a:5e:c3:51:61:f1 ID:1,2a:5e:c3:51:61:f1 Lease:0x64a70445}
I0706 11:29:53.338607 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.9 HWAddress:ce:c0:c5:93:71:f ID:1,ce:c0:c5:93:71:f Lease:0x64a7041c}
I0706 11:29:53.338617 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.8 HWAddress:ca:1f:af:38:26:7 ID:1,ca:1f:af:38:26:7 Lease:0x64a8555a}
I0706 11:29:53.338626 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.7 HWAddress:56:c4:af:c0:5a:5c ID:1,56:c4:af:c0:5a:5c Lease:0x64a85513}
I0706 11:29:53.338637 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.6 HWAddress:ee:53:97:eb:4c:2d ID:1,ee:53:97:eb:4c:2d Lease:0x64a85473}
I0706 11:29:53.338646 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.5 HWAddress:ce:2e:68:4e:d8:ef ID:1,ce:2e:68:4e:d8:ef Lease:0x64a702e0}
I0706 11:29:53.338655 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.4 HWAddress:36:8d:55:3e:e9:99 ID:1,36:8d:55:3e:e9:99 Lease:0x64a8535c}
I0706 11:29:53.338664 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.3 HWAddress:ce:41:4c:ec:48:36 ID:1,ce:41:4c:ec:48:36 Lease:0x64a701d1}
I0706 11:29:53.338672 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.2 HWAddress:3a:39:ed:0:b2:a3 ID:1,3a:39:ed:0:b2:a3 Lease:0x64a851e4}
I0706 11:29:55.339991 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | Attempt 2
I0706 11:29:55.340009 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I0706 11:29:55.340078 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | hyperkit pid from json: 5629
I0706 11:29:55.340916 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | Searching for 5a:9:9b:b:10:19 in /var/db/dhcpd_leases ...
I0706 11:29:55.340974 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | Found 18 entries in /var/db/dhcpd_leases!
I0706 11:29:55.340989 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.19 HWAddress:36:8f:10:6b:a5:26 ID:1,36:8f:10:6b:a5:26 Lease:0x64a85992}
I0706 11:29:55.341000 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.18 HWAddress:4a:fd:e0:64:8:1b ID:1,4a:fd:e0:64:8:1b Lease:0x64a85926}
I0706 11:29:55.341007 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.17 HWAddress:aa:e9:64:86:a6:77 ID:1,aa:e9:64:86:a6:77 Lease:0x64a858b9}
I0706 11:29:55.341029 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.16 HWAddress:fe:bd:e2:30:9:9c ID:1,fe:bd:e2:30:9:9c Lease:0x64a8586a}
I0706 11:29:55.341043 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.15 HWAddress:ee:89:ef:2e:88:a2 ID:1,ee:89:ef:2e:88:a2 Lease:0x64a857d7}
I0706 11:29:55.341109 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.14 HWAddress:1e:77:5e:a:5b:76 ID:1,1e:77:5e:a:5b:76 Lease:0x64a705bb}
I0706 11:29:55.341131 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.13 HWAddress:3a:6:2d:3b:99:ee ID:1,3a:6:2d:3b:99:ee Lease:0x64a857a1}
I0706 11:29:55.341142 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.12 HWAddress:2e:48:a:75:36:d9 ID:1,2e:48:a:75:36:d9 Lease:0x64a85756}
I0706 11:29:55.341152 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.11 HWAddress:a:78:ca:16:ec:b2 ID:1,a:78:ca:16:ec:b2 Lease:0x64a70474}
I0706 11:29:55.341161 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.10 HWAddress:2a:5e:c3:51:61:f1 ID:1,2a:5e:c3:51:61:f1 Lease:0x64a70445}
I0706 11:29:55.341170 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.9 HWAddress:ce:c0:c5:93:71:f ID:1,ce:c0:c5:93:71:f Lease:0x64a7041c}
I0706 11:29:55.341179 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.8 HWAddress:ca:1f:af:38:26:7 ID:1,ca:1f:af:38:26:7 Lease:0x64a8555a}
I0706 11:29:55.341188 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.7 HWAddress:56:c4:af:c0:5a:5c ID:1,56:c4:af:c0:5a:5c Lease:0x64a85513}
I0706 11:29:55.341202 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.6 HWAddress:ee:53:97:eb:4c:2d ID:1,ee:53:97:eb:4c:2d Lease:0x64a85473}
I0706 11:29:55.341210 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.5 HWAddress:ce:2e:68:4e:d8:ef ID:1,ce:2e:68:4e:d8:ef Lease:0x64a702e0}
I0706 11:29:55.341217 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.4 HWAddress:36:8d:55:3e:e9:99 ID:1,36:8d:55:3e:e9:99 Lease:0x64a8535c}
I0706 11:29:55.341229 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.3 HWAddress:ce:41:4c:ec:48:36 ID:1,ce:41:4c:ec:48:36 Lease:0x64a701d1}
I0706 11:29:55.341239 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.2 HWAddress:3a:39:ed:0:b2:a3 ID:1,3a:39:ed:0:b2:a3 Lease:0x64a851e4}
I0706 11:29:56.881690 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | 2023/07/06 11:29:56 INFO : hyperkit: stderr: rdmsr to register 0x64d on vcpu 1
I0706 11:29:56.881776 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | 2023/07/06 11:29:56 INFO : hyperkit: stderr: rdmsr to register 0x64e on vcpu 1
I0706 11:29:56.881791 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | 2023/07/06 11:29:56 INFO : hyperkit: stderr: rdmsr to register 0x34 on vcpu 1
I0706 11:29:57.341733 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | Attempt 3
I0706 11:29:57.341749 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I0706 11:29:57.341793 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | hyperkit pid from json: 5629
I0706 11:29:57.342611 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | Searching for 5a:9:9b:b:10:19 in /var/db/dhcpd_leases ...
I0706 11:29:57.342705 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | Found 18 entries in /var/db/dhcpd_leases!
I0706 11:29:57.342727 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.19 HWAddress:36:8f:10:6b:a5:26 ID:1,36:8f:10:6b:a5:26 Lease:0x64a85992}
I0706 11:29:57.342753 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.18 HWAddress:4a:fd:e0:64:8:1b ID:1,4a:fd:e0:64:8:1b Lease:0x64a85926}
I0706 11:29:57.342773 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.17 HWAddress:aa:e9:64:86:a6:77 ID:1,aa:e9:64:86:a6:77 Lease:0x64a858b9}
I0706 11:29:57.342797 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.16 HWAddress:fe:bd:e2:30:9:9c ID:1,fe:bd:e2:30:9:9c Lease:0x64a8586a}
I0706 11:29:57.342817 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.15 HWAddress:ee:89:ef:2e:88:a2 ID:1,ee:89:ef:2e:88:a2 Lease:0x64a857d7}
I0706 11:29:57.342838 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.14 HWAddress:1e:77:5e:a:5b:76 ID:1,1e:77:5e:a:5b:76 Lease:0x64a705bb}
I0706 11:29:57.342864 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.13 HWAddress:3a:6:2d:3b:99:ee ID:1,3a:6:2d:3b:99:ee Lease:0x64a857a1}
I0706 11:29:57.342881 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.12 HWAddress:2e:48:a:75:36:d9 ID:1,2e:48:a:75:36:d9 Lease:0x64a85756}
I0706 11:29:57.342901 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.11 HWAddress:a:78:ca:16:ec:b2 ID:1,a:78:ca:16:ec:b2 Lease:0x64a70474}
I0706 11:29:57.342934 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.10 HWAddress:2a:5e:c3:51:61:f1 ID:1,2a:5e:c3:51:61:f1 Lease:0x64a70445}
I0706 11:29:57.342953 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.9 HWAddress:ce:c0:c5:93:71:f ID:1,ce:c0:c5:93:71:f Lease:0x64a7041c}
I0706 11:29:57.342967 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.8 HWAddress:ca:1f:af:38:26:7 ID:1,ca:1f:af:38:26:7 Lease:0x64a8555a}
I0706 11:29:57.342980 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.7 HWAddress:56:c4:af:c0:5a:5c ID:1,56:c4:af:c0:5a:5c Lease:0x64a85513}
I0706 11:29:57.342993 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.6 HWAddress:ee:53:97:eb:4c:2d ID:1,ee:53:97:eb:4c:2d Lease:0x64a85473}
I0706 11:29:57.343009 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.5 HWAddress:ce:2e:68:4e:d8:ef ID:1,ce:2e:68:4e:d8:ef Lease:0x64a702e0}
I0706 11:29:57.343019 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.4 HWAddress:36:8d:55:3e:e9:99 ID:1,36:8d:55:3e:e9:99 Lease:0x64a8535c}
I0706 11:29:57.343027 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.3 HWAddress:ce:41:4c:ec:48:36 ID:1,ce:41:4c:ec:48:36 Lease:0x64a701d1}
I0706 11:29:57.343034 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.2 HWAddress:3a:39:ed:0:b2:a3 ID:1,3a:39:ed:0:b2:a3 Lease:0x64a851e4}
I0706 11:29:59.343892 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | Attempt 4
I0706 11:29:59.343919 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I0706 11:29:59.343965 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | hyperkit pid from json: 5629
I0706 11:29:59.344757 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | Searching for 5a:9:9b:b:10:19 in /var/db/dhcpd_leases ...
I0706 11:29:59.344816 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | Found 18 entries in /var/db/dhcpd_leases!
I0706 11:29:59.344830 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.19 HWAddress:36:8f:10:6b:a5:26 ID:1,36:8f:10:6b:a5:26 Lease:0x64a85992}
I0706 11:29:59.344848 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.18 HWAddress:4a:fd:e0:64:8:1b ID:1,4a:fd:e0:64:8:1b Lease:0x64a85926}
I0706 11:29:59.344858 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.17 HWAddress:aa:e9:64:86:a6:77 ID:1,aa:e9:64:86:a6:77 Lease:0x64a858b9}
I0706 11:29:59.344868 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.16 HWAddress:fe:bd:e2:30:9:9c ID:1,fe:bd:e2:30:9:9c Lease:0x64a8586a}
I0706 11:29:59.344878 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.15 HWAddress:ee:89:ef:2e:88:a2 ID:1,ee:89:ef:2e:88:a2 Lease:0x64a857d7}
I0706 11:29:59.344887 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.14 HWAddress:1e:77:5e:a:5b:76 ID:1,1e:77:5e:a:5b:76 Lease:0x64a705bb}
I0706 11:29:59.344897 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.13 HWAddress:3a:6:2d:3b:99:ee ID:1,3a:6:2d:3b:99:ee Lease:0x64a857a1}
I0706 11:29:59.344915 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.12 HWAddress:2e:48:a:75:36:d9 ID:1,2e:48:a:75:36:d9 Lease:0x64a85756}
I0706 11:29:59.344926 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.11 HWAddress:a:78:ca:16:ec:b2 ID:1,a:78:ca:16:ec:b2 Lease:0x64a70474}
I0706 11:29:59.344945 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.10 HWAddress:2a:5e:c3:51:61:f1 ID:1,2a:5e:c3:51:61:f1 Lease:0x64a70445}
I0706 11:29:59.344957 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.9 HWAddress:ce:c0:c5:93:71:f ID:1,ce:c0:c5:93:71:f Lease:0x64a7041c}
I0706 11:29:59.344967 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.8 HWAddress:ca:1f:af:38:26:7 ID:1,ca:1f:af:38:26:7 Lease:0x64a8555a}
I0706 11:29:59.344978 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.7 HWAddress:56:c4:af:c0:5a:5c ID:1,56:c4:af:c0:5a:5c Lease:0x64a85513}
I0706 11:29:59.344986 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.6 HWAddress:ee:53:97:eb:4c:2d ID:1,ee:53:97:eb:4c:2d Lease:0x64a85473}
I0706 11:29:59.344995 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.5 HWAddress:ce:2e:68:4e:d8:ef ID:1,ce:2e:68:4e:d8:ef Lease:0x64a702e0}
I0706 11:29:59.345011 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.4 HWAddress:36:8d:55:3e:e9:99 ID:1,36:8d:55:3e:e9:99 Lease:0x64a8535c}
I0706 11:29:59.345024 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.3 HWAddress:ce:41:4c:ec:48:36 ID:1,ce:41:4c:ec:48:36 Lease:0x64a701d1}
I0706 11:29:59.345035 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.2 HWAddress:3a:39:ed:0:b2:a3 ID:1,3a:39:ed:0:b2:a3 Lease:0x64a851e4}
I0706 11:30:01.345550 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | Attempt 5
I0706 11:30:01.345566 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I0706 11:30:01.345641 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | hyperkit pid from json: 5629
I0706 11:30:01.346393 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | Searching for 5a:9:9b:b:10:19 in /var/db/dhcpd_leases ...
I0706 11:30:01.346451 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | Found 19 entries in /var/db/dhcpd_leases!
I0706 11:30:01.346463 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.20 HWAddress:5a:9:9b:b:10:19 ID:1,5a:9:9b:b:10:19 Lease:0x64a859a7}
I0706 11:30:01.346476 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | Found match: 5a:9:9b:b:10:19
I0706 11:30:01.346484 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | IP: 192.168.64.20
I0706 11:30:01.346522 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetConfigRaw
I0706 11:30:01.347024 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .DriverName
I0706 11:30:01.347113 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .DriverName
I0706 11:30:01.347199 5620 main.go:141] libmachine: Waiting for machine to be running, this may take a few minutes...
I0706 11:30:01.347208 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetState
I0706 11:30:01.347290 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I0706 11:30:01.347337 5620 main.go:141] libmachine: (force-systemd-env-327000) DBG | hyperkit pid from json: 5629
I0706 11:30:01.348053 5620 main.go:141] libmachine: Detecting operating system of created instance...
I0706 11:30:01.348065 5620 main.go:141] libmachine: Waiting for SSH to be available...
I0706 11:30:01.348071 5620 main.go:141] libmachine: Getting to WaitForSSH function...
I0706 11:30:01.348076 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHHostname
I0706 11:30:01.348153 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHPort
I0706 11:30:01.348232 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHKeyPath
I0706 11:30:01.348309 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHKeyPath
I0706 11:30:01.348403 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHUsername
I0706 11:30:01.348536 5620 main.go:141] libmachine: Using SSH client type: native
I0706 11:30:01.348891 5620 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x140d2c0] 0x1410360 <nil> [] 0s} 192.168.64.20 22 <nil> <nil>}
I0706 11:30:01.348899 5620 main.go:141] libmachine: About to run SSH command:
exit 0
I0706 11:30:01.404417 5620 main.go:141] libmachine: SSH cmd err, output: <nil>:
I0706 11:30:01.404432 5620 main.go:141] libmachine: Detecting the provisioner...
I0706 11:30:01.404439 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHHostname
I0706 11:30:01.404574 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHPort
I0706 11:30:01.404680 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHKeyPath
I0706 11:30:01.404771 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHKeyPath
I0706 11:30:01.404860 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHUsername
I0706 11:30:01.405001 5620 main.go:141] libmachine: Using SSH client type: native
I0706 11:30:01.405304 5620 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x140d2c0] 0x1410360 <nil> [] 0s} 192.168.64.20 22 <nil> <nil>}
I0706 11:30:01.405312 5620 main.go:141] libmachine: About to run SSH command:
cat /etc/os-release
I0706 11:30:01.461432 5620 main.go:141] libmachine: SSH cmd err, output: <nil>: NAME=Buildroot
VERSION=2021.02.12-1-g6f2898e-dirty
ID=buildroot
VERSION_ID=2021.02.12
PRETTY_NAME="Buildroot 2021.02.12"
I0706 11:30:01.461484 5620 main.go:141] libmachine: found compatible host: buildroot
I0706 11:30:01.461491 5620 main.go:141] libmachine: Provisioning with buildroot...
I0706 11:30:01.461498 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetMachineName
I0706 11:30:01.461636 5620 buildroot.go:166] provisioning hostname "force-systemd-env-327000"
I0706 11:30:01.461647 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetMachineName
I0706 11:30:01.461746 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHHostname
I0706 11:30:01.461828 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHPort
I0706 11:30:01.461915 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHKeyPath
I0706 11:30:01.462001 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHKeyPath
I0706 11:30:01.462077 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHUsername
I0706 11:30:01.462215 5620 main.go:141] libmachine: Using SSH client type: native
I0706 11:30:01.462521 5620 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x140d2c0] 0x1410360 <nil> [] 0s} 192.168.64.20 22 <nil> <nil>}
I0706 11:30:01.462531 5620 main.go:141] libmachine: About to run SSH command:
sudo hostname force-systemd-env-327000 && echo "force-systemd-env-327000" | sudo tee /etc/hostname
I0706 11:30:01.529057 5620 main.go:141] libmachine: SSH cmd err, output: <nil>: force-systemd-env-327000
I0706 11:30:01.529077 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHHostname
I0706 11:30:01.529232 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHPort
I0706 11:30:01.529346 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHKeyPath
I0706 11:30:01.529424 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHKeyPath
I0706 11:30:01.529502 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHUsername
I0706 11:30:01.529632 5620 main.go:141] libmachine: Using SSH client type: native
I0706 11:30:01.529943 5620 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x140d2c0] 0x1410360 <nil> [] 0s} 192.168.64.20 22 <nil> <nil>}
I0706 11:30:01.529955 5620 main.go:141] libmachine: About to run SSH command:
if ! grep -xq '.*\sforce-systemd-env-327000' /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-327000/g' /etc/hosts;
else
echo '127.0.1.1 force-systemd-env-327000' | sudo tee -a /etc/hosts;
fi
fi
I0706 11:30:01.591985 5620 main.go:141] libmachine: SSH cmd err, output: <nil>:
I0706 11:30:01.592004 5620 buildroot.go:172] set auth options {CertDir:/Users/jenkins/minikube-integration/15452-1292/.minikube CaCertPath:/Users/jenkins/minikube-integration/15452-1292/.minikube/certs/ca.pem CaPrivateKeyPath:/Users/jenkins/minikube-integration/15452-1292/.minikube/certs/ca-key.pem CaCertRemotePath:/etc/docker/ca.pem ServerCertPath:/Users/jenkins/minikube-integration/15452-1292/.minikube/machines/server.pem ServerKeyPath:/Users/jenkins/minikube-integration/15452-1292/.minikube/machines/server-key.pem ClientKeyPath:/Users/jenkins/minikube-integration/15452-1292/.minikube/certs/key.pem ServerCertRemotePath:/etc/docker/server.pem ServerKeyRemotePath:/etc/docker/server-key.pem ClientCertPath:/Users/jenkins/minikube-integration/15452-1292/.minikube/certs/cert.pem ServerCertSANs:[] StorePath:/Users/jenkins/minikube-integration/15452-1292/.minikube}
I0706 11:30:01.592021 5620 buildroot.go:174] setting up certificates
I0706 11:30:01.592034 5620 provision.go:83] configureAuth start
I0706 11:30:01.592042 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetMachineName
I0706 11:30:01.592172 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetIP
I0706 11:30:01.592256 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHHostname
I0706 11:30:01.592338 5620 provision.go:138] copyHostCerts
I0706 11:30:01.592379 5620 vm_assets.go:163] NewFileAsset: /Users/jenkins/minikube-integration/15452-1292/.minikube/certs/ca.pem -> /Users/jenkins/minikube-integration/15452-1292/.minikube/ca.pem
I0706 11:30:01.592438 5620 exec_runner.go:144] found /Users/jenkins/minikube-integration/15452-1292/.minikube/ca.pem, removing ...
I0706 11:30:01.592448 5620 exec_runner.go:203] rm: /Users/jenkins/minikube-integration/15452-1292/.minikube/ca.pem
I0706 11:30:01.592565 5620 exec_runner.go:151] cp: /Users/jenkins/minikube-integration/15452-1292/.minikube/certs/ca.pem --> /Users/jenkins/minikube-integration/15452-1292/.minikube/ca.pem (1082 bytes)
I0706 11:30:01.592751 5620 vm_assets.go:163] NewFileAsset: /Users/jenkins/minikube-integration/15452-1292/.minikube/certs/cert.pem -> /Users/jenkins/minikube-integration/15452-1292/.minikube/cert.pem
I0706 11:30:01.592787 5620 exec_runner.go:144] found /Users/jenkins/minikube-integration/15452-1292/.minikube/cert.pem, removing ...
I0706 11:30:01.592791 5620 exec_runner.go:203] rm: /Users/jenkins/minikube-integration/15452-1292/.minikube/cert.pem
I0706 11:30:01.592860 5620 exec_runner.go:151] cp: /Users/jenkins/minikube-integration/15452-1292/.minikube/certs/cert.pem --> /Users/jenkins/minikube-integration/15452-1292/.minikube/cert.pem (1123 bytes)
I0706 11:30:01.593006 5620 vm_assets.go:163] NewFileAsset: /Users/jenkins/minikube-integration/15452-1292/.minikube/certs/key.pem -> /Users/jenkins/minikube-integration/15452-1292/.minikube/key.pem
I0706 11:30:01.593041 5620 exec_runner.go:144] found /Users/jenkins/minikube-integration/15452-1292/.minikube/key.pem, removing ...
I0706 11:30:01.593045 5620 exec_runner.go:203] rm: /Users/jenkins/minikube-integration/15452-1292/.minikube/key.pem
I0706 11:30:01.593112 5620 exec_runner.go:151] cp: /Users/jenkins/minikube-integration/15452-1292/.minikube/certs/key.pem --> /Users/jenkins/minikube-integration/15452-1292/.minikube/key.pem (1679 bytes)
I0706 11:30:01.593239 5620 provision.go:112] generating server cert: /Users/jenkins/minikube-integration/15452-1292/.minikube/machines/server.pem ca-key=/Users/jenkins/minikube-integration/15452-1292/.minikube/certs/ca.pem private-key=/Users/jenkins/minikube-integration/15452-1292/.minikube/certs/ca-key.pem org=jenkins.force-systemd-env-327000 san=[192.168.64.20 192.168.64.20 localhost 127.0.0.1 minikube force-systemd-env-327000]
I0706 11:30:01.741549 5620 provision.go:172] copyRemoteCerts
I0706 11:30:01.741637 5620 ssh_runner.go:195] Run: sudo mkdir -p /etc/docker /etc/docker /etc/docker
I0706 11:30:01.741659 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHHostname
I0706 11:30:01.741849 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHPort
I0706 11:30:01.741967 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHKeyPath
I0706 11:30:01.742077 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHUsername
I0706 11:30:01.742197 5620 sshutil.go:53] new ssh client: &{IP:192.168.64.20 Port:22 SSHKeyPath:/Users/jenkins/minikube-integration/15452-1292/.minikube/machines/force-systemd-env-327000/id_rsa Username:docker}
I0706 11:30:01.777280 5620 vm_assets.go:163] NewFileAsset: /Users/jenkins/minikube-integration/15452-1292/.minikube/certs/ca.pem -> /etc/docker/ca.pem
I0706 11:30:01.777354 5620 ssh_runner.go:362] scp /Users/jenkins/minikube-integration/15452-1292/.minikube/certs/ca.pem --> /etc/docker/ca.pem (1082 bytes)
I0706 11:30:01.794174 5620 vm_assets.go:163] NewFileAsset: /Users/jenkins/minikube-integration/15452-1292/.minikube/machines/server.pem -> /etc/docker/server.pem
I0706 11:30:01.794245 5620 ssh_runner.go:362] scp /Users/jenkins/minikube-integration/15452-1292/.minikube/machines/server.pem --> /etc/docker/server.pem (1245 bytes)
I0706 11:30:01.810275 5620 vm_assets.go:163] NewFileAsset: /Users/jenkins/minikube-integration/15452-1292/.minikube/machines/server-key.pem -> /etc/docker/server-key.pem
I0706 11:30:01.810332 5620 ssh_runner.go:362] scp /Users/jenkins/minikube-integration/15452-1292/.minikube/machines/server-key.pem --> /etc/docker/server-key.pem (1675 bytes)
I0706 11:30:01.826958 5620 provision.go:86] duration metric: configureAuth took 234.91768ms
I0706 11:30:01.826972 5620 buildroot.go:189] setting minikube options for container-runtime
I0706 11:30:01.827104 5620 config.go:182] Loaded profile config "force-systemd-env-327000": Driver=hyperkit, ContainerRuntime=docker, KubernetesVersion=v1.27.3
I0706 11:30:01.827118 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .DriverName
I0706 11:30:01.827259 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHHostname
I0706 11:30:01.827400 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHPort
I0706 11:30:01.827503 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHKeyPath
I0706 11:30:01.827592 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHKeyPath
I0706 11:30:01.827677 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHUsername
I0706 11:30:01.827790 5620 main.go:141] libmachine: Using SSH client type: native
I0706 11:30:01.828084 5620 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x140d2c0] 0x1410360 <nil> [] 0s} 192.168.64.20 22 <nil> <nil>}
I0706 11:30:01.828093 5620 main.go:141] libmachine: About to run SSH command:
df --output=fstype / | tail -n 1
I0706 11:30:01.885512 5620 main.go:141] libmachine: SSH cmd err, output: <nil>: tmpfs
I0706 11:30:01.885530 5620 buildroot.go:70] root file system type: tmpfs
I0706 11:30:01.885606 5620 provision.go:309] Updating docker unit: /lib/systemd/system/docker.service ...
I0706 11:30:01.885618 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHHostname
I0706 11:30:01.885765 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHPort
I0706 11:30:01.885859 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHKeyPath
I0706 11:30:01.885946 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHKeyPath
I0706 11:30:01.886027 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHUsername
I0706 11:30:01.886154 5620 main.go:141] libmachine: Using SSH client type: native
I0706 11:30:01.886462 5620 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x140d2c0] 0x1410360 <nil> [] 0s} 192.168.64.20 22 <nil> <nil>}
I0706 11:30:01.886508 5620 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
I0706 11:30:01.950663 5620 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
I0706 11:30:01.950686 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHHostname
I0706 11:30:01.950830 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHPort
I0706 11:30:01.950939 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHKeyPath
I0706 11:30:01.951031 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHKeyPath
I0706 11:30:01.951125 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHUsername
I0706 11:30:01.951252 5620 main.go:141] libmachine: Using SSH client type: native
I0706 11:30:01.951564 5620 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x140d2c0] 0x1410360 <nil> [] 0s} 192.168.64.20 22 <nil> <nil>}
I0706 11:30:01.951579 5620 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; }
I0706 11:30:02.463697 5620 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.
I0706 11:30:02.463715 5620 main.go:141] libmachine: Checking connection to Docker...
I0706 11:30:02.463725 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetURL
I0706 11:30:02.463863 5620 main.go:141] libmachine: Docker is up and running!
I0706 11:30:02.463872 5620 main.go:141] libmachine: Reticulating splines...
I0706 11:30:02.463878 5620 client.go:171] LocalClient.Create took 11.84316333s
I0706 11:30:02.463892 5620 start.go:167] duration metric: libmachine.API.Create for "force-systemd-env-327000" took 11.843203058s
I0706 11:30:02.463904 5620 start.go:300] post-start starting for "force-systemd-env-327000" (driver="hyperkit")
I0706 11:30:02.463915 5620 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]
I0706 11:30:02.463930 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .DriverName
I0706 11:30:02.464089 5620 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
I0706 11:30:02.464104 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHHostname
I0706 11:30:02.464198 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHPort
I0706 11:30:02.464302 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHKeyPath
I0706 11:30:02.464392 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHUsername
I0706 11:30:02.464476 5620 sshutil.go:53] new ssh client: &{IP:192.168.64.20 Port:22 SSHKeyPath:/Users/jenkins/minikube-integration/15452-1292/.minikube/machines/force-systemd-env-327000/id_rsa Username:docker}
I0706 11:30:02.498378 5620 ssh_runner.go:195] Run: cat /etc/os-release
I0706 11:30:02.501153 5620 info.go:137] Remote host: Buildroot 2021.02.12
I0706 11:30:02.501165 5620 filesync.go:126] Scanning /Users/jenkins/minikube-integration/15452-1292/.minikube/addons for local assets ...
I0706 11:30:02.501248 5620 filesync.go:126] Scanning /Users/jenkins/minikube-integration/15452-1292/.minikube/files for local assets ...
I0706 11:30:02.501401 5620 filesync.go:149] local asset: /Users/jenkins/minikube-integration/15452-1292/.minikube/files/etc/ssl/certs/25342.pem -> 25342.pem in /etc/ssl/certs
I0706 11:30:02.501407 5620 vm_assets.go:163] NewFileAsset: /Users/jenkins/minikube-integration/15452-1292/.minikube/files/etc/ssl/certs/25342.pem -> /etc/ssl/certs/25342.pem
I0706 11:30:02.501586 5620 ssh_runner.go:195] Run: sudo mkdir -p /etc/ssl/certs
I0706 11:30:02.507453 5620 ssh_runner.go:362] scp /Users/jenkins/minikube-integration/15452-1292/.minikube/files/etc/ssl/certs/25342.pem --> /etc/ssl/certs/25342.pem (1708 bytes)
I0706 11:30:02.524451 5620 start.go:303] post-start completed in 60.538902ms
I0706 11:30:02.524486 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetConfigRaw
I0706 11:30:02.525057 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetIP
I0706 11:30:02.525195 5620 profile.go:148] Saving config to /Users/jenkins/minikube-integration/15452-1292/.minikube/profiles/force-systemd-env-327000/config.json ...
I0706 11:30:02.525461 5620 start.go:128] duration metric: createHost completed in 11.934410029s
I0706 11:30:02.525478 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHHostname
I0706 11:30:02.525571 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHPort
I0706 11:30:02.525649 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHKeyPath
I0706 11:30:02.525728 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHKeyPath
I0706 11:30:02.525798 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHUsername
I0706 11:30:02.525899 5620 main.go:141] libmachine: Using SSH client type: native
I0706 11:30:02.526195 5620 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x140d2c0] 0x1410360 <nil> [] 0s} 192.168.64.20 22 <nil> <nil>}
I0706 11:30:02.526203 5620 main.go:141] libmachine: About to run SSH command:
date +%s.%N
I0706 11:30:02.583324 5620 main.go:141] libmachine: SSH cmd err, output: <nil>: 1688668201.849088053
I0706 11:30:02.583342 5620 fix.go:206] guest clock: 1688668201.849088053
I0706 11:30:02.583347 5620 fix.go:219] Guest: 2023-07-06 11:30:01.849088053 -0700 PDT Remote: 2023-07-06 11:30:02.525471 -0700 PDT m=+12.430327724 (delta=-676.382947ms)
I0706 11:30:02.583365 5620 fix.go:190] guest clock delta is within tolerance: -676.382947ms
I0706 11:30:02.583369 5620 start.go:83] releasing machines lock for "force-systemd-env-327000", held for 11.992439479s
I0706 11:30:02.583386 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .DriverName
I0706 11:30:02.583515 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetIP
I0706 11:30:02.583616 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .DriverName
I0706 11:30:02.583909 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .DriverName
I0706 11:30:02.584009 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .DriverName
I0706 11:30:02.584097 5620 ssh_runner.go:195] Run: curl -sS -m 2 https://registry.k8s.io/
I0706 11:30:02.584134 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHHostname
I0706 11:30:02.584142 5620 ssh_runner.go:195] Run: cat /version.json
I0706 11:30:02.584155 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHHostname
I0706 11:30:02.584241 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHPort
I0706 11:30:02.584279 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHPort
I0706 11:30:02.584360 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHKeyPath
I0706 11:30:02.584373 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHKeyPath
I0706 11:30:02.584454 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHUsername
I0706 11:30:02.584470 5620 main.go:141] libmachine: (force-systemd-env-327000) Calling .GetSSHUsername
I0706 11:30:02.584543 5620 sshutil.go:53] new ssh client: &{IP:192.168.64.20 Port:22 SSHKeyPath:/Users/jenkins/minikube-integration/15452-1292/.minikube/machines/force-systemd-env-327000/id_rsa Username:docker}
I0706 11:30:02.584575 5620 sshutil.go:53] new ssh client: &{IP:192.168.64.20 Port:22 SSHKeyPath:/Users/jenkins/minikube-integration/15452-1292/.minikube/machines/force-systemd-env-327000/id_rsa Username:docker}
I0706 11:30:02.660718 5620 ssh_runner.go:195] Run: systemctl --version
I0706 11:30:02.665028 5620 ssh_runner.go:195] Run: sh -c "stat /etc/cni/net.d/*loopback.conf*"
W0706 11:30:02.668506 5620 cni.go:215] loopback cni configuration skipped: "/etc/cni/net.d/*loopback.conf*" not found
I0706 11:30:02.668547 5620 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" ;
I0706 11:30:02.679306 5620 cni.go:268] disabled [/etc/cni/net.d/87-podman-bridge.conflist] bridge cni config(s)
I0706 11:30:02.679320 5620 start.go:466] detecting cgroup driver to use...
I0706 11:30:02.679329 5620 start.go:470] using "systemd" cgroup driver as enforced via flags
I0706 11:30:02.679415 5620 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"
I0706 11:30:02.691362 5620 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"
I0706 11:30:02.698651 5620 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"
I0706 11:30:02.706116 5620 containerd.go:145] configuring containerd to use "systemd" as cgroup driver...
I0706 11:30:02.706184 5620 ssh_runner.go:195] Run: sh -c "sudo sed -i -r 's|^( *)SystemdCgroup = .*$|\1SystemdCgroup = true|g' /etc/containerd/config.toml"
I0706 11:30:02.713710 5620 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"
I0706 11:30:02.720905 5620 ssh_runner.go:195] Run: sh -c "sudo sed -i '/systemd_cgroup/d' /etc/containerd/config.toml"
I0706 11:30:02.727958 5620 ssh_runner.go:195] Run: sh -c "sudo sed -i 's|"io.containerd.runc.v1"|"io.containerd.runc.v2"|g' /etc/containerd/config.toml"
I0706 11:30:02.734948 5620 ssh_runner.go:195] Run: sh -c "sudo rm -rf /etc/cni/net.mk"
I0706 11:30:02.742208 5620 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"
I0706 11:30:02.749110 5620 ssh_runner.go:195] Run: sudo sysctl net.bridge.bridge-nf-call-iptables
I0706 11:30:02.755278 5620 ssh_runner.go:195] Run: sudo sh -c "echo 1 > /proc/sys/net/ipv4/ip_forward"
I0706 11:30:02.761566 5620 ssh_runner.go:195] Run: sudo systemctl daemon-reload
I0706 11:30:02.843991 5620 ssh_runner.go:195] Run: sudo systemctl restart containerd
I0706 11:30:02.854941 5620 start.go:466] detecting cgroup driver to use...
I0706 11:30:02.854959 5620 start.go:470] using "systemd" cgroup driver as enforced via flags
I0706 11:30:02.855022 5620 ssh_runner.go:195] Run: sudo systemctl cat docker.service
I0706 11:30:02.866130 5620 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service containerd
I0706 11:30:02.876405 5620 ssh_runner.go:195] Run: sudo systemctl stop -f containerd
I0706 11:30:02.890257 5620 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service containerd
I0706 11:30:02.898871 5620 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service crio
I0706 11:30:02.906965 5620 ssh_runner.go:195] Run: sudo systemctl stop -f crio
I0706 11:30:02.928490 5620 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service crio
I0706 11:30:02.938050 5620 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"
I0706 11:30:02.950736 5620 ssh_runner.go:195] Run: which cri-dockerd
I0706 11:30:02.953253 5620 ssh_runner.go:195] Run: sudo mkdir -p /etc/systemd/system/cri-docker.service.d
I0706 11:30:02.958991 5620 ssh_runner.go:362] scp memory --> /etc/systemd/system/cri-docker.service.d/10-cni.conf (189 bytes)
I0706 11:30:02.970130 5620 ssh_runner.go:195] Run: sudo systemctl unmask docker.service
I0706 11:30:03.053484 5620 ssh_runner.go:195] Run: sudo systemctl enable docker.socket
I0706 11:30:03.141990 5620 docker.go:535] configuring docker to use "systemd" as cgroup driver...
I0706 11:30:03.142007 5620 ssh_runner.go:362] scp memory --> /etc/docker/daemon.json (143 bytes)
I0706 11:30:03.157455 5620 ssh_runner.go:195] Run: sudo systemctl daemon-reload
I0706 11:30:03.257249 5620 ssh_runner.go:195] Run: sudo systemctl restart docker
I0706 11:30:04.518243 5620 ssh_runner.go:235] Completed: sudo systemctl restart docker: (1.261013026s)
I0706 11:30:04.518318 5620 ssh_runner.go:195] Run: sudo systemctl enable cri-docker.socket
I0706 11:30:04.616021 5620 ssh_runner.go:195] Run: sudo systemctl unmask cri-docker.socket
I0706 11:30:04.708347 5620 ssh_runner.go:195] Run: sudo systemctl enable cri-docker.socket
I0706 11:30:04.798243 5620 ssh_runner.go:195] Run: sudo systemctl daemon-reload
I0706 11:30:04.882698 5620 ssh_runner.go:195] Run: sudo systemctl restart cri-docker.socket
I0706 11:30:04.918270 5620 out.go:177]
W0706 11:30:04.939286 5620 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.
W0706 11:30:04.939309 5620 out.go:239] *
*
W0706 11:30:04.940574 5620 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. │
│ │
╰─────────────────────────────────────────────────────────────────────────────────────────────╯
I0706 11:30:05.004369 5620 out.go:177]
** /stderr **
docker_test.go:157: failed to start minikube with args: "out/minikube-darwin-amd64 start -p force-systemd-env-327000 --memory=2048 --alsologtostderr -v=5 --driver=hyperkit " : exit status 90
docker_test.go:110: (dbg) Run: out/minikube-darwin-amd64 -p force-systemd-env-327000 ssh "docker info --format {{.CgroupDriver}}"
docker_test.go:166: *** TestForceSystemdEnv FAILED at 2023-07-06 11:30:05.194008 -0700 PDT m=+2024.705143865
helpers_test.go:222: -----------------------post-mortem--------------------------------
helpers_test.go:239: (dbg) Run: out/minikube-darwin-amd64 status --format={{.Host}} -p force-systemd-env-327000 -n force-systemd-env-327000
helpers_test.go:239: (dbg) Non-zero exit: out/minikube-darwin-amd64 status --format={{.Host}} -p force-systemd-env-327000 -n force-systemd-env-327000: exit status 6 (125.50988ms)
-- stdout --
Running
WARNING: Your kubectl is pointing to stale minikube-vm.
To fix the kubectl context, run `minikube update-context`
-- /stdout --
** stderr **
E0706 11:30:05.309530 5651 status.go:415] kubeconfig endpoint: extract IP: "force-systemd-env-327000" does not appear in /Users/jenkins/minikube-integration/15452-1292/kubeconfig
** /stderr **
helpers_test.go:239: status error: exit status 6 (may be ok)
helpers_test.go:241: "force-systemd-env-327000" 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-327000" profile ...
helpers_test.go:178: (dbg) Run: out/minikube-darwin-amd64 delete -p force-systemd-env-327000
E0706 11:30:10.222256 2534 cert_rotation.go:168] key failed with : open /Users/jenkins/minikube-integration/15452-1292/.minikube/profiles/addons-636000/client.crt: no such file or directory
helpers_test.go:178: (dbg) Done: out/minikube-darwin-amd64 delete -p force-systemd-env-327000: (5.342111578s)
--- FAIL: TestForceSystemdEnv (20.57s)