Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

HYPERKIT_CRASHED #7841

Closed
yveshield opened this issue Apr 22, 2020 · 16 comments
Closed

HYPERKIT_CRASHED #7841

yveshield opened this issue Apr 22, 2020 · 16 comments
Labels
cause/firewall-or-proxy When firewalls or proxies seem to be interfering co/hyperkit Hyperkit related issues kind/support Categorizes issue or PR as a support question. needs-solution-message Issues where where offering a solution for an error would be helpful os/macos

Comments

@yveshield
Copy link

yveshield commented Apr 22, 2020

$ hyperkit -versio
hyperkit: v0.20190802-4-g97f091

Homepage: https://github.com/docker/hyperkit
License: BSD

$ ls -la /usr/local/bin/hyperkit
lrwxr-xr-x 1 root admin 67 Apr 22 10:20 /usr/local/bin/hyperkit -> /Applications/Docker.app/Contents/Resources/bin/com.docker.hyperkit

$ minikube delete

$ minikube start --driver=hyperkit

😄 minikube v1.9.2 on Darwin 10.15.4
✨ Using the hyperkit driver based on user configuration
👍 Starting control plane node m01 in cluster minikube
🔥 Creating hyperkit VM (CPUs=2, Memory=4000MB, Disk=20000MB) ...
🤦 StartHost failed, but will try again: creating host: create: Error creating machine: Error in driver during machine creation: hyperkit crashed! command line:
hyperkit 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=minikube
🔥 Deleting "minikube" in hyperkit ...
🔥 Creating hyperkit VM (CPUs=2, Memory=4000MB, Disk=20000MB) ...

❌ [HYPERKIT_CRASHED] Failed to start hyperkit VM. "minikube start" may fix it. creating host: create: Error creating machine: Error in driver during machine creation: hyperkit crashed! command line:
hyperkit 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=minikube


Upgrade to the latest hyperkit version

$ hyperkit -v
hyperkit: 0.20200224

$ ls -la /usr/local/bin/hyperkit
lrwxr-xr-x 1 yves admin 42 Apr 22 11:18 /usr/local/bin/hyperkit -> ../Cellar/hyperkit/0.20200224/bin/hyperkit

➔ ~ minikube delete
🔥 Deleting "minikube" in hyperkit ...
💀 Removed all traces of the "minikube" cluster.
➔ ~ minikube start --driver=hyperkit
😄 minikube v1.9.2 on Darwin 10.15.4
✨ Using the hyperkit driver based on user configuration
👍 Starting control plane node m01 in cluster minikube
🔥 Creating hyperkit VM (CPUs=2, Memory=4000MB, Disk=20000MB) ...
🤦 StartHost failed, but will try again: creating host: create: Error creating machine: Error in driver during machine creation: hyperkit crashed! command line:
hyperkit 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=minikube
🔥 Deleting "minikube" in hyperkit ...
🔥 Creating hyperkit VM (CPUs=2, Memory=4000MB, Disk=20000MB) ...

❌ [HYPERKIT_CRASHED] Failed to start hyperkit VM. "minikube start" may fix it. creating host: create: Error creating machine: Error in driver during machine creation: hyperkit crashed! command line:
hyperkit 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=minikube


choose an alternate --driver virtualbox

➜ ~ minikube delete
🔥 Removing /Users/yves/.minikube/machines/minikube ...
💀 Removed all traces of the "minikube" cluster.
➔ ~ minikube start --driver=virtualbox
😄 minikube v1.9.2 on Darwin 10.15.4
✨ Using the virtualbox driver based on user configuration
👍 Starting control plane node m01 in cluster minikube
🔥 Creating virtualbox VM (CPUs=2, Memory=4000MB, Disk=20000MB) ...
🤦 StartHost failed, but will try again: creating host: create: creating: /usr/local/bin/VBoxManage storageattach minikube --storagectl SATA --port 0 --device 0 --type dvddrive --medium /Users/yves/.minikube/machines/minikube/boot2docker.iso failed:
VBoxManage: error: Could not get the storage format of the medium '/Users/yves/.minikube/machines/minikube/boot2docker.iso' (VERR_NOT_SUPPORTED)
VBoxManage: error: Details: code VBOX_E_IPRT_ERROR (0x80bb0005), component MediumWrap, interface IMedium, callee nsISupports
VBoxManage: error: Context: "OpenMedium(Bstr(pszFilenameOrUuid).raw(), enmDevType, enmAccessMode, fForceNewUuidOnOpen, pMedium.asOutParam())" at line 191 of file VBoxManageDisk.cpp
VBoxManage: error: Invalid UUID or filename "/Users/yves/.minikube/machines/minikube/boot2docker.iso"

🔥 Deleting "minikube" in virtualbox ...
🔥 Creating virtualbox VM (CPUs=2, Memory=4000MB, Disk=20000MB) ...

💣 Failed to start virtualbox VM. "minikube start" may fix it.: creating host: create: creating: /usr/local/bin/VBoxManage storageattach minikube --storagectl SATA --port 0 --device 0 --type dvddrive --medium /Users/yves/.minikube/machines/minikube/boot2docker.iso failed:
VBoxManage: error: Could not get the storage format of the medium '/Users/yves/.minikube/machines/minikube/boot2docker.iso' (VERR_NOT_SUPPORTED)
VBoxManage: error: Details: code VBOX_E_IPRT_ERROR (0x80bb0005), component MediumWrap, interface IMedium, callee nsISupports
VBoxManage: error: Context: "OpenMedium(Bstr(pszFilenameOrUuid).raw(), enmDevType, enmAccessMode, fForceNewUuidOnOpen, pMedium.asOutParam())" at line 191 of file VBoxManageDisk.cpp
VBoxManage: error: Invalid UUID or filename "/Users/yves/.minikube/machines/minikube/boot2docker.iso"

😿 minikube is exiting due to an error. If the above message is not useful, open an issue:
👉 https://github.com/kubernetes/minikube/issues/new/choose


choose an alternate --driver docker

➜ ~ minikube delete
🔥 Deleting "minikube" in virtualbox ...
💀 Removed all traces of the "minikube" cluster.
➔ ~ minikube start --driver=docker
😄 minikube v1.9.2 on Darwin 10.15.4
✨ Using the docker driver based on user configuration
👍 Starting control plane node m01 in cluster minikube
🚜 Pulling base image ...
E0422 11:40:23.244391 28666 cache.go:114] Error downloading kic artifacts: getting remote image: Get "https://gcr.io/v2/": dial tcp 108.177.97.82:443: i/o timeout
🔥 Creating Kubernetes in docker container with (CPUs=2) (4 available), Memory=1989MB (1989MB available) ...
🤦 StartHost failed, but will try again: creating host: create host timed out in 120.000000 seconds
🤷 docker "minikube" container is missing, will recreate.
🔥 Creating Kubernetes in docker container with (CPUs=2) (4 available), Memory=1989MB (1989MB available) ...

❌ [CREATE_TIMEOUT] Failed to start docker container. "minikube start" may fix it. recreate: creating host: create host timed out in 120.000000 seconds

@govargo govargo added kind/support Categorizes issue or PR as a support question. co/hyperkit Hyperkit related issues labels Apr 22, 2020
@govargo
Copy link
Contributor

govargo commented Apr 22, 2020

Hello. Could you try following commands?

# delete all profile
$ minikube delete --all

$ minikube start --driver hyperkit --alsologtostderr -v=1
Or
$ minikube start --driver docker --alsologtostderr -v=1

If the problem remains, could you mind sharing the output of above minikube start?

@yveshield
Copy link
Author

Hello. Could you try following commands?

# delete all profile
$ minikube delete --all

$ minikube start --driver hyperkit --alsologtostderr -v=1
Or
$ minikube start --driver docker --alsologtostderr -v=1

If the problem remains, could you mind sharing the output of above minikube start?

➜ ~ minikube delete --all
🔥 Deleting "minikube" in hyperkit ...
💀 Removed all traces of the "minikube" cluster.
🔥 Successfully deleted all profiles
➔ ~ minikube start --driver hyperkit --alsologtostderr -v=1
I0422 14:38:26.220899 67248 notify.go:125] Checking for updates...
I0422 14:38:28.312478 67248 start.go:262] hostinfo: {"hostname":"Gordon-MacBook-Pro.local","uptime":13386,"bootTime":1587524122,"procs":433,"os":"darwin","platform":"darwin","platformFamily":"","platformVersion":"10.15.4","kernelVersion":"19.4.0","virtualizationSystem":"","virtualizationRole":"","hostid":"ab0aa7ee-3d03-3c21-91ad-5719d79d7af6"}
W0422 14:38:28.312600 67248 start.go:270] gopshost.Virtualization returned error: not implemented yet
😄 minikube v1.9.2 on Darwin 10.15.4
I0422 14:38:28.335111 67248 driver.go:245] Setting default libvirt URI to qemu:///system
✨ Using the hyperkit driver based on user configuration
I0422 14:38:28.361891 67248 start.go:310] selected driver: hyperkit
I0422 14:38:28.361935 67248 start.go:656] validating driver "hyperkit" against
I0422 14:38:28.361951 67248 start.go:662] status for hyperkit: {Installed:true Healthy:true Error: Fix: Doc:}
I0422 14:38:28.362035 67248 install.go:49] acquiring lock: {Name:mk4023283b30b374c3f04c8805d539e68824c0b8 Clock:{} Delay:500ms Timeout:10m0s Cancel:}
I0422 14:38:28.362266 67248 install.go:115] Validating docker-machine-driver-hyperkit, PATH=/Users/yves/.minikube/bin:/usr/local/opt/binutils/bin:/usr/local/opt/python/libexec/bin:/usr/local/sbin:/usr/local/opt/mysql@5.7/bin:/usr/local/opt/mysql@5.7/bin:/usr/local/bin:/usr/bin:/bin:/usr/sbin:/sbin:/Applications/VMware Fusion.app/Contents/Public:/usr/local/MacGPG2/bin:/opt/X11/bin
I0422 14:38:28.392180 67248 install.go:77] stdout: /Users/yves/.minikube/bin/docker-machine-driver-hyperkit
I0422 14:38:28.392240 67248 install.go:79] /Users/yves/.minikube/bin/docker-machine-driver-hyperkit looks good
I0422 14:38:28.392338 67248 start.go:1004] Using suggested 4000MB memory alloc based on sys=16384MB, container=0MB
I0422 14:38:28.392450 67248 start.go:1210] Wait components to verify : map[apiserver:true system_pods:true]
I0422 14:38:28.392492 67248 iso.go:119] acquiring lock: {Name:mkc66493fd5a14eb3815b1fcc2805060061fd975 Clock:{} Delay:500ms Timeout:10m0s Cancel:}
👍 Starting control plane node m01 in cluster minikube
I0422 14:38:28.398595 67248 preload.go:81] Checking if preload exists for k8s version v1.18.0 and runtime docker
I0422 14:38:28.398670 67248 preload.go:97] Found local preload: /Users/yves/.minikube/cache/preloaded-tarball/preloaded-images-k8s-v2-v1.18.0-docker-overlay2-amd64.tar.lz4
I0422 14:38:28.398689 67248 cache.go:46] Caching tarball of preloaded images
I0422 14:38:28.398710 67248 preload.go:123] Found /Users/yves/.minikube/cache/preloaded-tarball/preloaded-images-k8s-v2-v1.18.0-docker-overlay2-amd64.tar.lz4 in cache, skipping download
I0422 14:38:28.398715 67248 cache.go:49] Finished downloading the preloaded tar for v1.18.0 on docker
I0422 14:38:28.399071 67248 profile.go:138] Saving config to /Users/yves/.minikube/profiles/minikube/config.json ...
I0422 14:38:28.399288 67248 lock.go:35] WriteFile acquiring /Users/yves/.minikube/profiles/minikube/config.json: {Name:mk0844afacaf7e815f18bb78d94c4d2a6f109b65 Clock:{} Delay:500ms Timeout:1m0s Cancel:}
I0422 14:38:28.399648 67248 cache.go:117] Successfully downloaded all kic artifacts
I0422 14:38:28.399679 67248 start.go:260] acquiring machines lock for minikube: {Name:mkdd7a8a1ff4814687d3c0149520cd20cd24b807 Clock:{} Delay:500ms Timeout:15m0s Cancel:}
I0422 14:38:28.399779 67248 start.go:264] acquired machines lock for "minikube" in 84.228µs
I0422 14:38:28.399818 67248 start.go:86] Provisioning new machine with config: {Name:minikube KeepContext:false EmbedCerts:false MinikubeISO:https://storage.googleapis.com/minikube/iso/minikube-v1.9.0.iso Memory:4000 CPUs:2 DiskSize:20000 Driver:hyperkit HyperkitVpnKitSock: HyperkitVSockPorts:[] DockerEnv:[] InsecureRegistry:[] RegistryMirror:[] HostOnlyCIDR:192.168.99.1/24 HypervVirtualSwitch: HypervUseExternalSwitch:false HypervExternalAdapter: KVMNetwork:default KVMQemuURI:qemu:///system KVMGPU:false KVMHidden:false DockerOpt:[] DisableDriverMounts:false NFSShare:[] NFSSharesRoot:/nfsshares UUID: NoVTXCheck:false DNSProxy:false HostDNSResolver:true HostOnlyNicType:virtio NatNicType:virtio KubernetesConfig:{KubernetesVersion:v1.18.0 ClusterName:minikube APIServerName:minikubeCA APIServerNames:[] APIServerIPs:[] DNSDomain:cluster.local ContainerRuntime:docker CRISocket: NetworkPlugin: FeatureGates: ServiceCIDR:10.96.0.0/12 ImageRepository: ExtraOptions:[] ShouldLoadCachedImages:true EnableDefaultCNI:false NodeIP: NodePort:0 NodeName:} Nodes:[{Name:m01 IP: Port:8443 KubernetesVersion:v1.18.0 ControlPlane:true Worker:true}] Addons:map[] VerifyComponents:map[apiserver:true system_pods:true]} {Name:m01 IP: Port:8443 KubernetesVersion:v1.18.0 ControlPlane:true Worker:true}
I0422 14:38:28.399884 67248 start.go:107] createHost starting for "m01" (driver="hyperkit")
🔥 Creating hyperkit VM (CPUs=2, Memory=4000MB, Disk=20000MB) ...
I0422 14:38:28.422070 67248 main.go:110] libmachine: Found binary path at /Users/yves/.minikube/bin/docker-machine-driver-hyperkit
I0422 14:38:28.422160 67248 main.go:110] libmachine: Launching plugin server for driver hyperkit
I0422 14:38:28.435047 67248 main.go:110] libmachine: Plugin server listening at address 127.0.0.1:56658
I0422 14:38:28.435524 67248 main.go:110] libmachine: () Calling .GetVersion
I0422 14:38:28.436148 67248 main.go:110] libmachine: Using API Version 1
I0422 14:38:28.436168 67248 main.go:110] libmachine: () Calling .SetConfigRaw
I0422 14:38:28.436511 67248 main.go:110] libmachine: () Calling .GetMachineName
I0422 14:38:28.436656 67248 main.go:110] libmachine: (minikube) Calling .GetMachineName
I0422 14:38:28.436765 67248 main.go:110] libmachine: (minikube) Calling .DriverName
I0422 14:38:28.436892 67248 start.go:143] libmachine.API.Create for "minikube" (driver="hyperkit")
I0422 14:38:28.436922 67248 client.go:169] LocalClient.Create starting
I0422 14:38:28.436979 67248 main.go:110] libmachine: Reading certificate data from /Users/yves/.minikube/certs/ca.pem
I0422 14:38:28.437043 67248 main.go:110] libmachine: Decoding PEM data...
I0422 14:38:28.437071 67248 main.go:110] libmachine: Parsing certificate...
I0422 14:38:28.437220 67248 main.go:110] libmachine: Reading certificate data from /Users/yves/.minikube/certs/cert.pem
I0422 14:38:28.437261 67248 main.go:110] libmachine: Decoding PEM data...
I0422 14:38:28.437274 67248 main.go:110] libmachine: Parsing certificate...
I0422 14:38:28.437317 67248 main.go:110] libmachine: Running pre-create checks...
I0422 14:38:28.437334 67248 main.go:110] libmachine: (minikube) Calling .PreCreateCheck
I0422 14:38:28.437483 67248 main.go:110] libmachine: (minikube) DBG | exe=/Users/yves/.minikube/bin/docker-machine-driver-hyperkit uid=0
I0422 14:38:28.437688 67248 main.go:110] libmachine: (minikube) Calling .GetConfigRaw
I0422 14:38:28.438306 67248 main.go:110] libmachine: Creating machine...
I0422 14:38:28.438321 67248 main.go:110] libmachine: (minikube) Calling .Create
I0422 14:38:28.438419 67248 main.go:110] libmachine: (minikube) DBG | exe=/Users/yves/.minikube/bin/docker-machine-driver-hyperkit uid=0
I0422 14:38:28.438569 67248 main.go:110] libmachine: (minikube) DBG | ERROR: logging before flag.Parse: I0422 14:38:28.438408 67283 common.go:99] Making disk image using store path: /Users/yves/.minikube
I0422 14:38:28.438644 67248 main.go:110] libmachine: (minikube) Downloading /Users/yves/.minikube/cache/boot2docker.iso from file:///Users/yves/.minikube/cache/iso/minikube-v1.9.0.iso...
I0422 14:38:28.440038 67248 main.go:110] libmachine: (minikube) DBG | ERROR: logging before flag.Parse: I0422 14:38:28.439983 67283 common.go:106] Creating ssh key: /Users/yves/.minikube/machines/minikube/id_rsa...
I0422 14:38:28.554501 67248 main.go:110] libmachine: (minikube) DBG | ERROR: logging before flag.Parse: I0422 14:38:28.554406 67283 common.go:112] Creating raw disk image: /Users/yves/.minikube/machines/minikube/minikube.rawdisk...
I0422 14:38:28.554535 67248 main.go:110] libmachine: (minikube) DBG | Writing magic tar header
I0422 14:38:28.554568 67248 main.go:110] libmachine: (minikube) DBG | Writing SSH key tar header
I0422 14:38:28.554843 67248 main.go:110] libmachine: (minikube) DBG | ERROR: logging before flag.Parse: I0422 14:38:28.554780 67283 common.go:126] Fixing permissions on /Users/yves/.minikube/machines/minikube ...
I0422 14:38:28.556365 67248 main.go:110] libmachine: (minikube) DBG | exe=/Users/yves/.minikube/bin/docker-machine-driver-hyperkit uid=0
I0422 14:38:28.556387 67248 main.go:110] libmachine: (minikube) DBG | clean start, hyperkit pid file doesn't exist: /Users/yves/.minikube/machines/minikube/hyperkit.pid
I0422 14:38:28.556463 67248 main.go:110] libmachine: (minikube) DBG | Using UUID e01364ec-8463-11ea-b75a-acde48001122
I0422 14:38:28.755349 67248 main.go:110] libmachine: (minikube) DBG | Generated MAC e6:51:c7:bf:97:5b
I0422 14:38:28.755404 67248 main.go:110] libmachine: (minikube) 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=minikube
I0422 14:38:28.757719 67248 main.go:110] libmachine: (minikube) DBG | Attempt 0
I0422 14:38:28.757753 67248 main.go:110] libmachine: (minikube) DBG | exe=/Users/yves/.minikube/bin/docker-machine-driver-hyperkit uid=0
I0422 14:38:28.757866 67248 main.go:110] libmachine: (minikube) DBG | hyperkit pid from json: 67307
I0422 14:38:28.760464 67248 main.go:110] libmachine: (minikube) DBG | Searching for e6:51:c7:bf:97:5b in /var/db/dhcpd_leases ...
I0422 14:38:28.760498 67248 main.go:110] libmachine: (minikube) DBG | Found 1 entries in /var/db/dhcpd_leases!
I0422 14:38:28.760571 67248 main.go:110] libmachine: (minikube) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.2 HWAddress:5e:fc:d8:d:9a:80 ID:1,5e:fc:d8:d:9a:80 Lease:0x5ea06d90}
I0422 14:38:28.814526 67248 main.go:110] libmachine: (minikube) DBG | 2020/04/22 14:38:28 fcntl(F_PUNCHHOLE) failed: host filesystem does not support sparse files: Operation not permitted
I0422 14:38:28.815848 67248 main.go:110] libmachine: (minikube) DBG | 2020/04/22 14:38:28 kexec: failed to load kernel /Users/yves/.minikube/machines/minikube/bzimage
I0422 14:38:28.815865 67248 main.go:110] libmachine: (minikube) DBG | 2020/04/22 14:38:28 linkname /Users/yves/.minikube/machines/minikube/tty
I0422 14:38:28.815884 67248 main.go:110] libmachine: (minikube) DBG | 2020/04/22 14:38:28 COM1 connected to /dev/ttys000
I0422 14:38:28.815896 67248 main.go:110] libmachine: (minikube) DBG | 2020/04/22 14:38:28 COM1 linked to /Users/yves/.minikube/machines/minikube/tty
I0422 14:38:30.764554 67248 main.go:110] libmachine: (minikube) DBG | Attempt 1
I0422 14:38:30.764580 67248 main.go:110] libmachine: (minikube) DBG | exe=/Users/yves/.minikube/bin/docker-machine-driver-hyperkit uid=0
I0422 14:38:30.764730 67248 main.go:110] libmachine: (minikube) DBG | hyperkit pid from json: 67307
I0422 14:38:30.766427 67248 main.go:110] libmachine: (minikube) DBG | hyperkit pid 67307 missing from process table
I0422 14:38:30.766579 67248 client.go:172] LocalClient.Create took 2.329605028s
I0422 14:38:32.770410 67248 start.go:110] createHost completed in 4.37045471s
I0422 14:38:32.770449 67248 start.go:77] releasing machines lock for "minikube", held for 4.370600688s
🤦 StartHost failed, but will try again: creating host: create: Error creating machine: Error in driver during machine creation: hyperkit crashed! command line:
hyperkit 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=minikube
I0422 14:38:32.771859 67248 main.go:110] libmachine: Found binary path at /Users/yves/.minikube/bin/docker-machine-driver-hyperkit
I0422 14:38:32.771961 67248 main.go:110] libmachine: Launching plugin server for driver hyperkit
I0422 14:38:32.786760 67248 main.go:110] libmachine: Plugin server listening at address 127.0.0.1:56662
I0422 14:38:32.787286 67248 main.go:110] libmachine: () Calling .GetVersion
I0422 14:38:32.787760 67248 main.go:110] libmachine: Using API Version 1
I0422 14:38:32.787772 67248 main.go:110] libmachine: () Calling .SetConfigRaw
I0422 14:38:32.788074 67248 main.go:110] libmachine: () Calling .GetMachineName
I0422 14:38:32.788511 67248 main.go:110] libmachine: Found binary path at /Users/yves/.minikube/bin/docker-machine-driver-hyperkit
I0422 14:38:32.788540 67248 main.go:110] libmachine: Launching plugin server for driver hyperkit
I0422 14:38:32.798100 67248 main.go:110] libmachine: Plugin server listening at address 127.0.0.1:56666
I0422 14:38:32.798577 67248 main.go:110] libmachine: () Calling .GetVersion
I0422 14:38:32.798982 67248 main.go:110] libmachine: Using API Version 1
I0422 14:38:32.798994 67248 main.go:110] libmachine: () Calling .SetConfigRaw
I0422 14:38:32.799233 67248 main.go:110] libmachine: () Calling .GetMachineName
I0422 14:38:32.799336 67248 main.go:110] libmachine: (minikube) Calling .GetState
I0422 14:38:32.799436 67248 main.go:110] libmachine: (minikube) DBG | exe=/Users/yves/.minikube/bin/docker-machine-driver-hyperkit uid=0
I0422 14:38:32.799659 67248 main.go:110] libmachine: (minikube) DBG | hyperkit pid from json: 67307
I0422 14:38:32.801369 67248 main.go:110] libmachine: (minikube) DBG | hyperkit pid 67307 missing from process table
I0422 14:38:32.801510 67248 main.go:110] libmachine: (minikube) Calling .DriverName
🔥 Deleting "minikube" in hyperkit ...
I0422 14:38:32.822108 67248 main.go:110] libmachine: (minikube) Calling .Remove
I0422 14:38:32.822552 67248 main.go:110] libmachine: (minikube) DBG | exe=/Users/yves/.minikube/bin/docker-machine-driver-hyperkit uid=0
I0422 14:38:32.822576 67248 main.go:110] libmachine: (minikube) DBG | exe=/Users/yves/.minikube/bin/docker-machine-driver-hyperkit uid=0
I0422 14:38:32.823059 67248 main.go:110] libmachine: (minikube) DBG | hyperkit pid from json: 67307
I0422 14:38:32.824807 67248 main.go:110] libmachine: (minikube) DBG | hyperkit pid 67307 missing from process table
I0422 14:38:37.828592 67248 start.go:260] acquiring machines lock for minikube: {Name:mkdd7a8a1ff4814687d3c0149520cd20cd24b807 Clock:{} Delay:500ms Timeout:15m0s Cancel:}
I0422 14:38:37.828834 67248 start.go:264] acquired machines lock for "minikube" in 196.148µs
I0422 14:38:37.828921 67248 start.go:86] Provisioning new machine with config: {Name:minikube KeepContext:false EmbedCerts:false MinikubeISO:https://storage.googleapis.com/minikube/iso/minikube-v1.9.0.iso Memory:4000 CPUs:2 DiskSize:20000 Driver:hyperkit HyperkitVpnKitSock: HyperkitVSockPorts:[] DockerEnv:[] InsecureRegistry:[] RegistryMirror:[] HostOnlyCIDR:192.168.99.1/24 HypervVirtualSwitch: HypervUseExternalSwitch:false HypervExternalAdapter: KVMNetwork:default KVMQemuURI:qemu:///system KVMGPU:false KVMHidden:false DockerOpt:[] DisableDriverMounts:false NFSShare:[] NFSSharesRoot:/nfsshares UUID: NoVTXCheck:false DNSProxy:false HostDNSResolver:true HostOnlyNicType:virtio NatNicType:virtio KubernetesConfig:{KubernetesVersion:v1.18.0 ClusterName:minikube APIServerName:minikubeCA APIServerNames:[] APIServerIPs:[] DNSDomain:cluster.local ContainerRuntime:docker CRISocket: NetworkPlugin: FeatureGates: ServiceCIDR:10.96.0.0/12 ImageRepository: ExtraOptions:[] ShouldLoadCachedImages:true EnableDefaultCNI:false NodeIP: NodePort:0 NodeName:} Nodes:[{Name:m01 IP: Port:8443 KubernetesVersion:v1.18.0 ControlPlane:true Worker:true}] Addons:map[] VerifyComponents:map[apiserver:true system_pods:true]} {Name:m01 IP: Port:8443 KubernetesVersion:v1.18.0 ControlPlane:true Worker:true}
I0422 14:38:37.829154 67248 start.go:107] createHost starting for "m01" (driver="hyperkit")
🔥 Creating hyperkit VM (CPUs=2, Memory=4000MB, Disk=20000MB) ...
I0422 14:38:37.847317 67248 main.go:110] libmachine: Found binary path at /Users/yves/.minikube/bin/docker-machine-driver-hyperkit
I0422 14:38:37.847390 67248 main.go:110] libmachine: Launching plugin server for driver hyperkit
I0422 14:38:37.864127 67248 main.go:110] libmachine: Plugin server listening at address 127.0.0.1:56670
I0422 14:38:37.864627 67248 main.go:110] libmachine: () Calling .GetVersion
I0422 14:38:37.865124 67248 main.go:110] libmachine: Using API Version 1
I0422 14:38:37.865137 67248 main.go:110] libmachine: () Calling .SetConfigRaw
I0422 14:38:37.865480 67248 main.go:110] libmachine: () Calling .GetMachineName
I0422 14:38:37.865594 67248 main.go:110] libmachine: (minikube) Calling .GetMachineName
I0422 14:38:37.865680 67248 main.go:110] libmachine: (minikube) Calling .DriverName
I0422 14:38:37.865794 67248 start.go:143] libmachine.API.Create for "minikube" (driver="hyperkit")
I0422 14:38:37.865821 67248 client.go:169] LocalClient.Create starting
I0422 14:38:37.865868 67248 main.go:110] libmachine: Reading certificate data from /Users/yves/.minikube/certs/ca.pem
I0422 14:38:37.865917 67248 main.go:110] libmachine: Decoding PEM data...
I0422 14:38:37.865932 67248 main.go:110] libmachine: Parsing certificate...
I0422 14:38:37.866032 67248 main.go:110] libmachine: Reading certificate data from /Users/yves/.minikube/certs/cert.pem
I0422 14:38:37.866064 67248 main.go:110] libmachine: Decoding PEM data...
I0422 14:38:37.866075 67248 main.go:110] libmachine: Parsing certificate...
I0422 14:38:37.866120 67248 main.go:110] libmachine: Running pre-create checks...
I0422 14:38:37.866127 67248 main.go:110] libmachine: (minikube) Calling .PreCreateCheck
I0422 14:38:37.866228 67248 main.go:110] libmachine: (minikube) DBG | exe=/Users/yves/.minikube/bin/docker-machine-driver-hyperkit uid=0
I0422 14:38:37.866274 67248 main.go:110] libmachine: (minikube) Calling .GetConfigRaw
I0422 14:38:37.866975 67248 main.go:110] libmachine: Creating machine...
I0422 14:38:37.866986 67248 main.go:110] libmachine: (minikube) Calling .Create
I0422 14:38:37.867101 67248 main.go:110] libmachine: (minikube) DBG | exe=/Users/yves/.minikube/bin/docker-machine-driver-hyperkit uid=0
I0422 14:38:37.867236 67248 main.go:110] libmachine: (minikube) DBG | ERROR: logging before flag.Parse: I0422 14:38:37.867092 67394 common.go:99] Making disk image using store path: /Users/yves/.minikube
I0422 14:38:37.867324 67248 main.go:110] libmachine: (minikube) Downloading /Users/yves/.minikube/cache/boot2docker.iso from file:///Users/yves/.minikube/cache/iso/minikube-v1.9.0.iso...
I0422 14:38:37.869046 67248 main.go:110] libmachine: (minikube) DBG | ERROR: logging before flag.Parse: I0422 14:38:37.868983 67394 common.go:106] Creating ssh key: /Users/yves/.minikube/machines/minikube/id_rsa...
I0422 14:38:37.955376 67248 main.go:110] libmachine: (minikube) DBG | ERROR: logging before flag.Parse: I0422 14:38:37.955265 67394 common.go:112] Creating raw disk image: /Users/yves/.minikube/machines/minikube/minikube.rawdisk...
I0422 14:38:37.955395 67248 main.go:110] libmachine: (minikube) DBG | Writing magic tar header
I0422 14:38:37.955405 67248 main.go:110] libmachine: (minikube) DBG | Writing SSH key tar header
I0422 14:38:37.955842 67248 main.go:110] libmachine: (minikube) DBG | ERROR: logging before flag.Parse: I0422 14:38:37.955741 67394 common.go:126] Fixing permissions on /Users/yves/.minikube/machines/minikube ...
I0422 14:38:37.957898 67248 main.go:110] libmachine: (minikube) DBG | exe=/Users/yves/.minikube/bin/docker-machine-driver-hyperkit uid=0
I0422 14:38:37.957919 67248 main.go:110] libmachine: (minikube) DBG | clean start, hyperkit pid file doesn't exist: /Users/yves/.minikube/machines/minikube/hyperkit.pid
I0422 14:38:37.957995 67248 main.go:110] libmachine: (minikube) DBG | Using UUID e5b19626-8463-11ea-b75a-acde48001122
I0422 14:38:38.057449 67248 main.go:110] libmachine: (minikube) DBG | Generated MAC 46:23:e9:44:4d:99
I0422 14:38:38.057514 67248 main.go:110] libmachine: (minikube) 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=minikube
I0422 14:38:38.059793 67248 main.go:110] libmachine: (minikube) DBG | Attempt 0
I0422 14:38:38.059831 67248 main.go:110] libmachine: (minikube) DBG | exe=/Users/yves/.minikube/bin/docker-machine-driver-hyperkit uid=0
I0422 14:38:38.060105 67248 main.go:110] libmachine: (minikube) DBG | hyperkit pid from json: 67395
I0422 14:38:38.062268 67248 main.go:110] libmachine: (minikube) DBG | Searching for 46:23:e9:44:4d:99 in /var/db/dhcpd_leases ...
I0422 14:38:38.062305 67248 main.go:110] libmachine: (minikube) DBG | Found 1 entries in /var/db/dhcpd_leases!
I0422 14:38:38.062362 67248 main.go:110] libmachine: (minikube) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.2 HWAddress:5e:fc:d8:d:9a:80 ID:1,5e:fc:d8:d:9a:80 Lease:0x5ea06d90}
I0422 14:38:38.117417 67248 main.go:110] libmachine: (minikube) DBG | 2020/04/22 14:38:38 fcntl(F_PUNCHHOLE) failed: host filesystem does not support sparse files: Operation not permitted
I0422 14:38:38.118111 67248 main.go:110] libmachine: (minikube) DBG | 2020/04/22 14:38:38 linkname /Users/yves/.minikube/machines/minikube/tty
I0422 14:38:38.118130 67248 main.go:110] libmachine: (minikube) DBG | 2020/04/22 14:38:38 COM1 connected to /dev/ttys000
I0422 14:38:38.118151 67248 main.go:110] libmachine: (minikube) DBG | 2020/04/22 14:38:38 kexec: failed to load kernel /Users/yves/.minikube/machines/minikube/bzimage
I0422 14:38:38.118164 67248 main.go:110] libmachine: (minikube) DBG | 2020/04/22 14:38:38 COM1 linked to /Users/yves/.minikube/machines/minikube/tty
I0422 14:38:40.064638 67248 main.go:110] libmachine: (minikube) DBG | Attempt 1
I0422 14:38:40.064698 67248 main.go:110] libmachine: (minikube) DBG | exe=/Users/yves/.minikube/bin/docker-machine-driver-hyperkit uid=0
I0422 14:38:40.064991 67248 main.go:110] libmachine: (minikube) DBG | hyperkit pid from json: 67395
I0422 14:38:40.068352 67248 main.go:110] libmachine: (minikube) DBG | hyperkit pid 67395 missing from process table
I0422 14:38:40.068542 67248 client.go:172] LocalClient.Create took 2.202683184s
I0422 14:38:42.072118 67248 start.go:110] createHost completed in 4.242824616s
I0422 14:38:42.072152 67248 start.go:77] releasing machines lock for "minikube", held for 4.243228891s

❌ [HYPERKIT_CRASHED] Failed to start hyperkit VM. "minikube start" may fix it. creating host: create: Error creating machine: Error in driver during machine creation: hyperkit crashed! command line:
hyperkit 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=minikube
💡 Suggestion: Hyperkit is broken. Upgrade to the latest hyperkit version and/or Docker for Desktop. Alternatively, you may choose an alternate --driver
⁉️ Related issues:
#6079
#5780

@yveshield
Copy link
Author

➜ ~ minikube delete --all
🔥 Removing /Users/yves/.minikube/machines/minikube ...
💀 Removed all traces of the "minikube" cluster.
🔥 Successfully deleted all profiles
➔ ~ minikube start --driver docker --alsologtostderr -v=1
I0422 14:45:25.469554 71857 notify.go:125] Checking for updates...
I0422 14:45:29.714045 71857 start.go:262] hostinfo: {"hostname":"Gordon-MacBook-Pro.local","uptime":13807,"bootTime":1587524122,"procs":448,"os":"darwin","platform":"darwin","platformFamily":"","platformVersion":"10.15.4","kernelVersion":"19.4.0","virtualizationSystem":"","virtualizationRole":"","hostid":"ab0aa7ee-3d03-3c21-91ad-5719d79d7af6"}
W0422 14:45:29.714329 71857 start.go:270] gopshost.Virtualization returned error: not implemented yet
😄 minikube v1.9.2 on Darwin 10.15.4
I0422 14:45:29.738804 71857 driver.go:245] Setting default libvirt URI to qemu:///system
✨ Using the docker driver based on user configuration
I0422 14:45:29.855286 71857 start.go:310] selected driver: docker
I0422 14:45:29.855332 71857 start.go:656] validating driver "docker" against
I0422 14:45:29.855356 71857 start.go:662] status for docker: {Installed:true Healthy:true Error: Fix: Doc:}
I0422 14:45:29.855440 71857 start.go:1100] auto setting extra-config to "kubeadm.pod-network-cidr=10.244.0.0/16".
I0422 14:45:29.939513 71857 start.go:1004] Using suggested 1989MB memory alloc based on sys=16384MB, container=1989MB
I0422 14:45:29.939643 71857 start.go:1210] Wait components to verify : map[apiserver:true system_pods:true]
👍 Starting control plane node m01 in cluster minikube
🚜 Pulling base image ...
I0422 14:45:29.960866 71857 cache.go:104] Beginning downloading kic artifacts
I0422 14:45:29.961232 71857 cache.go:106] Downloading gcr.io/k8s-minikube/kicbase:v0.0.8@sha256:2f3380ebf1bb0c75b0b47160fd4e61b7b8fef0f1f32f9def108d3eada50a7a81 to local daemon
I0422 14:45:29.961426 71857 image.go:84] Writing gcr.io/k8s-minikube/kicbase:v0.0.8@sha256:2f3380ebf1bb0c75b0b47160fd4e61b7b8fef0f1f32f9def108d3eada50a7a81 to local daemon
I0422 14:45:29.961447 71857 preload.go:81] Checking if preload exists for k8s version v1.18.0 and runtime docker
I0422 14:45:29.961527 71857 preload.go:97] Found local preload: /Users/yves/.minikube/cache/preloaded-tarball/preloaded-images-k8s-v2-v1.18.0-docker-overlay2-amd64.tar.lz4
I0422 14:45:29.961560 71857 cache.go:46] Caching tarball of preloaded images
I0422 14:45:29.961581 71857 preload.go:123] Found /Users/yves/.minikube/cache/preloaded-tarball/preloaded-images-k8s-v2-v1.18.0-docker-overlay2-amd64.tar.lz4 in cache, skipping download
I0422 14:45:29.961599 71857 cache.go:49] Finished downloading the preloaded tar for v1.18.0 on docker
I0422 14:45:29.962772 71857 profile.go:138] Saving config to /Users/yves/.minikube/profiles/minikube/config.json ...
I0422 14:45:29.963103 71857 lock.go:35] WriteFile acquiring /Users/yves/.minikube/profiles/minikube/config.json: {Name:mk0844afacaf7e815f18bb78d94c4d2a6f109b65 Clock:{} Delay:500ms Timeout:1m0s Cancel:}
E0422 14:48:04.228525 71857 cache.go:114] Error downloading kic artifacts: getting remote image: Get "https://gcr.io/v2/": dial tcp 74.125.203.82:443: i/o timeout
I0422 14:48:04.230567 71857 start.go:260] acquiring machines lock for minikube: {Name:mkdd7a8a1ff4814687d3c0149520cd20cd24b807 Clock:{} Delay:500ms Timeout:15m0s Cancel:}
I0422 14:48:04.230754 71857 start.go:264] acquired machines lock for "minikube" in 118.157µs
I0422 14:48:04.231196 71857 start.go:86] Provisioning new machine with config: {Name:minikube KeepContext:false EmbedCerts:false MinikubeISO: Memory:1989 CPUs:2 DiskSize:20000 Driver:docker HyperkitVpnKitSock: HyperkitVSockPorts:[] DockerEnv:[] InsecureRegistry:[] RegistryMirror:[] HostOnlyCIDR:192.168.99.1/24 HypervVirtualSwitch: HypervUseExternalSwitch:false HypervExternalAdapter: KVMNetwork:default KVMQemuURI:qemu:///system KVMGPU:false KVMHidden:false DockerOpt:[] DisableDriverMounts:false NFSShare:[] NFSSharesRoot:/nfsshares UUID: NoVTXCheck:false DNSProxy:false HostDNSResolver:true HostOnlyNicType:virtio NatNicType:virtio KubernetesConfig:{KubernetesVersion:v1.18.0 ClusterName:minikube APIServerName:minikubeCA APIServerNames:[] APIServerIPs:[] DNSDomain:cluster.local ContainerRuntime:docker CRISocket: NetworkPlugin: FeatureGates: ServiceCIDR:10.96.0.0/12 ImageRepository: ExtraOptions:[{Component:kubeadm Key:pod-network-cidr Value:10.244.0.0/16}] ShouldLoadCachedImages:true EnableDefaultCNI:false NodeIP: NodePort:0 NodeName:} Nodes:[{Name:m01 IP: Port:8443 KubernetesVersion:v1.18.0 ControlPlane:true Worker:true}] Addons:map[] VerifyComponents:map[apiserver:true system_pods:true]} {Name:m01 IP: Port:8443 KubernetesVersion:v1.18.0 ControlPlane:true Worker:true}
I0422 14:48:04.231348 71857 start.go:107] createHost starting for "m01" (driver="docker")
🔥 Creating Kubernetes in docker container with (CPUs=2) (4 available), Memory=1989MB (1989MB available) ...
I0422 14:48:04.347805 71857 start.go:143] libmachine.API.Create for "minikube" (driver="docker")
I0422 14:48:04.347878 71857 client.go:169] LocalClient.Create starting
I0422 14:48:04.348379 71857 main.go:110] libmachine: Reading certificate data from /Users/yves/.minikube/certs/ca.pem
I0422 14:48:04.348771 71857 main.go:110] libmachine: Decoding PEM data...
I0422 14:48:04.348809 71857 main.go:110] libmachine: Parsing certificate...
I0422 14:48:04.349665 71857 main.go:110] libmachine: Reading certificate data from /Users/yves/.minikube/certs/cert.pem
I0422 14:48:04.349954 71857 main.go:110] libmachine: Decoding PEM data...
I0422 14:48:04.349982 71857 main.go:110] libmachine: Parsing certificate...
I0422 14:48:04.351787 71857 oci.go:250] executing with [docker ps -a --format {{.Names}}] timeout: 30s
I0422 14:48:04.395680 71857 volumes.go:97] executing: [docker volume create minikube --label name.minikube.sigs.k8s.io=minikube --label created_by.minikube.sigs.k8s.io=true]
I0422 14:48:04.438548 71857 oci.go:128] Successfully created a docker volume minikube
I0422 14:50:04.351269 71857 start.go:110] createHost completed in 2m0.117476665s
I0422 14:50:04.351317 71857 start.go:77] releasing machines lock for "minikube", held for 2m0.118963705s
🤦 StartHost failed, but will try again: creating host: create host timed out in 120.000000 seconds
I0422 14:50:04.353583 71857 oci.go:250] executing with [docker inspect -f {{.State.Status}} minikube] timeout: 19s
I0422 14:50:04.402391 71857 delete.go:72] Unable to get host status for minikube, assuming it has already been deleted: state: "docker inspect -f {{.State.Status}} minikube" failed: exit status 1: Template parsing error: template: :1:8: executing "" at <.State.Status>: map has no entry for key "State"
I0422 14:50:09.402706 71857 start.go:260] acquiring machines lock for minikube: {Name:mkdd7a8a1ff4814687d3c0149520cd20cd24b807 Clock:{} Delay:500ms Timeout:15m0s Cancel:}
I0422 14:50:09.402967 71857 start.go:264] acquired machines lock for "minikube" in 195.89µs
I0422 14:50:09.403044 71857 start.go:90] Skipping create...Using existing machine configuration
I0422 14:50:09.403068 71857 fix.go:53] fixHost starting: m01
I0422 14:50:09.403545 71857 oci.go:250] executing with [docker inspect -f {{.State.Status}} minikube] timeout: 19s
I0422 14:50:09.446285 71857 fix.go:105] recreateIfNeeded on minikube: state=Error err="docker inspect -f {{.State.Status}} minikube" failed: exit status 1: Template parsing error: template: :1:8: executing "" at <.State.Status>: map has no entry for key "State"
I0422 14:50:09.446319 71857 fix.go:109] exists: false err=machine does not exist
I0422 14:50:09.446330 71857 fix.go:110] "machine does not exist" vs "machine does not exist"
🤷 docker "minikube" container is missing, will recreate.
I0422 14:50:09.467375 71857 delete.go:114] DEMOLISHING minikube ...
I0422 14:50:09.467467 71857 main.go:110] libmachine: Stopping "minikube"...
I0422 14:50:09.467827 71857 oci.go:250] executing with [docker inspect -f {{.State.Status}} minikube] timeout: 19s
I0422 14:50:09.511002 71857 main.go:110] libmachine: Error getting machine state: "docker inspect -f {{.State.Status}} minikube" failed: exit status 1: Template parsing error: template: :1:8: executing "" at <.State.Status>: map has no entry for key "State"

I0422 14:50:09.511430 71857 kubelet.go:43] stopping kubelet ...
I0422 14:50:09.512064 71857 kic_runner.go:91] Run: sudo systemctl stop kubelet.service
I0422 14:50:10.474361 71857 kic_runner.go:91] Run: sudo systemctl stop kubelet.service
I0422 14:50:12.294120 71857 kic_runner.go:91] Run: sudo systemctl stop kubelet.service
W0422 14:50:12.334310 71857 kic.go:322] couldn't stop kubelet. will continue with stop anyways: error stopping kubelet: temporary error for "sudo systemctl stop kubelet.service" : sudo systemctl stop kubelet.service: exit status 1
stdout:

stderr:
Error: No such container: minikube
I0422 14:50:12.334392 71857 kubelet.go:43] stopping kubelet ...
I0422 14:50:12.334646 71857 kic_runner.go:91] Run: sudo systemctl stop -f kubelet.service
I0422 14:50:12.937599 71857 kic_runner.go:91] Run: sudo systemctl stop -f kubelet.service
I0422 14:50:13.962411 71857 kic_runner.go:91] Run: sudo systemctl stop -f kubelet.service
W0422 14:50:14.000488 71857 kic.go:324] couldn't force stop kubelet. will continue with stop anyways: error stopping kubelet: temporary error for "sudo systemctl stop -f kubelet.service" : sudo systemctl stop -f kubelet.service: exit status 1
stdout:

stderr:
Error: No such container: minikube
I0422 14:50:14.000759 71857 kic_runner.go:91] Run: docker ps -a --filter=name=k8s_.(kube-system|kubernetes-dashboard|storage-gluster|istio-operator) --format={{.ID}}
I0422 14:50:14.032687 71857 kic.go:335] unable list containers : docker: docker ps -a --filter=name=k8s_.
(kube-system|kubernetes-dashboard|storage-gluster|istio-operator) --format={{.ID}}: exit status 1
stdout:

stderr:
Error: No such container: minikube
I0422 14:50:14.032714 71857 kic.go:342] successfully stopped kubernetes!
I0422 14:50:14.067064 71857 stop.go:56] stop err: stopping minikube: exit status 1
I0422 14:50:14.067093 71857 delete.go:119] stophost failed (probably ok): Temporary Error: stop: stopping minikube: exit status 1
I0422 14:50:14.067479 71857 oci.go:250] executing with [docker inspect -f {{.State.Status}} minikube] timeout: 19s
I0422 14:50:14.106566 71857 delete.go:72] Unable to get host status for minikube, assuming it has already been deleted: state: "docker inspect -f {{.State.Status}} minikube" failed: exit status 1: Template parsing error: template: :1:8: executing "" at <.State.Status>: map has no entry for key "State"
I0422 14:50:14.146756 71857 main.go:110] libmachine: could not find the container minikube to remove it.
W0422 14:50:14.178697 71857 delete.go:96] remove failed, will retry: removing container minikube, output Error: No such container: minikube: exit status 1
I0422 14:50:15.219201 71857 main.go:110] libmachine: could not find the container minikube to remove it.
W0422 14:50:15.251994 71857 delete.go:129] delete failed (probably ok) host remove retry: removing container minikube, output Error: No such container: minikube: exit status 1
I0422 14:50:15.252028 71857 fix.go:116] Sleeping 1 second for extra luck!
I0422 14:50:16.256715 71857 start.go:107] createHost starting for "m01" (driver="docker")
🔥 Creating Kubernetes in docker container with (CPUs=2) (4 available), Memory=1989MB (1989MB available) ...
I0422 14:50:16.360958 71857 start.go:143] libmachine.API.Create for "minikube" (driver="docker")
I0422 14:50:16.361015 71857 client.go:169] LocalClient.Create starting
I0422 14:50:16.361124 71857 main.go:110] libmachine: Reading certificate data from /Users/yves/.minikube/certs/ca.pem
I0422 14:50:16.361225 71857 main.go:110] libmachine: Decoding PEM data...
I0422 14:50:16.361258 71857 main.go:110] libmachine: Parsing certificate...
I0422 14:50:16.361498 71857 main.go:110] libmachine: Reading certificate data from /Users/yves/.minikube/certs/cert.pem
I0422 14:50:16.361575 71857 main.go:110] libmachine: Decoding PEM data...
I0422 14:50:16.361595 71857 main.go:110] libmachine: Parsing certificate...
I0422 14:50:16.363367 71857 oci.go:250] executing with [docker ps -a --format {{.Names}}] timeout: 30s
I0422 14:50:16.399787 71857 volumes.go:97] executing: [docker volume create minikube --label name.minikube.sigs.k8s.io=minikube --label created_by.minikube.sigs.k8s.io=true]
I0422 14:50:16.433045 71857 oci.go:128] Successfully created a docker volume minikube
I0422 14:52:16.364005 71857 start.go:110] createHost completed in 2m0.105676283s
I0422 14:52:16.364062 71857 fix.go:55] fixHost completed within 2m6.959344985s
I0422 14:52:16.364075 71857 start.go:77] releasing machines lock for "minikube", held for 2m6.959426307s

❌ [CREATE_TIMEOUT] Failed to start docker container. "minikube start" may fix it. recreate: creating host: create host timed out in 120.000000 seconds
💡 Suggestion: Try 'minikube delete', and disable any conflicting VPN or firewall software
⁉️ Related issue: #7072

@govargo
Copy link
Contributor

govargo commented Apr 23, 2020

Thank you for sharing your tried result.
I'm not very confident, but could you check your minikube home directory permission?

$ ls -la ~/.minikube/

# if the directory owner is not your user, please try
$ sudo chown -R <your user>:<your group>  ~/.minikube/

It looks failed cannot accessing or writing home directory files.

VBoxManage: error: Invalid UUID or filename "/Users/yves/.minikube/machines/minikube/boot2docker.iso"
kexec: failed to load kernel /Users/yves/.minikube/machines/minikube/bzimage

@yveshield
Copy link
Author

➔  ~ ls -la ~/.minikube/
total 0
drwxr-xr-x   11 yves  staff   352 Apr 23 08:59 .
drwxr-xr-x@ 182 yves  staff  5824 Apr 23 11:30 ..
drwxr-xr-x    2 yves  staff    64 Apr 22 15:10 addons
drwxr-xr-x    2 yves  staff    64 Apr 23 10:46 bin
drwxr-xr-x    4 yves  staff   128 Apr 23 08:59 cache
drwxr-xr-x    6 yves  staff   192 Apr 23 08:59 certs
drwxr-xr-x    3 yves  staff    96 Apr 23 09:14 config
drwxr-xr-x    2 yves  staff    64 Apr 22 15:10 files
drwxr-xr-x    2 yves  staff    64 Apr 22 15:10 logs
drwxr-xr-x    3 yves  staff    96 Apr 23 10:28 machines
drwx------    3 yves  staff    96 Apr 23 10:28 profiles
➔  ~ ls -la ~/.minikube/machines/minikube/
total 715512
drwx------  14 yves  staff          448 Apr 23 10:47 .
drwxr-xr-x   3 yves  staff           96 Apr 23 10:28 ..
-rw-------   1 yves  staff    183420928 Apr 23 10:28 boot2docker.iso
-rw-r--r--   1 root  staff     12697648 Apr 23 10:28 bzimage
-rw-------   1 yves  staff         2903 Apr 23 10:28 config.json
-rw-r--r--   1 root  staff        65536 Apr 23 10:47 console-ring
-rw-r--r--   1 root  staff         2239 Apr 23 10:47 hyperkit.json
-rw-r--r--   1 root  staff            5 Apr 23 10:47 hyperkit.pid
-rw-------   1 yves  staff         1675 Apr 23 10:28 id_rsa
-rw-------   1 yves  staff          381 Apr 23 10:28 id_rsa.pub
-rw-r--r--   1 root  staff    170181552 Apr 23 10:28 initrd
-rw-r--r--   1 root  staff          247 Apr 23 10:28 isolinux.cfg
-rw-r--r--   1 yves  staff  20000000000 Apr 23 10:28 minikube.rawdisk
lrwxr-xr-x   1 root  staff           12 Apr 23 10:47 tty -> /dev/ttys000
➔  ~ sudo chown -R yves:staff .minikube
➔  ~ ls -la ~/.minikube/machines/minikube/
total 715512
drwx------  14 yves  staff          448 Apr 23 11:39 .
drwxr-xr-x   3 yves  staff           96 Apr 23 10:28 ..
-rw-------   1 yves  staff    183420928 Apr 23 10:28 boot2docker.iso
-rw-r--r--   1 yves  staff     12697648 Apr 23 10:28 bzimage
-rw-------   1 yves  staff         2903 Apr 23 10:28 config.json
-rw-r--r--   1 yves  staff        65536 Apr 23 11:39 console-ring
-rw-r--r--   1 yves  staff         2239 Apr 23 11:39 hyperkit.json
-rw-r--r--   1 root  staff            5 Apr 23 11:39 hyperkit.pid
-rw-------   1 yves  staff         1675 Apr 23 10:28 id_rsa
-rw-------   1 yves  staff          381 Apr 23 10:28 id_rsa.pub
-rw-r--r--   1 yves  staff    170181552 Apr 23 10:28 initrd
-rw-r--r--   1 yves  staff          247 Apr 23 10:28 isolinux.cfg
-rw-r--r--   1 yves  staff  20000000000 Apr 23 10:28 minikube.rawdisk
lrwxr-xr-x   1 root  staff           12 Apr 23 11:39 tty -> /dev/ttys003
➜  ~ minikube start --alsologtostderr
I0423 11:42:32.832972   77604 notify.go:125] Checking for updates...
I0423 11:42:34.170749   77604 start.go:262] hostinfo: {"hostname":"Gordon-MacBook-Pro.local","uptime":89232,"bootTime":1587524122,"procs":497,"os":"darwin","platform":"darwin","platformFamily":"","platformVersion":"10.15.4","kernelVersion":"19.4.0","virtualizationSystem":"","virtualizationRole":"","hostid":"ab0aa7ee-3d03-3c21-91ad-5719d79d7af6"}
W0423 11:42:34.171136   77604 start.go:270] gopshost.Virtualization returned error: not implemented yet
😄  minikube v1.9.2 on Darwin 10.15.4
I0423 11:42:34.211391   77604 main.go:110] libmachine: Found binary path at /usr/local/bin/docker-machine-driver-hyperkit
I0423 11:42:34.212033   77604 main.go:110] libmachine: Launching plugin server for driver hyperkit
I0423 11:42:34.263100   77604 main.go:110] libmachine: Plugin server listening at address 127.0.0.1:53763
I0423 11:42:34.265306   77604 main.go:110] libmachine: () Calling .GetVersion
I0423 11:42:34.267898   77604 main.go:110] libmachine: Using API Version  1
I0423 11:42:34.267915   77604 main.go:110] libmachine: () Calling .SetConfigRaw
I0423 11:42:34.268608   77604 main.go:110] libmachine: () Calling .GetMachineName
I0423 11:42:34.268754   77604 main.go:110] libmachine: (minikube) Calling .DriverName
I0423 11:42:34.269455   77604 driver.go:245] Setting default libvirt URI to qemu:///system
I0423 11:42:34.269906   77604 main.go:110] libmachine: Found binary path at /usr/local/bin/docker-machine-driver-hyperkit
I0423 11:42:34.269949   77604 main.go:110] libmachine: Launching plugin server for driver hyperkit
I0423 11:42:34.287097   77604 main.go:110] libmachine: Plugin server listening at address 127.0.0.1:53767
I0423 11:42:34.287544   77604 main.go:110] libmachine: () Calling .GetVersion
I0423 11:42:34.287999   77604 main.go:110] libmachine: Using API Version  1
I0423 11:42:34.288017   77604 main.go:110] libmachine: () Calling .SetConfigRaw
I0423 11:42:34.288275   77604 main.go:110] libmachine: () Calling .GetMachineName
I0423 11:42:34.288390   77604 main.go:110] libmachine: (minikube) Calling .DriverName
✨  Using the hyperkit driver based on existing profile
I0423 11:42:34.313208   77604 start.go:310] selected driver: hyperkit
I0423 11:42:34.313261   77604 start.go:656] validating driver "hyperkit" against &{Name:minikube KeepContext:false EmbedCerts:false MinikubeISO:https://storage.googleapis.com/minikube/iso/minikube-v1.9.0.iso Memory:4000 CPUs:2 DiskSize:20000 Driver:hyperkit HyperkitVpnKitSock: HyperkitVSockPorts:[] DockerEnv:[HTTP_PROXY=http://127.0.0.1:6152 HTTPS_PROXY=http://127.0.0.1:6152 NO_PROXY=localhost,127.0.0.1,10.96.0.0/12,192.168.99.0/24,192.168.39.0/24] InsecureRegistry:[] RegistryMirror:[] HostOnlyCIDR:192.168.99.1/24 HypervVirtualSwitch: HypervUseExternalSwitch:false HypervExternalAdapter: KVMNetwork:default KVMQemuURI:qemu:///system KVMGPU:false KVMHidden:false DockerOpt:[] DisableDriverMounts:false NFSShare:[] NFSSharesRoot:/nfsshares UUID: NoVTXCheck:false DNSProxy:false HostDNSResolver:true HostOnlyNicType:virtio NatNicType:virtio KubernetesConfig:{KubernetesVersion:v1.18.2 ClusterName:minikube APIServerName:minikubeCA APIServerNames:[] APIServerIPs:[] DNSDomain:cluster.local ContainerRuntime:docker CRISocket: NetworkPlugin: FeatureGates: ServiceCIDR:10.96.0.0/12 ImageRepository: ExtraOptions:[] ShouldLoadCachedImages:true EnableDefaultCNI:false NodeIP: NodePort:0 NodeName:} Nodes:[{Name:m01 IP: Port:8443 KubernetesVersion:v1.18.2 ControlPlane:true Worker:true}] Addons:map[] VerifyComponents:map[apiserver:true system_pods:true]}
I0423 11:42:34.313433   77604 start.go:662] status for hyperkit: {Installed:true Healthy:true Error:<nil> Fix: Doc:}
I0423 11:42:34.313532   77604 install.go:49] acquiring lock: {Name:mk4023283b30b374c3f04c8805d539e68824c0b8 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I0423 11:42:34.313849   77604 install.go:115] Validating docker-machine-driver-hyperkit, PATH=/Users/yves/.minikube/bin:/usr/local/opt/binutils/bin:/usr/local/opt/python/libexec/bin:/usr/local/sbin:/usr/local/opt/mysql@5.7/bin:/usr/local/opt/mysql@5.7/bin:/usr/local/bin:/usr/bin:/bin:/usr/sbin:/sbin:/Applications/VMware Fusion.app/Contents/Public:/usr/local/MacGPG2/bin:/opt/X11/bin
I0423 11:42:34.334154   77604 install.go:77] stdout: /usr/local/bin/docker-machine-driver-hyperkit
I0423 11:42:34.334188   77604 install.go:79] /usr/local/bin/docker-machine-driver-hyperkit looks good
I0423 11:42:34.334762   77604 start.go:1004] Using suggested 4000MB memory alloc based on sys=16384MB, container=0MB
I0423 11:42:34.334865   77604 start.go:1210] Wait components to verify : map[apiserver:true system_pods:true]
I0423 11:42:34.335231   77604 iso.go:119] acquiring lock: {Name:mkc66493fd5a14eb3815b1fcc2805060061fd975 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
👍  Starting control plane node m01 in cluster minikube
I0423 11:42:34.346554   77604 preload.go:81] Checking if preload exists for k8s version v1.18.2 and runtime docker
W0423 11:42:34.874908   77604 preload.go:110] https://storage.googleapis.com/minikube-preloaded-volume-tarballs/preloaded-images-k8s-v2-v1.18.2-docker-overlay2-amd64.tar.lz4 status code: 404
I0423 11:42:34.876108   77604 profile.go:138] Saving config to /Users/yves/.minikube/profiles/minikube/config.json ...
I0423 11:42:34.877523   77604 cache.go:117] Successfully downloaded all kic artifacts
I0423 11:42:34.877697   77604 start.go:260] acquiring machines lock for minikube: {Name:mkdd7a8a1ff4814687d3c0149520cd20cd24b807 Clock:{} Delay:500ms Timeout:15m0s Cancel:<nil>}
I0423 11:42:34.877583   77604 cache.go:92] acquiring lock: {Name:mke8e52ef0fe7c54d31f0c414199e83710b0ae0a Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I0423 11:42:34.877467   77604 cache.go:92] acquiring lock: {Name:mk3537ea35fc741e32acbeda5b3eefb914a5477e Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I0423 11:42:34.877488   77604 cache.go:92] acquiring lock: {Name:mkbb8bf1318e75e4a3398befaa18e5faf3f5e594 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I0423 11:42:34.877560   77604 cache.go:92] acquiring lock: {Name:mkc14e434b1b1e210dcc978a74c98ddccc9006b3 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I0423 11:42:34.877581   77604 cache.go:92] acquiring lock: {Name:mk4c05df071d27fe234436c2d7a1ba71955b7c0b Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I0423 11:42:34.877904   77604 start.go:264] acquired machines lock for "minikube" in 178.915µs
I0423 11:42:34.877550   77604 cache.go:92] acquiring lock: {Name:mk9b9d62bcf8c8f8f9c277797abbc26b04b8b5e8 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I0423 11:42:34.877960   77604 start.go:90] Skipping create...Using existing machine configuration
I0423 11:42:34.877949   77604 cache.go:92] acquiring lock: {Name:mk75d70a8259f1a41ede5996b6aa35b43525786d Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I0423 11:42:34.877981   77604 fix.go:53] fixHost starting: m01
I0423 11:42:34.878022   77604 cache.go:92] acquiring lock: {Name:mk1451a202e8533c2b84361ccde969e465d9fa14 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I0423 11:42:34.878039   77604 cache.go:92] acquiring lock: {Name:mkd2fe6653a3c1c9d13cf20b48bb9cb035ffcc6c Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I0423 11:42:34.877511   77604 cache.go:92] acquiring lock: {Name:mkdde60aa9356b16d9cdb58d4bbb8f00acaff146 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I0423 11:42:34.878126   77604 image.go:112] retrieving image: k8s.gcr.io/coredns:1.6.7
I0423 11:42:34.878178   77604 image.go:112] retrieving image: k8s.gcr.io/pause:3.2
I0423 11:42:34.878199   77604 image.go:112] retrieving image: k8s.gcr.io/kube-scheduler:v1.18.2
I0423 11:42:34.878200   77604 image.go:112] retrieving image: kubernetesui/metrics-scraper:v1.0.2
I0423 11:42:34.878242   77604 image.go:112] retrieving image: k8s.gcr.io/kube-proxy:v1.18.2
I0423 11:42:34.890040   77604 image.go:112] retrieving image: gcr.io/k8s-minikube/storage-provisioner:v1.8.1
I0423 11:42:34.890035   77604 image.go:112] retrieving image: k8s.gcr.io/etcd:3.4.3-0
I0423 11:42:34.878242   77604 image.go:112] retrieving image: k8s.gcr.io/kube-apiserver:v1.18.2
I0423 11:42:34.878330   77604 image.go:112] retrieving image: k8s.gcr.io/kube-controller-manager:v1.18.2
I0423 11:42:34.878709   77604 main.go:110] libmachine: Found binary path at /usr/local/bin/docker-machine-driver-hyperkit
I0423 11:42:34.890910   77604 main.go:110] libmachine: Launching plugin server for driver hyperkit
I0423 11:42:34.890036   77604 image.go:112] retrieving image: kubernetesui/dashboard:v2.0.0-rc6
I0423 11:42:34.907208   77604 image.go:120] daemon lookup for k8s.gcr.io/coredns:1.6.7: Error response from daemon: reference does not exist
I0423 11:42:34.907923   77604 image.go:120] daemon lookup for k8s.gcr.io/etcd:3.4.3-0: Error response from daemon: reference does not exist
I0423 11:42:34.908334   77604 image.go:120] daemon lookup for k8s.gcr.io/kube-proxy:v1.18.2: Error response from daemon: reference does not exist
I0423 11:42:34.911126   77604 image.go:120] daemon lookup for kubernetesui/dashboard:v2.0.0-rc6: Error response from daemon: reference does not exist
I0423 11:42:34.911512   77604 image.go:120] daemon lookup for k8s.gcr.io/kube-scheduler:v1.18.2: Error response from daemon: reference does not exist
I0423 11:42:34.914240   77604 image.go:120] daemon lookup for gcr.io/k8s-minikube/storage-provisioner:v1.8.1: Error response from daemon: reference does not exist
I0423 11:42:34.917511   77604 image.go:120] daemon lookup for k8s.gcr.io/kube-controller-manager:v1.18.2: Error response from daemon: reference does not exist
I0423 11:42:34.917607   77604 image.go:120] daemon lookup for k8s.gcr.io/pause:3.2: Error response from daemon: reference does not exist
I0423 11:42:34.917776   77604 image.go:120] daemon lookup for k8s.gcr.io/kube-apiserver:v1.18.2: Error response from daemon: reference does not exist
I0423 11:42:34.919158   77604 image.go:120] daemon lookup for kubernetesui/metrics-scraper:v1.0.2: Error response from daemon: reference does not exist
I0423 11:42:34.925118   77604 main.go:110] libmachine: Plugin server listening at address 127.0.0.1:53771
I0423 11:42:34.929006   77604 main.go:110] libmachine: () Calling .GetVersion
I0423 11:42:34.931905   77604 main.go:110] libmachine: Using API Version  1
I0423 11:42:34.931998   77604 main.go:110] libmachine: () Calling .SetConfigRaw
I0423 11:42:34.933362   77604 main.go:110] libmachine: () Calling .GetMachineName
I0423 11:42:34.935070   77604 main.go:110] libmachine: (minikube) Calling .DriverName
I0423 11:42:34.935485   77604 main.go:110] libmachine: (minikube) Calling .GetState
I0423 11:42:34.935871   77604 main.go:110] libmachine: (minikube) DBG | exe=/usr/local/bin/docker-machine-driver-hyperkit uid=0
I0423 11:42:34.937224   77604 main.go:110] libmachine: (minikube) DBG | hyperkit pid from json: 71269
I0423 11:42:34.940510   77604 main.go:110] libmachine: (minikube) DBG | hyperkit pid 71269 missing from process table
I0423 11:42:34.940579   77604 fix.go:105] recreateIfNeeded on minikube: state=Stopped err=<nil>
I0423 11:42:34.940619   77604 main.go:110] libmachine: (minikube) Calling .DriverName
I0423 11:42:34.940867   77604 fix.go:109] exists: true err=<nil>
I0423 11:42:34.940876   77604 fix.go:110] %!q(<nil>) vs "machine does not exist"
W0423 11:42:34.940884   77604 fix.go:130] unexpected machine state, will restart: <nil>
🔄  Restarting existing hyperkit VM for "minikube" ...
I0423 11:42:35.003894   77604 main.go:110] libmachine: (minikube) Calling .Start
I0423 11:42:35.007917   77604 main.go:110] libmachine: (minikube) minikube might have been shutdown in an unclean way, the hyperkit pid file still exists: /Users/yves/.minikube/machines/minikube/hyperkit.pid
I0423 11:42:35.007953   77604 main.go:110] libmachine: (minikube) DBG | exe=/usr/local/bin/docker-machine-driver-hyperkit uid=0
I0423 11:42:35.017568   77604 main.go:110] libmachine: (minikube) DBG | hyperkit pid 71269 missing from process table
I0423 11:42:35.017636   77604 main.go:110] libmachine: (minikube) DBG | pid 71269 is in state "Stopped"
I0423 11:42:35.017665   77604 main.go:110] libmachine: (minikube) DBG | Removing stale pid file /Users/yves/.minikube/machines/minikube/hyperkit.pid...
I0423 11:42:35.017895   77604 main.go:110] libmachine: (minikube) DBG | Using UUID 1e796fe6-850a-11ea-8d97-acde48001122
I0423 11:42:35.309114   77604 main.go:110] libmachine: (minikube) DBG | Generated MAC ae:23:5e:ff:7e:a9
I0423 11:42:35.309160   77604 main.go:110] libmachine: (minikube) 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=minikube
I0423 11:42:35.311447   77604 main.go:110] libmachine: (minikube) DBG | Attempt 0
I0423 11:42:35.311473   77604 main.go:110] libmachine: (minikube) DBG | exe=/usr/local/bin/docker-machine-driver-hyperkit uid=0
I0423 11:42:35.311647   77604 main.go:110] libmachine: (minikube) DBG | hyperkit pid from json: 77748
I0423 11:42:35.313251   77604 main.go:110] libmachine: (minikube) DBG | Searching for ae:23:5e:ff:7e:a9 in /var/db/dhcpd_leases ...
I0423 11:42:35.313292   77604 main.go:110] libmachine: (minikube) DBG | Found 1 entries in /var/db/dhcpd_leases!
I0423 11:42:35.313333   77604 main.go:110] libmachine: (minikube) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.2 HWAddress:5e:fc:d8:d:9a:80 ID:1,5e:fc:d8:d:9a:80 Lease:0x5ea06d90}
I0423 11:42:35.367632   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 fcntl(F_PUNCHHOLE) failed: host filesystem does not support sparse files: Operation not permitted
I0423 11:42:35.476442   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 Failed to emulate instruction [0x82 0x51 0xa5 0xad] at 0xde400a
I0423 11:42:35.476468   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 linkname /Users/yves/.minikube/machines/minikube/tty
I0423 11:42:35.476485   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 COM1 connected to /dev/ttys004
I0423 11:42:35.476500   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 COM1 linked to /Users/yves/.minikube/machines/minikube/tty
I0423 11:42:35.476512   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_PIN_BASED_CTLS:           0x000000000000003f
I0423 11:42:35.476522   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_PRI_PROC_BASED_CTLS:      0x00000000b5186dfa
I0423 11:42:35.476536   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_SEC_PROC_BASED_CTLS:      0x00000000000000aa
I0423 11:42:35.476545   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_ENTRY_CTLS:               0x00000000000091ff
I0423 11:42:35.476555   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_EXCEPTION_BITMAP:         0x0000000000040000
I0423 11:42:35.476568   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_CR0_MASK:                 0x00000000e0000031
I0423 11:42:35.476607   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_CR0_SHADOW:               0x0000000000000021
I0423 11:42:35.476628   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_CR4_MASK:                 0x0000000000002000
I0423 11:42:35.476642   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_CR4_SHADOW:               0x0000000000000000
I0423 11:42:35.476673   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_GUEST_PHYSICAL_ADDRESS:   0x00000000ffffffa5
I0423 11:42:35.476689   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_GUEST_LINEAR_ADDRESS:     0x00000000ffffffa5
I0423 11:42:35.476703   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_GUEST_CS_SELECTOR:        0x0000000000000010
I0423 11:42:35.476716   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_GUEST_CS_LIMIT:           0x00000000ffffffff
I0423 11:42:35.476730   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_GUEST_CS_ACCESS_RIGHTS:   0x000000000000c09b
I0423 11:42:35.476740   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_GUEST_CS_BASE:            0x0000000000000000
I0423 11:42:35.476759   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_GUEST_DS_SELECTOR:        0x0000000000000018
I0423 11:42:35.476771   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_GUEST_DS_LIMIT:           0x00000000ffffffff
I0423 11:42:35.476783   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_GUEST_DS_ACCESS_RIGHTS:   0x000000000000c093
I0423 11:42:35.476794   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_GUEST_DS_BASE:            0x0000000000000000
I0423 11:42:35.476804   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_GUEST_ES_SELECTOR:        0x0000000000000018
I0423 11:42:35.476815   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_GUEST_ES_LIMIT:           0x00000000ffffffff
I0423 11:42:35.476828   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_GUEST_ES_ACCESS_RIGHTS:   0x000000000000c093
I0423 11:42:35.476843   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_GUEST_ES_BASE:            0x0000000000000000
I0423 11:42:35.476860   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_GUEST_FS_SELECTOR:        0x0000000000000000
I0423 11:42:35.476872   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_GUEST_FS_LIMIT:           0x000000000000ffff
I0423 11:42:35.476884   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_GUEST_FS_ACCESS_RIGHTS:   0x0000000000000093
I0423 11:42:35.476899   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_GUEST_FS_BASE:            0x0000000000000000
I0423 11:42:35.476908   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_GUEST_GS_SELECTOR:        0x0000000000000000
I0423 11:42:35.476918   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_GUEST_GS_LIMIT:           0x000000000000ffff
I0423 11:42:35.476927   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_GUEST_GS_ACCESS_RIGHTS:   0x0000000000000093
I0423 11:42:35.476936   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_GUEST_GS_BASE:            0x0000000000000000
I0423 11:42:35.476946   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_GUEST_SS_SELECTOR:        0x0000000000000018
I0423 11:42:35.476956   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_GUEST_SS_LIMIT:           0x00000000ffffffff
I0423 11:42:35.476973   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_GUEST_SS_ACCESS_RIGHTS:   0x000000000000c093
I0423 11:42:35.476987   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_GUEST_SS_BASE:            0x0000000000000000
I0423 11:42:35.476997   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_GUEST_LDTR_SELECTOR:      0x0000000000000000
I0423 11:42:35.477005   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_GUEST_LDTR_LIMIT:         0x000000000000ffff
I0423 11:42:35.477038   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_GUEST_LDTR_ACCESS_RIGHTS: 0x0000000000000082
I0423 11:42:35.477059   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_GUEST_LDTR_BASE:          0x0000000000000000
I0423 11:42:35.477079   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_GUEST_TR_SELECTOR:        0x0000000000000000
I0423 11:42:35.477095   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_GUEST_TR_LIMIT:           0x0000000000000000
I0423 11:42:35.477106   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_GUEST_TR_ACCESS_RIGHTS:   0x000000000000008b
I0423 11:42:35.477119   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_GUEST_TR_BASE:            0x0000000000000000
I0423 11:42:35.477141   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_GUEST_GDTR_LIMIT:         0x000000000000001f
I0423 11:42:35.477154   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_GUEST_GDTR_BASE:          0x0000000000002000
I0423 11:42:35.477173   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_GUEST_IDTR_LIMIT:         0x000000000000ffff
I0423 11:42:35.477186   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_GUEST_IDTR_BASE:          0x0000000000000000
I0423 11:42:35.477193   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_GUEST_CR0:                0x0000000000000031
I0423 11:42:35.477202   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_GUEST_CR3:                0x0000000000000000
I0423 11:42:35.477214   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_GUEST_CR4:                0x0000000000002000
I0423 11:42:35.477223   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 VMCS_GUEST_IA32_EFER:          0x0000000000000000
I0423 11:42:35.477241   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35
I0423 11:42:35.477253   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 rip: 0x0000000000de400a rfl: 0x0000000000010013 cr2: 0x0000000000000000
I0423 11:42:35.477279   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 rax: 0x0000000000000000 rbx: 0x0000000000000000 rcx: 0x0000000000000000 rdx: 0x0000000000000f00
I0423 11:42:35.477291   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 rsi: 0x0000000000003010 rdi: 0x0000000000000004 rbp: 0x0000000000200000 rsp: 0x0000000000dff87c
I0423 11:42:35.477303   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 r8:  0x0000000000000000 r9:  0x0000000000000000 r10: 0x0000000000000000 r11: 0x0000000000000000
I0423 11:42:35.477312   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:35 r12: 0x0000000000000000 r13: 0x0000000000000000 r14: 0x0000000000000000 r15: 0x0000000000000000
I0423 11:42:36.976996   77604 cache.go:138] opening:  /Users/yves/.minikube/cache/images/gcr.io/k8s-minikube/storage-provisioner_v1.8.1
I0423 11:42:37.318010   77604 main.go:110] libmachine: (minikube) DBG | Attempt 1
I0423 11:42:37.318071   77604 main.go:110] libmachine: (minikube) DBG | exe=/usr/local/bin/docker-machine-driver-hyperkit uid=0
I0423 11:42:37.318569   77604 main.go:110] libmachine: (minikube) DBG | hyperkit pid from json: 77748
I0423 11:42:37.321956   77604 main.go:110] libmachine: (minikube) DBG | hyperkit pid 77748 missing from process table
I0423 11:42:37.322950   77604 fix.go:55] fixHost completed within 2.444084517s
I0423 11:42:37.322981   77604 start.go:77] releasing machines lock for "minikube", held for 2.445036443s
🤦  StartHost failed, but will try again: driver start: hyperkit crashed! command line:
  hyperkit 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=minikube
I0423 11:42:39.228550   77604 cache.go:138] opening:  /Users/yves/.minikube/cache/images/k8s.gcr.io/coredns_1.6.7
I0423 11:42:39.258618   77604 cache.go:138] opening:  /Users/yves/.minikube/cache/images/k8s.gcr.io/pause_3.2
I0423 11:42:39.304417   77604 cache.go:138] opening:  /Users/yves/.minikube/cache/images/k8s.gcr.io/kube-controller-manager_v1.18.2
I0423 11:42:39.304463   77604 cache.go:138] opening:  /Users/yves/.minikube/cache/images/k8s.gcr.io/kube-scheduler_v1.18.2
I0423 11:42:39.304429   77604 cache.go:138] opening:  /Users/yves/.minikube/cache/images/k8s.gcr.io/kube-apiserver_v1.18.2
I0423 11:42:39.304498   77604 cache.go:138] opening:  /Users/yves/.minikube/cache/images/k8s.gcr.io/kube-proxy_v1.18.2
I0423 11:42:39.347908   77604 cache.go:138] opening:  /Users/yves/.minikube/cache/images/k8s.gcr.io/etcd_3.4.3-0
I0423 11:42:42.323829   77604 start.go:260] acquiring machines lock for minikube: {Name:mkdd7a8a1ff4814687d3c0149520cd20cd24b807 Clock:{} Delay:500ms Timeout:15m0s Cancel:<nil>}
I0423 11:42:42.324062   77604 start.go:264] acquired machines lock for "minikube" in 176.743µs
I0423 11:42:42.324139   77604 start.go:90] Skipping create...Using existing machine configuration
I0423 11:42:42.324154   77604 fix.go:53] fixHost starting: m01
I0423 11:42:42.325753   77604 main.go:110] libmachine: Found binary path at /usr/local/bin/docker-machine-driver-hyperkit
I0423 11:42:42.325909   77604 main.go:110] libmachine: Launching plugin server for driver hyperkit
I0423 11:42:42.347528   77604 main.go:110] libmachine: Plugin server listening at address 127.0.0.1:53803
I0423 11:42:42.348086   77604 main.go:110] libmachine: () Calling .GetVersion
I0423 11:42:42.348615   77604 main.go:110] libmachine: Using API Version  1
I0423 11:42:42.348631   77604 main.go:110] libmachine: () Calling .SetConfigRaw
I0423 11:42:42.348936   77604 main.go:110] libmachine: () Calling .GetMachineName
I0423 11:42:42.349080   77604 main.go:110] libmachine: (minikube) Calling .DriverName
I0423 11:42:42.349204   77604 main.go:110] libmachine: (minikube) Calling .GetState
I0423 11:42:42.349332   77604 main.go:110] libmachine: (minikube) DBG | exe=/usr/local/bin/docker-machine-driver-hyperkit uid=0
I0423 11:42:42.349584   77604 main.go:110] libmachine: (minikube) DBG | hyperkit pid from json: 77748
I0423 11:42:42.351537   77604 main.go:110] libmachine: (minikube) DBG | hyperkit pid 77748 missing from process table
I0423 11:42:42.351656   77604 fix.go:105] recreateIfNeeded on minikube: state=Stopped err=<nil>
I0423 11:42:42.351685   77604 main.go:110] libmachine: (minikube) Calling .DriverName
I0423 11:42:42.351898   77604 fix.go:109] exists: true err=<nil>
I0423 11:42:42.351909   77604 fix.go:110] %!q(<nil>) vs "machine does not exist"
W0423 11:42:42.351916   77604 fix.go:130] unexpected machine state, will restart: <nil>
🔄  Restarting existing hyperkit VM for "minikube" ...
I0423 11:42:42.388510   77604 main.go:110] libmachine: (minikube) Calling .Start
I0423 11:42:42.388915   77604 main.go:110] libmachine: (minikube) DBG | exe=/usr/local/bin/docker-machine-driver-hyperkit uid=0
I0423 11:42:42.389129   77604 main.go:110] libmachine: (minikube) minikube might have been shutdown in an unclean way, the hyperkit pid file still exists: /Users/yves/.minikube/machines/minikube/hyperkit.pid
I0423 11:42:42.392945   77604 main.go:110] libmachine: (minikube) DBG | hyperkit pid 77748 missing from process table
I0423 11:42:42.392973   77604 main.go:110] libmachine: (minikube) DBG | pid 77748 is in state "Stopped"
I0423 11:42:42.392999   77604 main.go:110] libmachine: (minikube) DBG | Removing stale pid file /Users/yves/.minikube/machines/minikube/hyperkit.pid...
I0423 11:42:42.393015   77604 main.go:110] libmachine: (minikube) DBG | Using UUID 1e796fe6-850a-11ea-8d97-acde48001122
I0423 11:42:42.489571   77604 main.go:110] libmachine: (minikube) DBG | Generated MAC ae:23:5e:ff:7e:a9
I0423 11:42:42.489651   77604 main.go:110] libmachine: (minikube) 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=minikube
I0423 11:42:42.492680   77604 main.go:110] libmachine: (minikube) DBG | Attempt 0
I0423 11:42:42.492712   77604 main.go:110] libmachine: (minikube) DBG | exe=/usr/local/bin/docker-machine-driver-hyperkit uid=0
I0423 11:42:42.492857   77604 main.go:110] libmachine: (minikube) DBG | hyperkit pid from json: 77960
I0423 11:42:42.494588   77604 main.go:110] libmachine: (minikube) DBG | Searching for ae:23:5e:ff:7e:a9 in /var/db/dhcpd_leases ...
I0423 11:42:42.494633   77604 main.go:110] libmachine: (minikube) DBG | Found 1 entries in /var/db/dhcpd_leases!
I0423 11:42:42.494674   77604 main.go:110] libmachine: (minikube) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.2 HWAddress:5e:fc:d8:d:9a:80 ID:1,5e:fc:d8:d:9a:80 Lease:0x5ea06d90}
I0423 11:42:42.548777   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 fcntl(F_PUNCHHOLE) failed: host filesystem does not support sparse files: Operation not permitted
I0423 11:42:42.632519   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 Failed to emulate instruction [0x82 0x51 0xa5 0xad] at 0xde400a
I0423 11:42:42.632548   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 linkname /Users/yves/.minikube/machines/minikube/tty
I0423 11:42:42.632564   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 COM1 connected to /dev/ttys004
I0423 11:42:42.632575   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 COM1 linked to /Users/yves/.minikube/machines/minikube/tty
I0423 11:42:42.632612   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_PIN_BASED_CTLS:           0x000000000000003f
I0423 11:42:42.632630   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_PRI_PROC_BASED_CTLS:      0x00000000b5186dfa
I0423 11:42:42.632656   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_SEC_PROC_BASED_CTLS:      0x00000000000000aa
I0423 11:42:42.632677   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_ENTRY_CTLS:               0x00000000000091ff
I0423 11:42:42.632696   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_EXCEPTION_BITMAP:         0x0000000000040000
I0423 11:42:42.632706   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_CR0_MASK:                 0x00000000e0000031
I0423 11:42:42.632723   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_CR0_SHADOW:               0x0000000000000021
I0423 11:42:42.632742   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_CR4_MASK:                 0x0000000000002000
I0423 11:42:42.632756   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_CR4_SHADOW:               0x0000000000000000
I0423 11:42:42.632767   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_GUEST_PHYSICAL_ADDRESS:   0x00000000ffffffa5
I0423 11:42:42.632782   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_GUEST_LINEAR_ADDRESS:     0x00000000ffffffa5
I0423 11:42:42.632795   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_GUEST_CS_SELECTOR:        0x0000000000000010
I0423 11:42:42.632806   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_GUEST_CS_LIMIT:           0x00000000ffffffff
I0423 11:42:42.632817   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_GUEST_CS_ACCESS_RIGHTS:   0x000000000000c09b
I0423 11:42:42.632832   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_GUEST_CS_BASE:            0x0000000000000000
I0423 11:42:42.632842   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_GUEST_DS_SELECTOR:        0x0000000000000018
I0423 11:42:42.632864   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_GUEST_DS_LIMIT:           0x00000000ffffffff
I0423 11:42:42.632875   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_GUEST_DS_ACCESS_RIGHTS:   0x000000000000c093
I0423 11:42:42.632888   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_GUEST_DS_BASE:            0x0000000000000000
I0423 11:42:42.632901   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_GUEST_ES_SELECTOR:        0x0000000000000018
I0423 11:42:42.632914   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_GUEST_ES_LIMIT:           0x00000000ffffffff
I0423 11:42:42.632926   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_GUEST_ES_ACCESS_RIGHTS:   0x000000000000c093
I0423 11:42:42.632938   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_GUEST_ES_BASE:            0x0000000000000000
I0423 11:42:42.632948   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_GUEST_FS_SELECTOR:        0x0000000000000000
I0423 11:42:42.632962   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_GUEST_FS_LIMIT:           0x000000000000ffff
I0423 11:42:42.632975   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_GUEST_FS_ACCESS_RIGHTS:   0x0000000000000093
I0423 11:42:42.632987   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_GUEST_FS_BASE:            0x0000000000000000
I0423 11:42:42.632997   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_GUEST_GS_SELECTOR:        0x0000000000000000
I0423 11:42:42.633009   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_GUEST_GS_LIMIT:           0x000000000000ffff
I0423 11:42:42.633019   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_GUEST_GS_ACCESS_RIGHTS:   0x0000000000000093
I0423 11:42:42.633038   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_GUEST_GS_BASE:            0x0000000000000000
I0423 11:42:42.633055   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_GUEST_SS_SELECTOR:        0x0000000000000018
I0423 11:42:42.633070   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_GUEST_SS_LIMIT:           0x00000000ffffffff
I0423 11:42:42.633084   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_GUEST_SS_ACCESS_RIGHTS:   0x000000000000c093
I0423 11:42:42.633099   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_GUEST_SS_BASE:            0x0000000000000000
I0423 11:42:42.633113   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_GUEST_LDTR_SELECTOR:      0x0000000000000000
I0423 11:42:42.633128   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_GUEST_LDTR_LIMIT:         0x000000000000ffff
I0423 11:42:42.633142   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_GUEST_LDTR_ACCESS_RIGHTS: 0x0000000000000082
I0423 11:42:42.633157   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_GUEST_LDTR_BASE:          0x0000000000000000
I0423 11:42:42.633170   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_GUEST_TR_SELECTOR:        0x0000000000000000
I0423 11:42:42.633186   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_GUEST_TR_LIMIT:           0x0000000000000000
I0423 11:42:42.633199   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_GUEST_TR_ACCESS_RIGHTS:   0x000000000000008b
I0423 11:42:42.633211   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_GUEST_TR_BASE:            0x0000000000000000
I0423 11:42:42.633224   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_GUEST_GDTR_LIMIT:         0x000000000000001f
I0423 11:42:42.633236   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_GUEST_GDTR_BASE:          0x0000000000002000
I0423 11:42:42.633247   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_GUEST_IDTR_LIMIT:         0x000000000000ffff
I0423 11:42:42.633254   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_GUEST_IDTR_BASE:          0x0000000000000000
I0423 11:42:42.633266   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_GUEST_CR0:                0x0000000000000031
I0423 11:42:42.633291   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_GUEST_CR3:                0x0000000000000000
I0423 11:42:42.633303   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_GUEST_CR4:                0x0000000000002000
I0423 11:42:42.633321   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 VMCS_GUEST_IA32_EFER:          0x0000000000000000
I0423 11:42:42.633336   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42
I0423 11:42:42.633350   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 rip: 0x0000000000de400a rfl: 0x0000000000010013 cr2: 0x0000000000000000
I0423 11:42:42.633365   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 rax: 0x0000000000000000 rbx: 0x0000000000000000 rcx: 0x0000000000000000 rdx: 0x0000000000000f00
I0423 11:42:42.633390   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 rsi: 0x0000000000003010 rdi: 0x0000000000000004 rbp: 0x0000000000200000 rsp: 0x0000000000dff87c
I0423 11:42:42.633411   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 r8:  0x0000000000000000 r9:  0x0000000000000000 r10: 0x0000000000000000 r11: 0x0000000000000000
I0423 11:42:42.633447   77604 main.go:110] libmachine: (minikube) DBG | 2020/04/23 11:42:42 r12: 0x0000000000000000 r13: 0x0000000000000000 r14: 0x0000000000000000 r15: 0x0000000000000000
I0423 11:42:43.562898   77604 cache.go:138] opening:  /Users/yves/.minikube/cache/images/kubernetesui/metrics-scraper_v1.0.2
I0423 11:42:44.495760   77604 main.go:110] libmachine: (minikube) DBG | Attempt 1
I0423 11:42:44.495812   77604 main.go:110] libmachine: (minikube) DBG | exe=/usr/local/bin/docker-machine-driver-hyperkit uid=0
I0423 11:42:44.496439   77604 main.go:110] libmachine: (minikube) DBG | hyperkit pid from json: 77960
I0423 11:42:44.500763   77604 main.go:110] libmachine: (minikube) DBG | hyperkit pid 77960 missing from process table
I0423 11:42:44.500893   77604 fix.go:55] fixHost completed within 2.176727036s
I0423 11:42:44.500933   77604 start.go:77] releasing machines lock for "minikube", held for 2.176824238s

❌  [HYPERKIT_CRASHED] Failed to start hyperkit VM. "minikube start" may fix it. driver start: hyperkit crashed! command line:
  hyperkit 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=minikube

@govargo
Copy link
Contributor

govargo commented Apr 23, 2020

Thank you for sharing.

This looks no error log about starting machine...
Hyperkit with macOS Catalina may have issue (#7303).

In above log, docker driver time outed.

StartHost failed, but will try again: creating host: create host timed out in 120.000000 seconds

However, maybe it's best to be able to get the Docker driver working on your machine

I'm sorry many times. What is your docker's version?

$ which docker && docker version

If it's not latest, please consider upgrading your docker version.

@yveshield
Copy link
Author

yveshield commented Apr 23, 2020

➔  ~ which docker && docker version
/usr/local/bin/docker
Client: Docker Engine - Community
 Version:           19.03.8
 API version:       1.40
 Go version:        go1.12.17
 Git commit:        afacb8b
 Built:             Wed Mar 11 01:21:11 2020
 OS/Arch:           darwin/amd64
 Experimental:      false

Server: Docker Engine - Community
 Engine:
  Version:          19.03.8
  API version:      1.40 (minimum version 1.12)
  Go version:       go1.12.17
  Git commit:       afacb8b
  Built:            Wed Mar 11 01:29:16 2020
  OS/Arch:          linux/amd64
  Experimental:     false
 containerd:
  Version:          v1.2.13
  GitCommit:        7ad184331fa3e55e52b890ea95e65ba581ae3429
 runc:
  Version:          1.0.0-rc10
  GitCommit:        dc9208a3303feef5b3839f4323d9beb36df0a9dd
 docker-init:
  Version:          0.18.0
  GitCommit:        fec3683

@govargo
Copy link
Contributor

govargo commented Apr 23, 2020

Thank you sharing.
Your docker version looks no problem.


Now it looks there is a problem which cannot access artifact repository.

HTTP_PROXY=http://127.0.0.1:6152 HTTPS_PROXY=http://127.0.0.1:6152 NO_PROXY=localhost,127.0.0.1,10.96.0.0/12,192.168.99.0/24,192.168.39.0/24
E0422 11:40:23.244391 28666 cache.go:114] Error downloading kic artifacts: getting remote image: Get "https://gcr.io/v2/": dial tcp 108.177.97.82:443: i/o timeout

Could you check if you can access https://gcr.io/v2/ with your proxy?

# check method
curl -vvv https://gcr.io/v2/ -x ${HTTPS_PROXY}
(if you can get 401 {"code":"UNAUTHORIZED","message":"Unauthorized access."}, access is success. if you get time out, access is failed)

If you cannot access with your proxy, please try once more minikube delete && minikube start --alsologtostderr -v=1 with NO_PROXY=localhost,127.0.0.1,10.96.0.0/12,192.168.99.0/24,192.168.39.0/24,gcr.io.

@yveshield
Copy link
Author

yes. I got 401

{"errors":[{"code":"UNAUTHORIZED","message":"Unauthorized access."}]}* Closing connection 0

If I Use proxy env variable NO_PROXY == 'localhost,127.0.0.1,10.96.0.0/12,192.168.99.0/24,192.168.39.0/24,gcr.io'
got "curl: (7) Failed to connect to gcr.io port 443: Operation timed out"

@yveshield
Copy link
Author

I got this msg

I0423 23:21:55.695820   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 fcntl(F_PUNCHHOLE) failed: host filesystem does not support sparse files: Operation not permitted

in the latest log

I0423 23:21:52.853102   97953 notify.go:125] Checking for updates...
I0423 23:21:55.244272   97953 start.go:262] hostinfo: {"hostname":"Gordon-MacBook-Pro.local","uptime":15021,"bootTime":1587640294,"procs":457,"os":"darwin","platform":"darwin","platformFamily":"","platformVersion":"10.15.4","kernelVersion":"19.4.0","virtualizationSystem":"","virtualizationRole":"","hostid":"ab0aa7ee-3d03-3c21-91ad-5719d79d7af6"}
W0423 23:21:55.244396   97953 start.go:270] gopshost.Virtualization returned error: not implemented yet
😄  minikube v1.9.2 on Darwin 10.15.4
I0423 23:21:55.267139   97953 main.go:110] libmachine: Found binary path at /usr/local/bin/docker-machine-driver-hyperkit
I0423 23:21:55.267216   97953 main.go:110] libmachine: Launching plugin server for driver hyperkit
I0423 23:21:55.285015   97953 main.go:110] libmachine: Plugin server listening at address 127.0.0.1:55488
I0423 23:21:55.285507   97953 main.go:110] libmachine: () Calling .GetVersion
I0423 23:21:55.286146   97953 main.go:110] libmachine: Using API Version  1
I0423 23:21:55.286158   97953 main.go:110] libmachine: () Calling .SetConfigRaw
I0423 23:21:55.286435   97953 main.go:110] libmachine: () Calling .GetMachineName
I0423 23:21:55.286553   97953 main.go:110] libmachine: (minikube) Calling .DriverName
I0423 23:21:55.286666   97953 driver.go:245] Setting default libvirt URI to qemu:///system
I0423 23:21:55.287073   97953 main.go:110] libmachine: Found binary path at /usr/local/bin/docker-machine-driver-hyperkit
I0423 23:21:55.287096   97953 main.go:110] libmachine: Launching plugin server for driver hyperkit
I0423 23:21:55.307240   97953 main.go:110] libmachine: Plugin server listening at address 127.0.0.1:55492
I0423 23:21:55.307708   97953 main.go:110] libmachine: () Calling .GetVersion
I0423 23:21:55.308353   97953 main.go:110] libmachine: Using API Version  1
I0423 23:21:55.308405   97953 main.go:110] libmachine: () Calling .SetConfigRaw
I0423 23:21:55.308663   97953 main.go:110] libmachine: () Calling .GetMachineName
I0423 23:21:55.308789   97953 main.go:110] libmachine: (minikube) Calling .DriverName
✨  Using the hyperkit driver based on existing profile
I0423 23:21:55.348065   97953 start.go:310] selected driver: hyperkit
I0423 23:21:55.348080   97953 start.go:656] validating driver "hyperkit" against &{Name:minikube KeepContext:false EmbedCerts:false MinikubeISO:https://storage.googleapis.com/minikube/iso/minikube-v1.9.0.iso Memory:4000 CPUs:2 DiskSize:20000 Driver:hyperkit HyperkitVpnKitSock: HyperkitVSockPorts:[] DockerEnv:[NO_PROXY=localhost,127.0.0.1,10.96.0.0/12,192.168.99.0/24,192.168.39.0/24 HTTPS_PROXY=http://127.0.0.1:6152] InsecureRegistry:[] RegistryMirror:[] HostOnlyCIDR:192.168.99.1/24 HypervVirtualSwitch: HypervUseExternalSwitch:false HypervExternalAdapter: KVMNetwork:default KVMQemuURI:qemu:///system KVMGPU:false KVMHidden:false DockerOpt:[] DisableDriverMounts:false NFSShare:[] NFSSharesRoot:/nfsshares UUID: NoVTXCheck:false DNSProxy:false HostDNSResolver:true HostOnlyNicType:virtio NatNicType:virtio KubernetesConfig:{KubernetesVersion:v1.18.0 ClusterName:minikube APIServerName:minikubeCA APIServerNames:[] APIServerIPs:[] DNSDomain:cluster.local ContainerRuntime:docker CRISocket: NetworkPlugin: FeatureGates: ServiceCIDR:10.96.0.0/12 ImageRepository: ExtraOptions:[] ShouldLoadCachedImages:true EnableDefaultCNI:false NodeIP: NodePort:0 NodeName:} Nodes:[{Name:m01 IP: Port:8443 KubernetesVersion:v1.18.0 ControlPlane:true Worker:true}] Addons:map[] VerifyComponents:map[apiserver:true system_pods:true]}
I0423 23:21:55.348204   97953 start.go:662] status for hyperkit: {Installed:true Healthy:true Error:<nil> Fix: Doc:}
I0423 23:21:55.348316   97953 install.go:49] acquiring lock: {Name:mk4023283b30b374c3f04c8805d539e68824c0b8 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I0423 23:21:55.348646   97953 install.go:115] Validating docker-machine-driver-hyperkit, PATH=/Users/yves/.minikube/bin:/usr/local/opt/binutils/bin:/usr/local/opt/python/libexec/bin:/usr/local/sbin:/usr/local/opt/mysql@5.7/bin:/usr/local/opt/mysql@5.7/bin:/usr/local/bin:/usr/bin:/bin:/usr/sbin:/sbin:/Applications/VMware Fusion.app/Contents/Public:/usr/local/MacGPG2/bin:/opt/X11/bin
I0423 23:21:55.376795   97953 install.go:77] stdout: /usr/local/bin/docker-machine-driver-hyperkit
I0423 23:21:55.376830   97953 install.go:79] /usr/local/bin/docker-machine-driver-hyperkit looks good
I0423 23:21:55.376930   97953 start.go:1004] Using suggested 4000MB memory alloc based on sys=16384MB, container=0MB
I0423 23:21:55.377034   97953 start.go:1210] Wait components to verify : map[apiserver:true system_pods:true]
I0423 23:21:55.377071   97953 iso.go:119] acquiring lock: {Name:mkc66493fd5a14eb3815b1fcc2805060061fd975 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
👍  Starting control plane node m01 in cluster minikube
I0423 23:21:55.388240   97953 preload.go:81] Checking if preload exists for k8s version v1.18.0 and runtime docker
I0423 23:21:55.388310   97953 preload.go:97] Found local preload: /Users/yves/.minikube/cache/preloaded-tarball/preloaded-images-k8s-v2-v1.18.0-docker-overlay2-amd64.tar.lz4
I0423 23:21:55.388325   97953 cache.go:46] Caching tarball of preloaded images
I0423 23:21:55.388344   97953 preload.go:123] Found /Users/yves/.minikube/cache/preloaded-tarball/preloaded-images-k8s-v2-v1.18.0-docker-overlay2-amd64.tar.lz4 in cache, skipping download
I0423 23:21:55.388352   97953 cache.go:49] Finished downloading the preloaded tar for v1.18.0 on docker
I0423 23:21:55.388479   97953 profile.go:138] Saving config to /Users/yves/.minikube/profiles/minikube/config.json ...
I0423 23:21:55.389438   97953 cache.go:117] Successfully downloaded all kic artifacts
I0423 23:21:55.389476   97953 start.go:260] acquiring machines lock for minikube: {Name:mkdd7a8a1ff4814687d3c0149520cd20cd24b807 Clock:{} Delay:500ms Timeout:15m0s Cancel:<nil>}
I0423 23:21:55.389581   97953 start.go:264] acquired machines lock for "minikube" in 89.984µs
I0423 23:21:55.389618   97953 start.go:90] Skipping create...Using existing machine configuration
I0423 23:21:55.389631   97953 fix.go:53] fixHost starting: m01
I0423 23:21:55.390275   97953 main.go:110] libmachine: Found binary path at /usr/local/bin/docker-machine-driver-hyperkit
I0423 23:21:55.390323   97953 main.go:110] libmachine: Launching plugin server for driver hyperkit
I0423 23:21:55.407100   97953 main.go:110] libmachine: Plugin server listening at address 127.0.0.1:55496
I0423 23:21:55.407557   97953 main.go:110] libmachine: () Calling .GetVersion
I0423 23:21:55.408025   97953 main.go:110] libmachine: Using API Version  1
I0423 23:21:55.408043   97953 main.go:110] libmachine: () Calling .SetConfigRaw
I0423 23:21:55.408315   97953 main.go:110] libmachine: () Calling .GetMachineName
I0423 23:21:55.408451   97953 main.go:110] libmachine: (minikube) Calling .DriverName
I0423 23:21:55.408601   97953 main.go:110] libmachine: (minikube) Calling .GetState
I0423 23:21:55.408747   97953 main.go:110] libmachine: (minikube) DBG | exe=/usr/local/bin/docker-machine-driver-hyperkit uid=0
I0423 23:21:55.409043   97953 main.go:110] libmachine: (minikube) DBG | hyperkit pid from json: 96295
I0423 23:21:55.410191   97953 main.go:110] libmachine: (minikube) DBG | hyperkit pid 96295 missing from process table
I0423 23:21:55.410235   97953 fix.go:105] recreateIfNeeded on minikube: state=Stopped err=<nil>
I0423 23:21:55.410268   97953 main.go:110] libmachine: (minikube) Calling .DriverName
I0423 23:21:55.410398   97953 fix.go:109] exists: true err=<nil>
I0423 23:21:55.410406   97953 fix.go:110] %!q(<nil>) vs "machine does not exist"
W0423 23:21:55.410411   97953 fix.go:130] unexpected machine state, will restart: <nil>
🔄  Restarting existing hyperkit VM for "minikube" ...
I0423 23:21:55.432065   97953 main.go:110] libmachine: (minikube) Calling .Start
I0423 23:21:55.432334   97953 main.go:110] libmachine: (minikube) DBG | exe=/usr/local/bin/docker-machine-driver-hyperkit uid=0
I0423 23:21:55.432396   97953 main.go:110] libmachine: (minikube) minikube might have been shutdown in an unclean way, the hyperkit pid file still exists: /Users/yves/.minikube/machines/minikube/hyperkit.pid
I0423 23:21:55.434122   97953 main.go:110] libmachine: (minikube) DBG | hyperkit pid 96295 missing from process table
I0423 23:21:55.434140   97953 main.go:110] libmachine: (minikube) DBG | pid 96295 is in state "Stopped"
I0423 23:21:55.434161   97953 main.go:110] libmachine: (minikube) DBG | Removing stale pid file /Users/yves/.minikube/machines/minikube/hyperkit.pid...
I0423 23:21:55.434712   97953 main.go:110] libmachine: (minikube) DBG | Using UUID 37121786-8575-11ea-a26d-acde48001122
I0423 23:21:55.637165   97953 main.go:110] libmachine: (minikube) DBG | Generated MAC 76:2:7b:8e:eb:8e
I0423 23:21:55.637210   97953 main.go:110] libmachine: (minikube) 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=minikube
I0423 23:21:55.639692   97953 main.go:110] libmachine: (minikube) DBG | Attempt 0
I0423 23:21:55.639737   97953 main.go:110] libmachine: (minikube) DBG | exe=/usr/local/bin/docker-machine-driver-hyperkit uid=0
I0423 23:21:55.639830   97953 main.go:110] libmachine: (minikube) DBG | hyperkit pid from json: 98014
I0423 23:21:55.641617   97953 main.go:110] libmachine: (minikube) DBG | Searching for 76:2:7b:8e:eb:8e in /var/db/dhcpd_leases ...
I0423 23:21:55.641665   97953 main.go:110] libmachine: (minikube) DBG | Found 1 entries in /var/db/dhcpd_leases!
I0423 23:21:55.641689   97953 main.go:110] libmachine: (minikube) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.2 HWAddress:5e:fc:d8:d:9a:80 ID:1,5e:fc:d8:d:9a:80 Lease:0x5ea06d90}
I0423 23:21:55.695820   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 fcntl(F_PUNCHHOLE) failed: host filesystem does not support sparse files: Operation not permitted
I0423 23:21:55.781423   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 Failed to emulate instruction [0x82 0x51 0xa5 0xad] at 0xde400a
I0423 23:21:55.781448   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 linkname /Users/yves/.minikube/machines/minikube/tty
I0423 23:21:55.781467   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 COM1 connected to /dev/ttys000
I0423 23:21:55.781480   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 COM1 linked to /Users/yves/.minikube/machines/minikube/tty
I0423 23:21:55.781492   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_PIN_BASED_CTLS:           0x000000000000003f
I0423 23:21:55.781502   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_PRI_PROC_BASED_CTLS:      0x00000000b5186dfa
I0423 23:21:55.781514   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_SEC_PROC_BASED_CTLS:      0x00000000000000aa
I0423 23:21:55.781523   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_ENTRY_CTLS:               0x00000000000091ff
I0423 23:21:55.781556   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_EXCEPTION_BITMAP:         0x0000000000040000
I0423 23:21:55.781590   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_CR0_MASK:                 0x00000000e0000031
I0423 23:21:55.781618   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_CR0_SHADOW:               0x0000000000000021
I0423 23:21:55.781634   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_CR4_MASK:                 0x0000000000002000
I0423 23:21:55.781650   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_CR4_SHADOW:               0x0000000000000000
I0423 23:21:55.781663   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_GUEST_PHYSICAL_ADDRESS:   0x00000000ffffffa5
I0423 23:21:55.781678   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_GUEST_LINEAR_ADDRESS:     0x00000000ffffffa5
I0423 23:21:55.781703   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_GUEST_CS_SELECTOR:        0x0000000000000010
I0423 23:21:55.781730   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_GUEST_CS_LIMIT:           0x00000000ffffffff
I0423 23:21:55.781743   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_GUEST_CS_ACCESS_RIGHTS:   0x000000000000c09b
I0423 23:21:55.781755   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_GUEST_CS_BASE:            0x0000000000000000
I0423 23:21:55.781773   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_GUEST_DS_SELECTOR:        0x0000000000000018
I0423 23:21:55.781786   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_GUEST_DS_LIMIT:           0x00000000ffffffff
I0423 23:21:55.781800   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_GUEST_DS_ACCESS_RIGHTS:   0x000000000000c093
I0423 23:21:55.781812   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_GUEST_DS_BASE:            0x0000000000000000
I0423 23:21:55.781822   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_GUEST_ES_SELECTOR:        0x0000000000000018
I0423 23:21:55.781833   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_GUEST_ES_LIMIT:           0x00000000ffffffff
I0423 23:21:55.781845   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_GUEST_ES_ACCESS_RIGHTS:   0x000000000000c093
I0423 23:21:55.781856   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_GUEST_ES_BASE:            0x0000000000000000
I0423 23:21:55.781866   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_GUEST_FS_SELECTOR:        0x0000000000000000
I0423 23:21:55.781884   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_GUEST_FS_LIMIT:           0x000000000000ffff
I0423 23:21:55.781895   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_GUEST_FS_ACCESS_RIGHTS:   0x0000000000000093
I0423 23:21:55.781910   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_GUEST_FS_BASE:            0x0000000000000000
I0423 23:21:55.781922   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_GUEST_GS_SELECTOR:        0x0000000000000000
I0423 23:21:55.781934   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_GUEST_GS_LIMIT:           0x000000000000ffff
I0423 23:21:55.781944   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_GUEST_GS_ACCESS_RIGHTS:   0x0000000000000093
I0423 23:21:55.781956   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_GUEST_GS_BASE:            0x0000000000000000
I0423 23:21:55.781965   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_GUEST_SS_SELECTOR:        0x0000000000000018
I0423 23:21:55.781976   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_GUEST_SS_LIMIT:           0x00000000ffffffff
I0423 23:21:55.781986   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_GUEST_SS_ACCESS_RIGHTS:   0x000000000000c093
I0423 23:21:55.781998   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_GUEST_SS_BASE:            0x0000000000000000
I0423 23:21:55.782008   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_GUEST_LDTR_SELECTOR:      0x0000000000000000
I0423 23:21:55.782019   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_GUEST_LDTR_LIMIT:         0x000000000000ffff
I0423 23:21:55.782031   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_GUEST_LDTR_ACCESS_RIGHTS: 0x0000000000000082
I0423 23:21:55.782051   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_GUEST_LDTR_BASE:          0x0000000000000000
I0423 23:21:55.782065   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_GUEST_TR_SELECTOR:        0x0000000000000000
I0423 23:21:55.782078   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_GUEST_TR_LIMIT:           0x0000000000000000
I0423 23:21:55.782094   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_GUEST_TR_ACCESS_RIGHTS:   0x000000000000008b
I0423 23:21:55.782106   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_GUEST_TR_BASE:            0x0000000000000000
I0423 23:21:55.782118   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_GUEST_GDTR_LIMIT:         0x000000000000001f
I0423 23:21:55.782130   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_GUEST_GDTR_BASE:          0x0000000000002000
I0423 23:21:55.782141   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_GUEST_IDTR_LIMIT:         0x000000000000ffff
I0423 23:21:55.782150   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_GUEST_IDTR_BASE:          0x0000000000000000
I0423 23:21:55.782157   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_GUEST_CR0:                0x0000000000000031
I0423 23:21:55.782164   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_GUEST_CR3:                0x0000000000000000
I0423 23:21:55.782170   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_GUEST_CR4:                0x0000000000002000
I0423 23:21:55.782177   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 VMCS_GUEST_IA32_EFER:          0x0000000000000000
I0423 23:21:55.782185   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55
I0423 23:21:55.782194   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 rip: 0x0000000000de400a rfl: 0x0000000000010013 cr2: 0x0000000000000000
I0423 23:21:55.782203   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 rax: 0x0000000000000000 rbx: 0x0000000000000000 rcx: 0x0000000000000000 rdx: 0x0000000000000f00
I0423 23:21:55.782211   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 rsi: 0x0000000000003010 rdi: 0x0000000000000004 rbp: 0x0000000000200000 rsp: 0x0000000000dff87c
I0423 23:21:55.782220   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 r8:  0x0000000000000000 r9:  0x0000000000000000 r10: 0x0000000000000000 r11: 0x0000000000000000
I0423 23:21:55.782229   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:21:55 r12: 0x0000000000000000 r13: 0x0000000000000000 r14: 0x0000000000000000 r15: 0x0000000000000000
I0423 23:21:57.641899   97953 main.go:110] libmachine: (minikube) DBG | Attempt 1
I0423 23:21:57.641965   97953 main.go:110] libmachine: (minikube) DBG | exe=/usr/local/bin/docker-machine-driver-hyperkit uid=0
I0423 23:21:57.642280   97953 main.go:110] libmachine: (minikube) DBG | hyperkit pid from json: 98014
I0423 23:21:57.645297   97953 main.go:110] libmachine: (minikube) DBG | hyperkit pid 98014 missing from process table
I0423 23:21:57.645439   97953 fix.go:55] fixHost completed within 2.255762387s
I0423 23:21:57.645459   97953 start.go:77] releasing machines lock for "minikube", held for 2.255840832s
🤦  StartHost failed, but will try again: driver start: hyperkit crashed! command line:
  hyperkit 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=minikube
I0423 23:22:02.645955   97953 start.go:260] acquiring machines lock for minikube: {Name:mkdd7a8a1ff4814687d3c0149520cd20cd24b807 Clock:{} Delay:500ms Timeout:15m0s Cancel:<nil>}
I0423 23:22:02.646241   97953 start.go:264] acquired machines lock for "minikube" in 226.448µs
I0423 23:22:02.646323   97953 start.go:90] Skipping create...Using existing machine configuration
I0423 23:22:02.646342   97953 fix.go:53] fixHost starting: m01
I0423 23:22:02.647776   97953 main.go:110] libmachine: Found binary path at /usr/local/bin/docker-machine-driver-hyperkit
I0423 23:22:02.647898   97953 main.go:110] libmachine: Launching plugin server for driver hyperkit
I0423 23:22:02.669588   97953 main.go:110] libmachine: Plugin server listening at address 127.0.0.1:55500
I0423 23:22:02.670155   97953 main.go:110] libmachine: () Calling .GetVersion
I0423 23:22:02.670760   97953 main.go:110] libmachine: Using API Version  1
I0423 23:22:02.670778   97953 main.go:110] libmachine: () Calling .SetConfigRaw
I0423 23:22:02.671117   97953 main.go:110] libmachine: () Calling .GetMachineName
I0423 23:22:02.671296   97953 main.go:110] libmachine: (minikube) Calling .DriverName
I0423 23:22:02.671432   97953 main.go:110] libmachine: (minikube) Calling .GetState
I0423 23:22:02.671565   97953 main.go:110] libmachine: (minikube) DBG | exe=/usr/local/bin/docker-machine-driver-hyperkit uid=0
I0423 23:22:02.671894   97953 main.go:110] libmachine: (minikube) DBG | hyperkit pid from json: 98014
I0423 23:22:02.673264   97953 main.go:110] libmachine: (minikube) DBG | hyperkit pid 98014 missing from process table
I0423 23:22:02.673322   97953 fix.go:105] recreateIfNeeded on minikube: state=Stopped err=<nil>
I0423 23:22:02.673344   97953 main.go:110] libmachine: (minikube) Calling .DriverName
I0423 23:22:02.673514   97953 fix.go:109] exists: true err=<nil>
I0423 23:22:02.673536   97953 fix.go:110] %!q(<nil>) vs "machine does not exist"
W0423 23:22:02.673553   97953 fix.go:130] unexpected machine state, will restart: <nil>
🔄  Restarting existing hyperkit VM for "minikube" ...
I0423 23:22:02.697040   97953 main.go:110] libmachine: (minikube) Calling .Start
I0423 23:22:02.697399   97953 main.go:110] libmachine: (minikube) DBG | exe=/usr/local/bin/docker-machine-driver-hyperkit uid=0
I0423 23:22:02.697507   97953 main.go:110] libmachine: (minikube) minikube might have been shutdown in an unclean way, the hyperkit pid file still exists: /Users/yves/.minikube/machines/minikube/hyperkit.pid
I0423 23:22:02.700018   97953 main.go:110] libmachine: (minikube) DBG | hyperkit pid 98014 missing from process table
I0423 23:22:02.700064   97953 main.go:110] libmachine: (minikube) DBG | pid 98014 is in state "Stopped"
I0423 23:22:02.700109   97953 main.go:110] libmachine: (minikube) DBG | Removing stale pid file /Users/yves/.minikube/machines/minikube/hyperkit.pid...
I0423 23:22:02.700920   97953 main.go:110] libmachine: (minikube) DBG | Using UUID 37121786-8575-11ea-a26d-acde48001122
I0423 23:22:02.802727   97953 main.go:110] libmachine: (minikube) DBG | Generated MAC 76:2:7b:8e:eb:8e
I0423 23:22:02.802779   97953 main.go:110] libmachine: (minikube) 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=minikube
I0423 23:22:02.804996   97953 main.go:110] libmachine: (minikube) DBG | Attempt 0
I0423 23:22:02.805051   97953 main.go:110] libmachine: (minikube) DBG | exe=/usr/local/bin/docker-machine-driver-hyperkit uid=0
I0423 23:22:02.805181   97953 main.go:110] libmachine: (minikube) DBG | hyperkit pid from json: 98083
I0423 23:22:02.807028   97953 main.go:110] libmachine: (minikube) DBG | Searching for 76:2:7b:8e:eb:8e in /var/db/dhcpd_leases ...
I0423 23:22:02.807071   97953 main.go:110] libmachine: (minikube) DBG | Found 1 entries in /var/db/dhcpd_leases!
I0423 23:22:02.807100   97953 main.go:110] libmachine: (minikube) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.2 HWAddress:5e:fc:d8:d:9a:80 ID:1,5e:fc:d8:d:9a:80 Lease:0x5ea06d90}
I0423 23:22:02.865507   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 fcntl(F_PUNCHHOLE) failed: host filesystem does not support sparse files: Operation not permitted
I0423 23:22:02.947009   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 Failed to emulate instruction [0x82 0x51 0xa5 0xad] at 0xde400a
I0423 23:22:02.947040   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 linkname /Users/yves/.minikube/machines/minikube/tty
I0423 23:22:02.947063   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 COM1 connected to /dev/ttys000
I0423 23:22:02.947075   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 COM1 linked to /Users/yves/.minikube/machines/minikube/tty
I0423 23:22:02.947088   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_PIN_BASED_CTLS:           0x000000000000003f
I0423 23:22:02.947154   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_PRI_PROC_BASED_CTLS:      0x00000000b5186dfa
I0423 23:22:02.947171   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_SEC_PROC_BASED_CTLS:      0x00000000000000aa
I0423 23:22:02.947191   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_ENTRY_CTLS:               0x00000000000091ff
I0423 23:22:02.947202   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_EXCEPTION_BITMAP:         0x0000000000040000
I0423 23:22:02.947273   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_CR0_MASK:                 0x00000000e0000031
I0423 23:22:02.947291   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_CR0_SHADOW:               0x0000000000000021
I0423 23:22:02.947315   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_CR4_MASK:                 0x0000000000002000
I0423 23:22:02.947340   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_CR4_SHADOW:               0x0000000000000000
I0423 23:22:02.947367   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_GUEST_PHYSICAL_ADDRESS:   0x00000000ffffffa5
I0423 23:22:02.947383   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_GUEST_LINEAR_ADDRESS:     0x00000000ffffffa5
I0423 23:22:02.947404   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_GUEST_CS_SELECTOR:        0x0000000000000010
I0423 23:22:02.947419   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_GUEST_CS_LIMIT:           0x00000000ffffffff
I0423 23:22:02.947443   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_GUEST_CS_ACCESS_RIGHTS:   0x000000000000c09b
I0423 23:22:02.947458   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_GUEST_CS_BASE:            0x0000000000000000
I0423 23:22:02.947478   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_GUEST_DS_SELECTOR:        0x0000000000000018
I0423 23:22:02.947491   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_GUEST_DS_LIMIT:           0x00000000ffffffff
I0423 23:22:02.947503   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_GUEST_DS_ACCESS_RIGHTS:   0x000000000000c093
I0423 23:22:02.947513   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_GUEST_DS_BASE:            0x0000000000000000
I0423 23:22:02.947532   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_GUEST_ES_SELECTOR:        0x0000000000000018
I0423 23:22:02.947555   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_GUEST_ES_LIMIT:           0x00000000ffffffff
I0423 23:22:02.947568   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_GUEST_ES_ACCESS_RIGHTS:   0x000000000000c093
I0423 23:22:02.947579   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_GUEST_ES_BASE:            0x0000000000000000
I0423 23:22:02.947590   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_GUEST_FS_SELECTOR:        0x0000000000000000
I0423 23:22:02.947608   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_GUEST_FS_LIMIT:           0x000000000000ffff
I0423 23:22:02.947620   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_GUEST_FS_ACCESS_RIGHTS:   0x0000000000000093
I0423 23:22:02.947631   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_GUEST_FS_BASE:            0x0000000000000000
I0423 23:22:02.947640   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_GUEST_GS_SELECTOR:        0x0000000000000000
I0423 23:22:02.947656   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_GUEST_GS_LIMIT:           0x000000000000ffff
I0423 23:22:02.947669   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_GUEST_GS_ACCESS_RIGHTS:   0x0000000000000093
I0423 23:22:02.947680   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_GUEST_GS_BASE:            0x0000000000000000
I0423 23:22:02.947692   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_GUEST_SS_SELECTOR:        0x0000000000000018
I0423 23:22:02.947703   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_GUEST_SS_LIMIT:           0x00000000ffffffff
I0423 23:22:02.947715   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_GUEST_SS_ACCESS_RIGHTS:   0x000000000000c093
I0423 23:22:02.947725   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_GUEST_SS_BASE:            0x0000000000000000
I0423 23:22:02.947736   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_GUEST_LDTR_SELECTOR:      0x0000000000000000
I0423 23:22:02.947752   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_GUEST_LDTR_LIMIT:         0x000000000000ffff
I0423 23:22:02.947764   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_GUEST_LDTR_ACCESS_RIGHTS: 0x0000000000000082
I0423 23:22:02.947777   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_GUEST_LDTR_BASE:          0x0000000000000000
I0423 23:22:02.947787   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_GUEST_TR_SELECTOR:        0x0000000000000000
I0423 23:22:02.947797   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_GUEST_TR_LIMIT:           0x0000000000000000
I0423 23:22:02.947809   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_GUEST_TR_ACCESS_RIGHTS:   0x000000000000008b
I0423 23:22:02.947819   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_GUEST_TR_BASE:            0x0000000000000000
I0423 23:22:02.947830   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_GUEST_GDTR_LIMIT:         0x000000000000001f
I0423 23:22:02.947843   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_GUEST_GDTR_BASE:          0x0000000000002000
I0423 23:22:02.947855   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_GUEST_IDTR_LIMIT:         0x000000000000ffff
I0423 23:22:02.947866   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_GUEST_IDTR_BASE:          0x0000000000000000
I0423 23:22:02.947878   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_GUEST_CR0:                0x0000000000000031
I0423 23:22:02.947890   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_GUEST_CR3:                0x0000000000000000
I0423 23:22:02.947906   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_GUEST_CR4:                0x0000000000002000
I0423 23:22:02.947918   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 VMCS_GUEST_IA32_EFER:          0x0000000000000000
I0423 23:22:02.947928   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02
I0423 23:22:02.947946   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 rip: 0x0000000000de400a rfl: 0x0000000000010013 cr2: 0x0000000000000000
I0423 23:22:02.947960   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 rax: 0x0000000000000000 rbx: 0x0000000000000000 rcx: 0x0000000000000000 rdx: 0x0000000000000f00
I0423 23:22:02.947973   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 rsi: 0x0000000000003010 rdi: 0x0000000000000004 rbp: 0x0000000000200000 rsp: 0x0000000000dff87c
I0423 23:22:02.947988   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 r8:  0x0000000000000000 r9:  0x0000000000000000 r10: 0x0000000000000000 r11: 0x0000000000000000
I0423 23:22:02.948003   97953 main.go:110] libmachine: (minikube) DBG | 2020/04/23 23:22:02 r12: 0x0000000000000000 r13: 0x0000000000000000 r14: 0x0000000000000000 r15: 0x0000000000000000
I0423 23:22:04.812393   97953 main.go:110] libmachine: (minikube) DBG | Attempt 1
I0423 23:22:04.812466   97953 main.go:110] libmachine: (minikube) DBG | exe=/usr/local/bin/docker-machine-driver-hyperkit uid=0
I0423 23:22:04.812894   97953 main.go:110] libmachine: (minikube) DBG | hyperkit pid from json: 98083
I0423 23:22:04.816927   97953 main.go:110] libmachine: (minikube) DBG | hyperkit pid 98083 missing from process table
I0423 23:22:04.817106   97953 fix.go:55] fixHost completed within 2.170742864s
I0423 23:22:04.817133   97953 start.go:77] releasing machines lock for "minikube", held for 2.170833451s

❌  [HYPERKIT_CRASHED] Failed to start hyperkit VM. "minikube start" may fix it. driver start: hyperkit crashed! command line:
  hyperkit 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=minikube

@govargo
Copy link
Contributor

govargo commented Apr 23, 2020

failed: host filesystem does not support sparse files

The above error is returned the docker-machine-driver-hyperkit.
This is located in ~/.minikube/bin/docker-machine-driver-hyperkit.

Could you check ~/.minikube/bin/docker-machine-driver-hyperkit version?
If it's old, those error may occur.

Or if the root cause is filesystem something, rm -rf ~/.minikube && minikube start may come to be the final solution...

@yveshield
Copy link
Author

➔  ~ ls .minikube/bin
[EMPTY]
➔  ~ which docker-machine-driver-hyperkit
/usr/local/bin/docker-machine-driver-hyperkit
➔  ~ ls -lad /usr/local/bin/docker-machine-driver-hyperkit
-rwsr-xr-x  1 root  wheel  11428724 Apr 23 10:45 /usr/local/bin/docker-machine-driver-hyperkit
➔  ~ /usr/local/bin/docker-machine-driver-hyperkit version
version: v1.9.2
commit: 93af9c1e43cab9618e301bc9fa720c63d5efa393

@govargo govargo added kind/bug Categorizes issue or PR as related to a bug. needs-solution-message Issues where where offering a solution for an error would be helpful os/macos labels Apr 23, 2020
@govargo
Copy link
Contributor

govargo commented Apr 23, 2020

Thank you sharing.
It looks like no problem with docker-machine-driver-hyperkit.

Now I don't understand what is root cause but I think this is bug or this is missing more detail of error.

hyperkit pid 98083 missing from process table.

I relabled this issue.
Sorry for waiting until our contributor solve this.

@govargo
Copy link
Contributor

govargo commented Apr 23, 2020

If you can share more verbose output, please share the following command output?

minikube start --driver hyperkit --alsologtostderr -v=10

@yveshield
Copy link
Author

The download took all night and still failed.
I Use proxy env variable NO_PROXY == 'localhost,127.0.0.1,10.96.0.0/12,192.168.99.0/24,192.168.39.0/24,storage.googleapis.com

Now

🏄 Done! kubectl is now configured to use "minikube"

It's all about the proxy.

Thank you very much for your help and your time these days.

@govargo govargo added cause/firewall-or-proxy When firewalls or proxies seem to be interfering and removed kind/bug Categorizes issue or PR as related to a bug. labels Apr 24, 2020
@govargo
Copy link
Contributor

govargo commented Apr 24, 2020

I Use proxy env variable NO_PROXY == 'localhost,127.0.0.1,10.96.0.0/12,192.168.99.0/24,192.168.39.0/24,storage.googleapis.com

Now

🏄 Done! kubectl is now configured to use "minikube"

It's all about the proxy.

Thank you for sharing.
Sorry it took long time to notice. This notice helped if other people face similar issue.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
cause/firewall-or-proxy When firewalls or proxies seem to be interfering co/hyperkit Hyperkit related issues kind/support Categorizes issue or PR as a support question. needs-solution-message Issues where where offering a solution for an error would be helpful os/macos
Projects
None yet
Development

No branches or pull requests

3 participants