=== RUN TestNetworkPlugins/group/calico/Start
net_test.go:112: (dbg) Run: out/minikube-darwin-amd64 start -p calico-745000 --memory=3072 --alsologtostderr --wait=true --wait-timeout=15m --cni=calico --driver=hyperkit
net_test.go:112: (dbg) Non-zero exit: out/minikube-darwin-amd64 start -p calico-745000 --memory=3072 --alsologtostderr --wait=true --wait-timeout=15m --cni=calico --driver=hyperkit : exit status 90 (14.88226057s)
-- stdout --
* [calico-745000] minikube v1.31.2 on Darwin 13.5.2
- MINIKUBE_LOCATION=17240
- KUBECONFIG=/Users/jenkins/minikube-integration/17240-937/kubeconfig
- MINIKUBE_BIN=out/minikube-darwin-amd64
- MINIKUBE_SUPPRESS_DOCKER_PERFORMANCE=true
- MINIKUBE_HOME=/Users/jenkins/minikube-integration/17240-937/.minikube
- MINIKUBE_FORCE_SYSTEMD=
* Using the hyperkit driver based on user configuration
* Starting control plane node calico-745000 in cluster calico-745000
* Creating hyperkit VM (CPUs=2, Memory=3072MB, Disk=20000MB) ...
-- /stdout --
** stderr **
I0919 10:15:07.468554 5780 out.go:296] Setting OutFile to fd 1 ...
I0919 10:15:07.469357 5780 out.go:343] TERM=,COLORTERM=, which probably does not support color
I0919 10:15:07.469365 5780 out.go:309] Setting ErrFile to fd 2...
I0919 10:15:07.469373 5780 out.go:343] TERM=,COLORTERM=, which probably does not support color
I0919 10:15:07.470105 5780 root.go:338] Updating PATH: /Users/jenkins/minikube-integration/17240-937/.minikube/bin
I0919 10:15:07.471890 5780 out.go:303] Setting JSON to false
I0919 10:15:07.493519 5780 start.go:128] hostinfo: {"hostname":"MacOS-Agent-2.local","uptime":2681,"bootTime":1695141026,"procs":408,"os":"darwin","platform":"darwin","platformFamily":"Standalone Workstation","platformVersion":"13.5.2","kernelVersion":"22.6.0","kernelArch":"x86_64","virtualizationSystem":"","virtualizationRole":"","hostId":"2965c349-98a5-5970-aaa9-9eedd3ae5959"}
W0919 10:15:07.493622 5780 start.go:136] gopshost.Virtualization returned error: not implemented yet
I0919 10:15:07.515294 5780 out.go:177] * [calico-745000] minikube v1.31.2 on Darwin 13.5.2
I0919 10:15:07.578128 5780 out.go:177] - MINIKUBE_LOCATION=17240
I0919 10:15:07.557091 5780 notify.go:220] Checking for updates...
I0919 10:15:07.619945 5780 out.go:177] - KUBECONFIG=/Users/jenkins/minikube-integration/17240-937/kubeconfig
I0919 10:15:07.678331 5780 out.go:177] - MINIKUBE_BIN=out/minikube-darwin-amd64
I0919 10:15:07.736404 5780 out.go:177] - MINIKUBE_SUPPRESS_DOCKER_PERFORMANCE=true
I0919 10:15:07.778915 5780 out.go:177] - MINIKUBE_HOME=/Users/jenkins/minikube-integration/17240-937/.minikube
I0919 10:15:07.820035 5780 out.go:177] - MINIKUBE_FORCE_SYSTEMD=
I0919 10:15:07.842017 5780 config.go:182] Loaded profile config "auto-745000": Driver=hyperkit, ContainerRuntime=docker, KubernetesVersion=v1.28.2
I0919 10:15:07.842200 5780 driver.go:373] Setting default libvirt URI to qemu:///system
I0919 10:15:07.870075 5780 out.go:177] * Using the hyperkit driver based on user configuration
I0919 10:15:07.891002 5780 start.go:298] selected driver: hyperkit
I0919 10:15:07.891016 5780 start.go:902] validating driver "hyperkit" against <nil>
I0919 10:15:07.891028 5780 start.go:913] status for hyperkit: {Installed:true Healthy:true Running:true NeedsImprovement:false Error:<nil> Reason: Fix: Doc: Version:}
I0919 10:15:07.893888 5780 install.go:52] acquiring lock: {Name:mk4023283b30b374c3f04c8805d539e68824c0b8 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I0919 10:15:07.894006 5780 install.go:117] Validating docker-machine-driver-hyperkit, PATH=/Users/jenkins/minikube-integration/17240-937/.minikube/bin:/Users/jenkins/workspace/out/:/usr/bin:/bin:/usr/sbin:/sbin:/Users/jenkins/google-cloud-sdk/bin:/usr/local/bin/:/usr/local/go/bin/:/Users/jenkins/go/bin
I0919 10:15:07.901013 5780 install.go:137] /Users/jenkins/workspace/out/docker-machine-driver-hyperkit version is 1.31.2
I0919 10:15:07.904560 5780 install.go:79] stdout: /Users/jenkins/workspace/out/docker-machine-driver-hyperkit
I0919 10:15:07.904579 5780 install.go:81] /Users/jenkins/workspace/out/docker-machine-driver-hyperkit looks good
I0919 10:15:07.904609 5780 start_flags.go:307] no existing cluster config was found, will generate one from the flags
I0919 10:15:07.904827 5780 start_flags.go:922] Waiting for all components: map[apiserver:true apps_running:true default_sa:true extra:true kubelet:true node_ready:true system_pods:true]
I0919 10:15:07.904860 5780 cni.go:84] Creating CNI manager for "calico"
I0919 10:15:07.904867 5780 start_flags.go:316] Found "Calico" CNI - setting NetworkPlugin=cni
I0919 10:15:07.904878 5780 start_flags.go:321] config:
{Name:calico-745000 KeepContext:false EmbedCerts:false MinikubeISO: KicBaseImage:gcr.io/k8s-minikube/kicbase-builds:v0.0.40-1694798187-17250@sha256:8d9a070cda8e1b1082ed355bde1aaf66fbf63d64fa6e9f553f449efc74157fe3 Memory:3072 CPUs:2 DiskSize:20000 VMDriver: Driver:hyperkit HyperkitVpnKitSock: HyperkitVSockPorts:[] DockerEnv:[] ContainerVolumeMounts:[] InsecureRegistry:[] RegistryMirror:[] HostOnlyCIDR:192.168.59.1/24 HypervVirtualSwitch: HypervUseExternalSwitch:false HypervExternalAdapter: KVMNetwork:default KVMQemuURI:qemu:///system KVMGPU:false KVMHidden:false KVMNUMACount:1 APIServerPort:0 DockerOpt:[] DisableDriverMounts:false NFSShare:[] NFSSharesRoot:/nfsshares UUID: NoVTXCheck:false DNSProxy:false HostDNSResolver:true HostOnlyNicType:virtio NatNicType:virtio SSHIPAddress: SSHUser:root SSHKey: SSHPort:22 KubernetesConfig:{KubernetesVersion:v1.28.2 ClusterName:calico-745000 Namespace:default APIServerName:minikubeCA APIServerNames:[] APIServerIPs:[] DNSDomain:cluster.local ContainerRuntime:docker
CRISocket: NetworkPlugin:cni FeatureGates: ServiceCIDR:10.96.0.0/12 ImageRepository: LoadBalancerStartIP: LoadBalancerEndIP: CustomIngressCert: RegistryAliases: ExtraOptions:[] ShouldLoadCachedImages:true EnableDefaultCNI:false CNI:calico NodeIP: NodePort:8443 NodeName:} Nodes:[] Addons:map[] CustomAddonImages:map[] CustomAddonRegistries:map[] VerifyComponents:map[apiserver:true apps_running:true default_sa:true extra:true kubelet:true node_ready:true system_pods:true] StartHostTimeout:15m0s ScheduledStop:<nil> ExposedPorts:[] ListenAddress: Network: Subnet: MultiNodeRequested:false ExtraDisks:0 CertExpiration:26280h0m0s Mount:false MountString:/Users:/minikube-host Mount9PVersion:9p2000.L MountGID:docker MountIP: MountMSize:262144 MountOptions:[] MountPort:0 MountType:9p MountUID:docker BinaryMirror: DisableOptimizations:false DisableMetrics:false CustomQemuFirmwarePath: SocketVMnetClientPath: SocketVMnetPath: StaticIP: SSHAuthSock: SSHAgentPID:0 AutoPauseInterval:1m0s}
I0919 10:15:07.905027 5780 iso.go:125] acquiring lock: {Name:mkd6d6b9bb46213010ae1edd625f82f2df609b8e Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I0919 10:15:07.947004 5780 out.go:177] * Starting control plane node calico-745000 in cluster calico-745000
I0919 10:15:07.967947 5780 preload.go:132] Checking if preload exists for k8s version v1.28.2 and runtime docker
I0919 10:15:07.967991 5780 preload.go:148] Found local preload: /Users/jenkins/minikube-integration/17240-937/.minikube/cache/preloaded-tarball/preloaded-images-k8s-v18-v1.28.2-docker-overlay2-amd64.tar.lz4
I0919 10:15:07.968005 5780 cache.go:57] Caching tarball of preloaded images
I0919 10:15:07.968141 5780 preload.go:174] Found /Users/jenkins/minikube-integration/17240-937/.minikube/cache/preloaded-tarball/preloaded-images-k8s-v18-v1.28.2-docker-overlay2-amd64.tar.lz4 in cache, skipping download
I0919 10:15:07.968151 5780 cache.go:60] Finished verifying existence of preloaded tar for v1.28.2 on docker
I0919 10:15:07.968239 5780 profile.go:148] Saving config to /Users/jenkins/minikube-integration/17240-937/.minikube/profiles/calico-745000/config.json ...
I0919 10:15:07.968263 5780 lock.go:35] WriteFile acquiring /Users/jenkins/minikube-integration/17240-937/.minikube/profiles/calico-745000/config.json: {Name:mk0a4a432711ee7ca8776c4152cf3e9ffa461eeb Clock:{} Delay:500ms Timeout:1m0s Cancel:<nil>}
I0919 10:15:07.968546 5780 start.go:365] acquiring machines lock for calico-745000: {Name:mk9019918ab387d52e7eddb3ea9419993c7da9bf Clock:{} Delay:500ms Timeout:13m0s Cancel:<nil>}
I0919 10:15:07.968594 5780 start.go:369] acquired machines lock for "calico-745000" in 38.335µs
I0919 10:15:07.968615 5780 start.go:93] Provisioning new machine with config: &{Name:calico-745000 KeepContext:false EmbedCerts:false MinikubeISO:https://storage.googleapis.com/minikube-builds/iso/17240/minikube-v1.31.0-1695060926-17240-amd64.iso KicBaseImage:gcr.io/k8s-minikube/kicbase-builds:v0.0.40-1694798187-17250@sha256:8d9a070cda8e1b1082ed355bde1aaf66fbf63d64fa6e9f553f449efc74157fe3 Memory:3072 CPUs:2 DiskSize:20000 VMDriver: Driver:hyperkit HyperkitVpnKitSock: HyperkitVSockPorts:[] DockerEnv:[] ContainerVolumeMounts:[] InsecureRegistry:[] RegistryMirror:[] HostOnlyCIDR:192.168.59.1/24 HypervVirtualSwitch: HypervUseExternalSwitch:false HypervExternalAdapter: KVMNetwork:default KVMQemuURI:qemu:///system KVMGPU:false KVMHidden:false KVMNUMACount:1 APIServerPort:0 DockerOpt:[] DisableDriverMounts:false NFSShare:[] NFSSharesRoot:/nfsshares UUID: NoVTXCheck:false DNSProxy:false HostDNSResolver:true HostOnlyNicType:virtio NatNicType:virtio SSHIPAddress: SSHUser:root SSHKey: SSHPort:22 KubernetesCo
nfig:{KubernetesVersion:v1.28.2 ClusterName:calico-745000 Namespace:default APIServerName:minikubeCA APIServerNames:[] APIServerIPs:[] DNSDomain:cluster.local ContainerRuntime:docker CRISocket: NetworkPlugin:cni FeatureGates: ServiceCIDR:10.96.0.0/12 ImageRepository: LoadBalancerStartIP: LoadBalancerEndIP: CustomIngressCert: RegistryAliases: ExtraOptions:[] ShouldLoadCachedImages:true EnableDefaultCNI:false CNI:calico NodeIP: NodePort:8443 NodeName:} Nodes:[{Name: IP: Port:8443 KubernetesVersion:v1.28.2 ContainerRuntime:docker ControlPlane:true Worker:true}] Addons:map[] CustomAddonImages:map[] CustomAddonRegistries:map[] VerifyComponents:map[apiserver:true apps_running:true default_sa:true extra:true kubelet:true node_ready:true system_pods:true] StartHostTimeout:15m0s ScheduledStop:<nil> ExposedPorts:[] ListenAddress: Network: Subnet: MultiNodeRequested:false ExtraDisks:0 CertExpiration:26280h0m0s Mount:false MountString:/Users:/minikube-host Mount9PVersion:9p2000.L MountGID:docker MountIP: MountMSize:26214
4 MountOptions:[] MountPort:0 MountType:9p MountUID:docker BinaryMirror: DisableOptimizations:false DisableMetrics:false CustomQemuFirmwarePath: SocketVMnetClientPath: SocketVMnetPath: StaticIP: SSHAuthSock: SSHAgentPID:0 AutoPauseInterval:1m0s} &{Name: IP: Port:8443 KubernetesVersion:v1.28.2 ContainerRuntime:docker ControlPlane:true Worker:true}
I0919 10:15:07.968671 5780 start.go:125] createHost starting for "" (driver="hyperkit")
I0919 10:15:07.989881 5780 out.go:204] * Creating hyperkit VM (CPUs=2, Memory=3072MB, Disk=20000MB) ...
I0919 10:15:07.990114 5780 main.go:141] libmachine: Found binary path at /Users/jenkins/workspace/out/docker-machine-driver-hyperkit
I0919 10:15:07.990189 5780 main.go:141] libmachine: Launching plugin server for driver hyperkit
I0919 10:15:07.997392 5780 main.go:141] libmachine: Plugin server listening at address 127.0.0.1:53225
I0919 10:15:07.997746 5780 main.go:141] libmachine: () Calling .GetVersion
I0919 10:15:07.998194 5780 main.go:141] libmachine: Using API Version 1
I0919 10:15:07.998208 5780 main.go:141] libmachine: () Calling .SetConfigRaw
I0919 10:15:07.998417 5780 main.go:141] libmachine: () Calling .GetMachineName
I0919 10:15:07.998524 5780 main.go:141] libmachine: (calico-745000) Calling .GetMachineName
I0919 10:15:07.998604 5780 main.go:141] libmachine: (calico-745000) Calling .DriverName
I0919 10:15:07.998701 5780 start.go:159] libmachine.API.Create for "calico-745000" (driver="hyperkit")
I0919 10:15:07.998731 5780 client.go:168] LocalClient.Create starting
I0919 10:15:07.998768 5780 main.go:141] libmachine: Reading certificate data from /Users/jenkins/minikube-integration/17240-937/.minikube/certs/ca.pem
I0919 10:15:07.998808 5780 main.go:141] libmachine: Decoding PEM data...
I0919 10:15:07.998822 5780 main.go:141] libmachine: Parsing certificate...
I0919 10:15:07.998877 5780 main.go:141] libmachine: Reading certificate data from /Users/jenkins/minikube-integration/17240-937/.minikube/certs/cert.pem
I0919 10:15:07.998905 5780 main.go:141] libmachine: Decoding PEM data...
I0919 10:15:07.998919 5780 main.go:141] libmachine: Parsing certificate...
I0919 10:15:07.998939 5780 main.go:141] libmachine: Running pre-create checks...
I0919 10:15:07.998945 5780 main.go:141] libmachine: (calico-745000) Calling .PreCreateCheck
I0919 10:15:07.999015 5780 main.go:141] libmachine: (calico-745000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I0919 10:15:07.999232 5780 main.go:141] libmachine: (calico-745000) Calling .GetConfigRaw
I0919 10:15:08.010285 5780 main.go:141] libmachine: Creating machine...
I0919 10:15:08.010296 5780 main.go:141] libmachine: (calico-745000) Calling .Create
I0919 10:15:08.010422 5780 main.go:141] libmachine: (calico-745000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I0919 10:15:08.010600 5780 main.go:141] libmachine: (calico-745000) DBG | I0919 10:15:08.010420 5788 common.go:145] Making disk image using store path: /Users/jenkins/minikube-integration/17240-937/.minikube
I0919 10:15:08.010632 5780 main.go:141] libmachine: (calico-745000) Downloading /Users/jenkins/minikube-integration/17240-937/.minikube/cache/boot2docker.iso from file:///Users/jenkins/minikube-integration/17240-937/.minikube/cache/iso/amd64/minikube-v1.31.0-1695060926-17240-amd64.iso...
I0919 10:15:08.207367 5780 main.go:141] libmachine: (calico-745000) DBG | I0919 10:15:08.207296 5788 common.go:152] Creating ssh key: /Users/jenkins/minikube-integration/17240-937/.minikube/machines/calico-745000/id_rsa...
I0919 10:15:08.252601 5780 main.go:141] libmachine: (calico-745000) DBG | I0919 10:15:08.252535 5788 common.go:158] Creating raw disk image: /Users/jenkins/minikube-integration/17240-937/.minikube/machines/calico-745000/calico-745000.rawdisk...
I0919 10:15:08.252626 5780 main.go:141] libmachine: (calico-745000) DBG | Writing magic tar header
I0919 10:15:08.252639 5780 main.go:141] libmachine: (calico-745000) DBG | Writing SSH key tar header
I0919 10:15:08.252955 5780 main.go:141] libmachine: (calico-745000) DBG | I0919 10:15:08.252882 5788 common.go:172] Fixing permissions on /Users/jenkins/minikube-integration/17240-937/.minikube/machines/calico-745000 ...
I0919 10:15:08.637508 5780 main.go:141] libmachine: (calico-745000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I0919 10:15:08.637526 5780 main.go:141] libmachine: (calico-745000) DBG | clean start, hyperkit pid file doesn't exist: /Users/jenkins/minikube-integration/17240-937/.minikube/machines/calico-745000/hyperkit.pid
I0919 10:15:08.637574 5780 main.go:141] libmachine: (calico-745000) DBG | Using UUID 1515ab50-5710-11ee-a92b-f01898ef957c
I0919 10:15:08.659224 5780 main.go:141] libmachine: (calico-745000) DBG | Generated MAC 6e:dc:b0:62:81:64
I0919 10:15:08.659242 5780 main.go:141] libmachine: (calico-745000) 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=calico-745000
I0919 10:15:08.659277 5780 main.go:141] libmachine: (calico-745000) DBG | 2023/09/19 10:15:08 DEBUG: hyperkit: Start &hyperkit.HyperKit{HyperKit:"/usr/local/bin/hyperkit", Argv0:"", StateDir:"/Users/jenkins/minikube-integration/17240-937/.minikube/machines/calico-745000", VPNKitSock:"", VPNKitUUID:"", VPNKitPreferredIPv4:"", UUID:"1515ab50-5710-11ee-a92b-f01898ef957c", Disks:[]hyperkit.Disk{(*hyperkit.RawDisk)(0xc000096360)}, ISOImages:[]string{"/Users/jenkins/minikube-integration/17240-937/.minikube/machines/calico-745000/boot2docker.iso"}, VSock:false, VSockDir:"", VSockPorts:[]int(nil), VSockGuestCID:3, VMNet:true, Sockets9P:[]hyperkit.Socket9P(nil), Kernel:"/Users/jenkins/minikube-integration/17240-937/.minikube/machines/calico-745000/bzimage", Initrd:"/Users/jenkins/minikube-integration/17240-937/.minikube/machines/calico-745000/initrd", Bootrom:"", CPUs:2, Memory:3072, Console:1, Serials:[]hyperkit.Serial(nil), Pid:0, Arguments:[]string(nil), CmdLine:"", process:(*os.Process)(nil)}
I0919 10:15:08.659318 5780 main.go:141] libmachine: (calico-745000) DBG | 2023/09/19 10:15:08 DEBUG: hyperkit: check &hyperkit.HyperKit{HyperKit:"/usr/local/bin/hyperkit", Argv0:"", StateDir:"/Users/jenkins/minikube-integration/17240-937/.minikube/machines/calico-745000", VPNKitSock:"", VPNKitUUID:"", VPNKitPreferredIPv4:"", UUID:"1515ab50-5710-11ee-a92b-f01898ef957c", Disks:[]hyperkit.Disk{(*hyperkit.RawDisk)(0xc000096360)}, ISOImages:[]string{"/Users/jenkins/minikube-integration/17240-937/.minikube/machines/calico-745000/boot2docker.iso"}, VSock:false, VSockDir:"", VSockPorts:[]int(nil), VSockGuestCID:3, VMNet:true, Sockets9P:[]hyperkit.Socket9P(nil), Kernel:"/Users/jenkins/minikube-integration/17240-937/.minikube/machines/calico-745000/bzimage", Initrd:"/Users/jenkins/minikube-integration/17240-937/.minikube/machines/calico-745000/initrd", Bootrom:"", CPUs:2, Memory:3072, Console:1, Serials:[]hyperkit.Serial(nil), Pid:0, Arguments:[]string(nil), CmdLine:"", process:(*os.Process)(nil)}
I0919 10:15:08.659392 5780 main.go:141] libmachine: (calico-745000) DBG | 2023/09/19 10:15:08 DEBUG: hyperkit: Arguments: []string{"-A", "-u", "-F", "/Users/jenkins/minikube-integration/17240-937/.minikube/machines/calico-745000/hyperkit.pid", "-c", "2", "-m", "3072M", "-s", "0:0,hostbridge", "-s", "31,lpc", "-s", "1:0,virtio-net", "-U", "1515ab50-5710-11ee-a92b-f01898ef957c", "-s", "2:0,virtio-blk,/Users/jenkins/minikube-integration/17240-937/.minikube/machines/calico-745000/calico-745000.rawdisk", "-s", "3,ahci-cd,/Users/jenkins/minikube-integration/17240-937/.minikube/machines/calico-745000/boot2docker.iso", "-s", "4,virtio-rnd", "-l", "com1,autopty=/Users/jenkins/minikube-integration/17240-937/.minikube/machines/calico-745000/tty,log=/Users/jenkins/minikube-integration/17240-937/.minikube/machines/calico-745000/console-ring", "-f", "kexec,/Users/jenkins/minikube-integration/17240-937/.minikube/machines/calico-745000/bzimage,/Users/jenkins/minikube-integration/17240-937/.minikube/machines/calic
o-745000/initrd,earlyprintk=serial loglevel=3 console=ttyS0 console=tty0 noembed nomodeset norestore waitusb=10 systemd.legacy_systemd_cgroup_controller=yes random.trust_cpu=on hw_rng_model=virtio base host=calico-745000"}
I0919 10:15:08.659441 5780 main.go:141] libmachine: (calico-745000) DBG | 2023/09/19 10:15:08 DEBUG: hyperkit: CmdLine: "/usr/local/bin/hyperkit -A -u -F /Users/jenkins/minikube-integration/17240-937/.minikube/machines/calico-745000/hyperkit.pid -c 2 -m 3072M -s 0:0,hostbridge -s 31,lpc -s 1:0,virtio-net -U 1515ab50-5710-11ee-a92b-f01898ef957c -s 2:0,virtio-blk,/Users/jenkins/minikube-integration/17240-937/.minikube/machines/calico-745000/calico-745000.rawdisk -s 3,ahci-cd,/Users/jenkins/minikube-integration/17240-937/.minikube/machines/calico-745000/boot2docker.iso -s 4,virtio-rnd -l com1,autopty=/Users/jenkins/minikube-integration/17240-937/.minikube/machines/calico-745000/tty,log=/Users/jenkins/minikube-integration/17240-937/.minikube/machines/calico-745000/console-ring -f kexec,/Users/jenkins/minikube-integration/17240-937/.minikube/machines/calico-745000/bzimage,/Users/jenkins/minikube-integration/17240-937/.minikube/machines/calico-745000/initrd,earlyprintk=serial loglevel=3 console=ttyS0 co
nsole=tty0 noembed nomodeset norestore waitusb=10 systemd.legacy_systemd_cgroup_controller=yes random.trust_cpu=on hw_rng_model=virtio base host=calico-745000"
I0919 10:15:08.659463 5780 main.go:141] libmachine: (calico-745000) DBG | 2023/09/19 10:15:08 DEBUG: hyperkit: Redirecting stdout/stderr to logger
I0919 10:15:08.662165 5780 main.go:141] libmachine: (calico-745000) DBG | 2023/09/19 10:15:08 DEBUG: hyperkit: Pid is 5791
I0919 10:15:08.662571 5780 main.go:141] libmachine: (calico-745000) DBG | Attempt 0
I0919 10:15:08.662586 5780 main.go:141] libmachine: (calico-745000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I0919 10:15:08.662635 5780 main.go:141] libmachine: (calico-745000) DBG | hyperkit pid from json: 5791
I0919 10:15:08.663490 5780 main.go:141] libmachine: (calico-745000) DBG | Searching for 6e:dc:b0:62:81:64 in /var/db/dhcpd_leases ...
I0919 10:15:08.663563 5780 main.go:141] libmachine: (calico-745000) DBG | Found 30 entries in /var/db/dhcpd_leases!
I0919 10:15:08.663578 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.31 HWAddress:fe:33:64:f3:3:22 ID:1,fe:33:64:f3:3:22 Lease:0x650b288e}
I0919 10:15:08.663585 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.30 HWAddress:72:5:51:7d:80:5f ID:1,72:5:51:7d:80:5f Lease:0x6509d703}
I0919 10:15:08.663593 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.29 HWAddress:c2:4a:8c:f4:6:ce ID:1,c2:4a:8c:f4:6:ce Lease:0x6509d6dd}
I0919 10:15:08.663601 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.28 HWAddress:ce:e7:94:f2:68:9a ID:1,ce:e7:94:f2:68:9a Lease:0x650b2821}
I0919 10:15:08.663608 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.27 HWAddress:aa:94:44:5:64:d6 ID:1,aa:94:44:5:64:d6 Lease:0x650b27f7}
I0919 10:15:08.663616 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.26 HWAddress:16:71:2:db:35:a ID:1,16:71:2:db:35:a Lease:0x650b27d6}
I0919 10:15:08.663624 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.25 HWAddress:a6:b6:ef:9b:cb:0 ID:1,a6:b6:ef:9b:cb:0 Lease:0x650b26ef}
I0919 10:15:08.663635 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.24 HWAddress:e2:b2:35:d1:fd:93 ID:1,e2:b2:35:d1:fd:93 Lease:0x650b26ba}
I0919 10:15:08.663643 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.23 HWAddress:76:ba:b4:e:43:fe ID:1,76:ba:b4:e:43:fe Lease:0x650b269e}
I0919 10:15:08.663650 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.22 HWAddress:82:94:37:91:10:f5 ID:1,82:94:37:91:10:f5 Lease:0x650b2692}
I0919 10:15:08.663658 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.21 HWAddress:16:84:92:71:cc:54 ID:1,16:84:92:71:cc:54 Lease:0x6509d50e}
I0919 10:15:08.663666 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.20 HWAddress:c2:ad:8d:c0:97:1e ID:1,c2:ad:8d:c0:97:1e Lease:0x650b264c}
I0919 10:15:08.663698 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.19 HWAddress:2a:9c:23:13:12:de ID:1,2a:9c:23:13:12:de Lease:0x650b2636}
I0919 10:15:08.663718 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.18 HWAddress:3e:96:b:12:dd:31 ID:1,3e:96:b:12:dd:31 Lease:0x650b25cb}
I0919 10:15:08.663730 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.17 HWAddress:a2:21:18:ac:1e:23 ID:1,a2:21:18:ac:1e:23 Lease:0x650b255f}
I0919 10:15:08.663738 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.16 HWAddress:26:17:c1:5e:79:9e ID:1,26:17:c1:5e:79:9e Lease:0x650b2527}
I0919 10:15:08.663747 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.15 HWAddress:f2:85:27:79:13:f9 ID:1,f2:85:27:79:13:f9 Lease:0x650b2498}
I0919 10:15:08.663758 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.14 HWAddress:1e:19:d7:7b:d4:e8 ID:1,1e:19:d7:7b:d4:e8 Lease:0x6509d28f}
I0919 10:15:08.663767 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.13 HWAddress:4e:2d:30:c0:73:4b ID:1,4e:2d:30:c0:73:4b Lease:0x650b245c}
I0919 10:15:08.663775 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.12 HWAddress:56:3:48:ef:b6:75 ID:1,56:3:48:ef:b6:75 Lease:0x650b2429}
I0919 10:15:08.663786 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.11 HWAddress:ca:30:a1:c0:14:a9 ID:1,ca:30:a1:c0:14:a9 Lease:0x6509d137}
I0919 10:15:08.663793 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.10 HWAddress:2:98:d3:e3:61:69 ID:1,2:98:d3:e3:61:69 Lease:0x6509d121}
I0919 10:15:08.663802 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.9 HWAddress:32:c:4b:e9:bc:da ID:1,32:c:4b:e9:bc:da Lease:0x650b2258}
I0919 10:15:08.663810 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.8 HWAddress:6e:d4:98:eb:9a:55 ID:1,6e:d4:98:eb:9a:55 Lease:0x650b2235}
I0919 10:15:08.663818 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.7 HWAddress:d6:48:60:54:1f:65 ID:1,d6:48:60:54:1f:65 Lease:0x650b21f9}
I0919 10:15:08.663826 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.6 HWAddress:be:4b:6c:1a:4b:67 ID:1,be:4b:6c:1a:4b:67 Lease:0x650b2183}
I0919 10:15:08.663838 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.5 HWAddress:82:ac:81:64:8:5 ID:1,82:ac:81:64:8:5 Lease:0x650b214b}
I0919 10:15:08.663846 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.4 HWAddress:86:49:8b:29:aa:4c ID:1,86:49:8b:29:aa:4c Lease:0x650b2047}
I0919 10:15:08.663875 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.3 HWAddress:e6:22:17:f0:35:9f ID:1,e6:22:17:f0:35:9f Lease:0x6509cebb}
I0919 10:15:08.663890 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.2 HWAddress:82:b4:f6:3f:4e:d5 ID:1,82:b4:f6:3f:4e:d5 Lease:0x650b1f1f}
I0919 10:15:08.668834 5780 main.go:141] libmachine: (calico-745000) DBG | 2023/09/19 10:15:08 INFO : hyperkit: stderr: Using fd 5 for I/O notifications
I0919 10:15:08.678753 5780 main.go:141] libmachine: (calico-745000) DBG | 2023/09/19 10:15:08 INFO : hyperkit: stderr: /Users/jenkins/minikube-integration/17240-937/.minikube/machines/calico-745000/boot2docker.iso: fcntl(F_PUNCHHOLE) Operation not permitted: block device will not support TRIM/DISCARD
I0919 10:15:08.679385 5780 main.go:141] libmachine: (calico-745000) DBG | 2023/09/19 10:15:08 INFO : hyperkit: stderr: vmx_set_ctlreg: cap_field: 2 bit: 22 unspecified don't care: bit is 0
I0919 10:15:08.679415 5780 main.go:141] libmachine: (calico-745000) DBG | 2023/09/19 10:15:08 INFO : hyperkit: stderr: vmx_set_ctlreg: cap_field: 4 bit: 12 unspecified don't care: bit is 0
I0919 10:15:08.679431 5780 main.go:141] libmachine: (calico-745000) DBG | 2023/09/19 10:15:08 INFO : hyperkit: stderr: vmx_set_ctlreg: cap_field: 4 bit: 20 unspecified don't care: bit is 0
I0919 10:15:08.679473 5780 main.go:141] libmachine: (calico-745000) DBG | 2023/09/19 10:15:08 INFO : hyperkit: stderr: vmx_set_ctlreg: cap_field: 3 bit: 13 unspecified don't care: bit is 0
I0919 10:15:09.079209 5780 main.go:141] libmachine: (calico-745000) DBG | 2023/09/19 10:15:09 INFO : hyperkit: stderr: rdmsr to register 0x3a on vcpu 0
I0919 10:15:09.079227 5780 main.go:141] libmachine: (calico-745000) DBG | 2023/09/19 10:15:09 INFO : hyperkit: stderr: rdmsr to register 0x140 on vcpu 0
I0919 10:15:09.183337 5780 main.go:141] libmachine: (calico-745000) DBG | 2023/09/19 10:15:09 INFO : hyperkit: stderr: vmx_set_ctlreg: cap_field: 2 bit: 22 unspecified don't care: bit is 0
I0919 10:15:09.183361 5780 main.go:141] libmachine: (calico-745000) DBG | 2023/09/19 10:15:09 INFO : hyperkit: stderr: vmx_set_ctlreg: cap_field: 4 bit: 12 unspecified don't care: bit is 0
I0919 10:15:09.183373 5780 main.go:141] libmachine: (calico-745000) DBG | 2023/09/19 10:15:09 INFO : hyperkit: stderr: vmx_set_ctlreg: cap_field: 4 bit: 20 unspecified don't care: bit is 0
I0919 10:15:09.183382 5780 main.go:141] libmachine: (calico-745000) DBG | 2023/09/19 10:15:09 INFO : hyperkit: stderr: vmx_set_ctlreg: cap_field: 3 bit: 13 unspecified don't care: bit is 0
I0919 10:15:09.184217 5780 main.go:141] libmachine: (calico-745000) DBG | 2023/09/19 10:15:09 INFO : hyperkit: stderr: rdmsr to register 0x3a on vcpu 1
I0919 10:15:09.184232 5780 main.go:141] libmachine: (calico-745000) DBG | 2023/09/19 10:15:09 INFO : hyperkit: stderr: rdmsr to register 0x140 on vcpu 1
I0919 10:15:10.664624 5780 main.go:141] libmachine: (calico-745000) DBG | Attempt 1
I0919 10:15:10.664644 5780 main.go:141] libmachine: (calico-745000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I0919 10:15:10.664769 5780 main.go:141] libmachine: (calico-745000) DBG | hyperkit pid from json: 5791
I0919 10:15:10.665579 5780 main.go:141] libmachine: (calico-745000) DBG | Searching for 6e:dc:b0:62:81:64 in /var/db/dhcpd_leases ...
I0919 10:15:10.665650 5780 main.go:141] libmachine: (calico-745000) DBG | Found 30 entries in /var/db/dhcpd_leases!
I0919 10:15:10.665659 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.31 HWAddress:fe:33:64:f3:3:22 ID:1,fe:33:64:f3:3:22 Lease:0x650b288e}
I0919 10:15:10.665669 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.30 HWAddress:72:5:51:7d:80:5f ID:1,72:5:51:7d:80:5f Lease:0x6509d703}
I0919 10:15:10.665679 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.29 HWAddress:c2:4a:8c:f4:6:ce ID:1,c2:4a:8c:f4:6:ce Lease:0x6509d6dd}
I0919 10:15:10.665738 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.28 HWAddress:ce:e7:94:f2:68:9a ID:1,ce:e7:94:f2:68:9a Lease:0x650b2821}
I0919 10:15:10.665754 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.27 HWAddress:aa:94:44:5:64:d6 ID:1,aa:94:44:5:64:d6 Lease:0x650b27f7}
I0919 10:15:10.665782 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.26 HWAddress:16:71:2:db:35:a ID:1,16:71:2:db:35:a Lease:0x650b27d6}
I0919 10:15:10.665798 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.25 HWAddress:a6:b6:ef:9b:cb:0 ID:1,a6:b6:ef:9b:cb:0 Lease:0x650b26ef}
I0919 10:15:10.665811 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.24 HWAddress:e2:b2:35:d1:fd:93 ID:1,e2:b2:35:d1:fd:93 Lease:0x650b26ba}
I0919 10:15:10.665819 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.23 HWAddress:76:ba:b4:e:43:fe ID:1,76:ba:b4:e:43:fe Lease:0x650b269e}
I0919 10:15:10.665833 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.22 HWAddress:82:94:37:91:10:f5 ID:1,82:94:37:91:10:f5 Lease:0x650b2692}
I0919 10:15:10.665842 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.21 HWAddress:16:84:92:71:cc:54 ID:1,16:84:92:71:cc:54 Lease:0x6509d50e}
I0919 10:15:10.665858 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.20 HWAddress:c2:ad:8d:c0:97:1e ID:1,c2:ad:8d:c0:97:1e Lease:0x650b264c}
I0919 10:15:10.665871 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.19 HWAddress:2a:9c:23:13:12:de ID:1,2a:9c:23:13:12:de Lease:0x650b2636}
I0919 10:15:10.665882 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.18 HWAddress:3e:96:b:12:dd:31 ID:1,3e:96:b:12:dd:31 Lease:0x650b25cb}
I0919 10:15:10.665891 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.17 HWAddress:a2:21:18:ac:1e:23 ID:1,a2:21:18:ac:1e:23 Lease:0x650b255f}
I0919 10:15:10.665929 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.16 HWAddress:26:17:c1:5e:79:9e ID:1,26:17:c1:5e:79:9e Lease:0x650b2527}
I0919 10:15:10.665941 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.15 HWAddress:f2:85:27:79:13:f9 ID:1,f2:85:27:79:13:f9 Lease:0x650b2498}
I0919 10:15:10.665954 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.14 HWAddress:1e:19:d7:7b:d4:e8 ID:1,1e:19:d7:7b:d4:e8 Lease:0x6509d28f}
I0919 10:15:10.665964 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.13 HWAddress:4e:2d:30:c0:73:4b ID:1,4e:2d:30:c0:73:4b Lease:0x650b245c}
I0919 10:15:10.665971 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.12 HWAddress:56:3:48:ef:b6:75 ID:1,56:3:48:ef:b6:75 Lease:0x650b2429}
I0919 10:15:10.665977 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.11 HWAddress:ca:30:a1:c0:14:a9 ID:1,ca:30:a1:c0:14:a9 Lease:0x6509d137}
I0919 10:15:10.665984 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.10 HWAddress:2:98:d3:e3:61:69 ID:1,2:98:d3:e3:61:69 Lease:0x6509d121}
I0919 10:15:10.665991 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.9 HWAddress:32:c:4b:e9:bc:da ID:1,32:c:4b:e9:bc:da Lease:0x650b2258}
I0919 10:15:10.665998 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.8 HWAddress:6e:d4:98:eb:9a:55 ID:1,6e:d4:98:eb:9a:55 Lease:0x650b2235}
I0919 10:15:10.666006 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.7 HWAddress:d6:48:60:54:1f:65 ID:1,d6:48:60:54:1f:65 Lease:0x650b21f9}
I0919 10:15:10.666017 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.6 HWAddress:be:4b:6c:1a:4b:67 ID:1,be:4b:6c:1a:4b:67 Lease:0x650b2183}
I0919 10:15:10.666037 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.5 HWAddress:82:ac:81:64:8:5 ID:1,82:ac:81:64:8:5 Lease:0x650b214b}
I0919 10:15:10.666050 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.4 HWAddress:86:49:8b:29:aa:4c ID:1,86:49:8b:29:aa:4c Lease:0x650b2047}
I0919 10:15:10.666059 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.3 HWAddress:e6:22:17:f0:35:9f ID:1,e6:22:17:f0:35:9f Lease:0x6509cebb}
I0919 10:15:10.666068 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.2 HWAddress:82:b4:f6:3f:4e:d5 ID:1,82:b4:f6:3f:4e:d5 Lease:0x650b1f1f}
I0919 10:15:12.666509 5780 main.go:141] libmachine: (calico-745000) DBG | Attempt 2
I0919 10:15:12.666535 5780 main.go:141] libmachine: (calico-745000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I0919 10:15:12.666604 5780 main.go:141] libmachine: (calico-745000) DBG | hyperkit pid from json: 5791
I0919 10:15:12.667329 5780 main.go:141] libmachine: (calico-745000) DBG | Searching for 6e:dc:b0:62:81:64 in /var/db/dhcpd_leases ...
I0919 10:15:12.667399 5780 main.go:141] libmachine: (calico-745000) DBG | Found 30 entries in /var/db/dhcpd_leases!
I0919 10:15:12.667411 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.31 HWAddress:fe:33:64:f3:3:22 ID:1,fe:33:64:f3:3:22 Lease:0x650b288e}
I0919 10:15:12.667420 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.30 HWAddress:72:5:51:7d:80:5f ID:1,72:5:51:7d:80:5f Lease:0x6509d703}
I0919 10:15:12.667430 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.29 HWAddress:c2:4a:8c:f4:6:ce ID:1,c2:4a:8c:f4:6:ce Lease:0x6509d6dd}
I0919 10:15:12.667441 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.28 HWAddress:ce:e7:94:f2:68:9a ID:1,ce:e7:94:f2:68:9a Lease:0x650b2821}
I0919 10:15:12.667450 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.27 HWAddress:aa:94:44:5:64:d6 ID:1,aa:94:44:5:64:d6 Lease:0x650b27f7}
I0919 10:15:12.667463 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.26 HWAddress:16:71:2:db:35:a ID:1,16:71:2:db:35:a Lease:0x650b27d6}
I0919 10:15:12.667480 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.25 HWAddress:a6:b6:ef:9b:cb:0 ID:1,a6:b6:ef:9b:cb:0 Lease:0x650b26ef}
I0919 10:15:12.667488 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.24 HWAddress:e2:b2:35:d1:fd:93 ID:1,e2:b2:35:d1:fd:93 Lease:0x650b26ba}
I0919 10:15:12.667495 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.23 HWAddress:76:ba:b4:e:43:fe ID:1,76:ba:b4:e:43:fe Lease:0x650b269e}
I0919 10:15:12.667502 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.22 HWAddress:82:94:37:91:10:f5 ID:1,82:94:37:91:10:f5 Lease:0x650b2692}
I0919 10:15:12.667511 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.21 HWAddress:16:84:92:71:cc:54 ID:1,16:84:92:71:cc:54 Lease:0x6509d50e}
I0919 10:15:12.667521 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.20 HWAddress:c2:ad:8d:c0:97:1e ID:1,c2:ad:8d:c0:97:1e Lease:0x650b264c}
I0919 10:15:12.667528 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.19 HWAddress:2a:9c:23:13:12:de ID:1,2a:9c:23:13:12:de Lease:0x650b2636}
I0919 10:15:12.667537 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.18 HWAddress:3e:96:b:12:dd:31 ID:1,3e:96:b:12:dd:31 Lease:0x650b25cb}
I0919 10:15:12.667544 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.17 HWAddress:a2:21:18:ac:1e:23 ID:1,a2:21:18:ac:1e:23 Lease:0x650b255f}
I0919 10:15:12.667552 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.16 HWAddress:26:17:c1:5e:79:9e ID:1,26:17:c1:5e:79:9e Lease:0x650b2527}
I0919 10:15:12.667560 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.15 HWAddress:f2:85:27:79:13:f9 ID:1,f2:85:27:79:13:f9 Lease:0x650b2498}
I0919 10:15:12.667571 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.14 HWAddress:1e:19:d7:7b:d4:e8 ID:1,1e:19:d7:7b:d4:e8 Lease:0x6509d28f}
I0919 10:15:12.667579 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.13 HWAddress:4e:2d:30:c0:73:4b ID:1,4e:2d:30:c0:73:4b Lease:0x650b245c}
I0919 10:15:12.667588 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.12 HWAddress:56:3:48:ef:b6:75 ID:1,56:3:48:ef:b6:75 Lease:0x650b2429}
I0919 10:15:12.667595 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.11 HWAddress:ca:30:a1:c0:14:a9 ID:1,ca:30:a1:c0:14:a9 Lease:0x6509d137}
I0919 10:15:12.667602 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.10 HWAddress:2:98:d3:e3:61:69 ID:1,2:98:d3:e3:61:69 Lease:0x6509d121}
I0919 10:15:12.667615 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.9 HWAddress:32:c:4b:e9:bc:da ID:1,32:c:4b:e9:bc:da Lease:0x650b2258}
I0919 10:15:12.667628 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.8 HWAddress:6e:d4:98:eb:9a:55 ID:1,6e:d4:98:eb:9a:55 Lease:0x650b2235}
I0919 10:15:12.667636 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.7 HWAddress:d6:48:60:54:1f:65 ID:1,d6:48:60:54:1f:65 Lease:0x650b21f9}
I0919 10:15:12.667644 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.6 HWAddress:be:4b:6c:1a:4b:67 ID:1,be:4b:6c:1a:4b:67 Lease:0x650b2183}
I0919 10:15:12.667655 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.5 HWAddress:82:ac:81:64:8:5 ID:1,82:ac:81:64:8:5 Lease:0x650b214b}
I0919 10:15:12.667672 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.4 HWAddress:86:49:8b:29:aa:4c ID:1,86:49:8b:29:aa:4c Lease:0x650b2047}
I0919 10:15:12.667685 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.3 HWAddress:e6:22:17:f0:35:9f ID:1,e6:22:17:f0:35:9f Lease:0x6509cebb}
I0919 10:15:12.667700 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.2 HWAddress:82:b4:f6:3f:4e:d5 ID:1,82:b4:f6:3f:4e:d5 Lease:0x650b1f1f}
I0919 10:15:14.337829 5780 main.go:141] libmachine: (calico-745000) DBG | 2023/09/19 10:15:14 INFO : hyperkit: stderr: rdmsr to register 0x64d on vcpu 1
I0919 10:15:14.337920 5780 main.go:141] libmachine: (calico-745000) DBG | 2023/09/19 10:15:14 INFO : hyperkit: stderr: rdmsr to register 0x64e on vcpu 1
I0919 10:15:14.337931 5780 main.go:141] libmachine: (calico-745000) DBG | 2023/09/19 10:15:14 INFO : hyperkit: stderr: rdmsr to register 0x34 on vcpu 1
I0919 10:15:14.669606 5780 main.go:141] libmachine: (calico-745000) DBG | Attempt 3
I0919 10:15:14.669623 5780 main.go:141] libmachine: (calico-745000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I0919 10:15:14.669702 5780 main.go:141] libmachine: (calico-745000) DBG | hyperkit pid from json: 5791
I0919 10:15:14.670432 5780 main.go:141] libmachine: (calico-745000) DBG | Searching for 6e:dc:b0:62:81:64 in /var/db/dhcpd_leases ...
I0919 10:15:14.670506 5780 main.go:141] libmachine: (calico-745000) DBG | Found 30 entries in /var/db/dhcpd_leases!
I0919 10:15:14.670515 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.31 HWAddress:fe:33:64:f3:3:22 ID:1,fe:33:64:f3:3:22 Lease:0x650b288e}
I0919 10:15:14.670526 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.30 HWAddress:72:5:51:7d:80:5f ID:1,72:5:51:7d:80:5f Lease:0x6509d703}
I0919 10:15:14.670544 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.29 HWAddress:c2:4a:8c:f4:6:ce ID:1,c2:4a:8c:f4:6:ce Lease:0x6509d6dd}
I0919 10:15:14.670552 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.28 HWAddress:ce:e7:94:f2:68:9a ID:1,ce:e7:94:f2:68:9a Lease:0x650b2821}
I0919 10:15:14.670559 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.27 HWAddress:aa:94:44:5:64:d6 ID:1,aa:94:44:5:64:d6 Lease:0x650b27f7}
I0919 10:15:14.670567 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.26 HWAddress:16:71:2:db:35:a ID:1,16:71:2:db:35:a Lease:0x650b27d6}
I0919 10:15:14.670580 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.25 HWAddress:a6:b6:ef:9b:cb:0 ID:1,a6:b6:ef:9b:cb:0 Lease:0x650b26ef}
I0919 10:15:14.670589 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.24 HWAddress:e2:b2:35:d1:fd:93 ID:1,e2:b2:35:d1:fd:93 Lease:0x650b26ba}
I0919 10:15:14.670596 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.23 HWAddress:76:ba:b4:e:43:fe ID:1,76:ba:b4:e:43:fe Lease:0x650b269e}
I0919 10:15:14.670603 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.22 HWAddress:82:94:37:91:10:f5 ID:1,82:94:37:91:10:f5 Lease:0x650b2692}
I0919 10:15:14.670612 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.21 HWAddress:16:84:92:71:cc:54 ID:1,16:84:92:71:cc:54 Lease:0x6509d50e}
I0919 10:15:14.670619 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.20 HWAddress:c2:ad:8d:c0:97:1e ID:1,c2:ad:8d:c0:97:1e Lease:0x650b264c}
I0919 10:15:14.670626 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.19 HWAddress:2a:9c:23:13:12:de ID:1,2a:9c:23:13:12:de Lease:0x650b2636}
I0919 10:15:14.670635 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.18 HWAddress:3e:96:b:12:dd:31 ID:1,3e:96:b:12:dd:31 Lease:0x650b25cb}
I0919 10:15:14.670644 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.17 HWAddress:a2:21:18:ac:1e:23 ID:1,a2:21:18:ac:1e:23 Lease:0x650b255f}
I0919 10:15:14.670653 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.16 HWAddress:26:17:c1:5e:79:9e ID:1,26:17:c1:5e:79:9e Lease:0x650b2527}
I0919 10:15:14.670661 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.15 HWAddress:f2:85:27:79:13:f9 ID:1,f2:85:27:79:13:f9 Lease:0x650b2498}
I0919 10:15:14.670669 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.14 HWAddress:1e:19:d7:7b:d4:e8 ID:1,1e:19:d7:7b:d4:e8 Lease:0x6509d28f}
I0919 10:15:14.670677 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.13 HWAddress:4e:2d:30:c0:73:4b ID:1,4e:2d:30:c0:73:4b Lease:0x650b245c}
I0919 10:15:14.670685 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.12 HWAddress:56:3:48:ef:b6:75 ID:1,56:3:48:ef:b6:75 Lease:0x650b2429}
I0919 10:15:14.670706 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.11 HWAddress:ca:30:a1:c0:14:a9 ID:1,ca:30:a1:c0:14:a9 Lease:0x6509d137}
I0919 10:15:14.670720 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.10 HWAddress:2:98:d3:e3:61:69 ID:1,2:98:d3:e3:61:69 Lease:0x6509d121}
I0919 10:15:14.670729 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.9 HWAddress:32:c:4b:e9:bc:da ID:1,32:c:4b:e9:bc:da Lease:0x650b2258}
I0919 10:15:14.670739 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.8 HWAddress:6e:d4:98:eb:9a:55 ID:1,6e:d4:98:eb:9a:55 Lease:0x650b2235}
I0919 10:15:14.670746 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.7 HWAddress:d6:48:60:54:1f:65 ID:1,d6:48:60:54:1f:65 Lease:0x650b21f9}
I0919 10:15:14.670753 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.6 HWAddress:be:4b:6c:1a:4b:67 ID:1,be:4b:6c:1a:4b:67 Lease:0x650b2183}
I0919 10:15:14.670762 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.5 HWAddress:82:ac:81:64:8:5 ID:1,82:ac:81:64:8:5 Lease:0x650b214b}
I0919 10:15:14.670770 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.4 HWAddress:86:49:8b:29:aa:4c ID:1,86:49:8b:29:aa:4c Lease:0x650b2047}
I0919 10:15:14.670778 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.3 HWAddress:e6:22:17:f0:35:9f ID:1,e6:22:17:f0:35:9f Lease:0x6509cebb}
I0919 10:15:14.670788 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.2 HWAddress:82:b4:f6:3f:4e:d5 ID:1,82:b4:f6:3f:4e:d5 Lease:0x650b1f1f}
I0919 10:15:16.672068 5780 main.go:141] libmachine: (calico-745000) DBG | Attempt 4
I0919 10:15:16.672086 5780 main.go:141] libmachine: (calico-745000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I0919 10:15:16.672148 5780 main.go:141] libmachine: (calico-745000) DBG | hyperkit pid from json: 5791
I0919 10:15:16.672979 5780 main.go:141] libmachine: (calico-745000) DBG | Searching for 6e:dc:b0:62:81:64 in /var/db/dhcpd_leases ...
I0919 10:15:16.673051 5780 main.go:141] libmachine: (calico-745000) DBG | Found 30 entries in /var/db/dhcpd_leases!
I0919 10:15:16.673062 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.31 HWAddress:fe:33:64:f3:3:22 ID:1,fe:33:64:f3:3:22 Lease:0x650b288e}
I0919 10:15:16.673076 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.30 HWAddress:72:5:51:7d:80:5f ID:1,72:5:51:7d:80:5f Lease:0x6509d703}
I0919 10:15:16.673086 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.29 HWAddress:c2:4a:8c:f4:6:ce ID:1,c2:4a:8c:f4:6:ce Lease:0x6509d6dd}
I0919 10:15:16.673107 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.28 HWAddress:ce:e7:94:f2:68:9a ID:1,ce:e7:94:f2:68:9a Lease:0x650b2821}
I0919 10:15:16.673120 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.27 HWAddress:aa:94:44:5:64:d6 ID:1,aa:94:44:5:64:d6 Lease:0x650b27f7}
I0919 10:15:16.673130 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.26 HWAddress:16:71:2:db:35:a ID:1,16:71:2:db:35:a Lease:0x650b27d6}
I0919 10:15:16.673140 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.25 HWAddress:a6:b6:ef:9b:cb:0 ID:1,a6:b6:ef:9b:cb:0 Lease:0x650b26ef}
I0919 10:15:16.673153 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.24 HWAddress:e2:b2:35:d1:fd:93 ID:1,e2:b2:35:d1:fd:93 Lease:0x650b26ba}
I0919 10:15:16.673181 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.23 HWAddress:76:ba:b4:e:43:fe ID:1,76:ba:b4:e:43:fe Lease:0x650b269e}
I0919 10:15:16.673194 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.22 HWAddress:82:94:37:91:10:f5 ID:1,82:94:37:91:10:f5 Lease:0x650b2692}
I0919 10:15:16.673204 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.21 HWAddress:16:84:92:71:cc:54 ID:1,16:84:92:71:cc:54 Lease:0x6509d50e}
I0919 10:15:16.673221 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.20 HWAddress:c2:ad:8d:c0:97:1e ID:1,c2:ad:8d:c0:97:1e Lease:0x650b264c}
I0919 10:15:16.673231 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.19 HWAddress:2a:9c:23:13:12:de ID:1,2a:9c:23:13:12:de Lease:0x650b2636}
I0919 10:15:16.673240 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.18 HWAddress:3e:96:b:12:dd:31 ID:1,3e:96:b:12:dd:31 Lease:0x650b25cb}
I0919 10:15:16.673263 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.17 HWAddress:a2:21:18:ac:1e:23 ID:1,a2:21:18:ac:1e:23 Lease:0x650b255f}
I0919 10:15:16.673281 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.16 HWAddress:26:17:c1:5e:79:9e ID:1,26:17:c1:5e:79:9e Lease:0x650b2527}
I0919 10:15:16.673290 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.15 HWAddress:f2:85:27:79:13:f9 ID:1,f2:85:27:79:13:f9 Lease:0x650b2498}
I0919 10:15:16.673298 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.14 HWAddress:1e:19:d7:7b:d4:e8 ID:1,1e:19:d7:7b:d4:e8 Lease:0x6509d28f}
I0919 10:15:16.673326 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.13 HWAddress:4e:2d:30:c0:73:4b ID:1,4e:2d:30:c0:73:4b Lease:0x650b245c}
I0919 10:15:16.673342 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.12 HWAddress:56:3:48:ef:b6:75 ID:1,56:3:48:ef:b6:75 Lease:0x650b2429}
I0919 10:15:16.673354 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.11 HWAddress:ca:30:a1:c0:14:a9 ID:1,ca:30:a1:c0:14:a9 Lease:0x6509d137}
I0919 10:15:16.673364 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.10 HWAddress:2:98:d3:e3:61:69 ID:1,2:98:d3:e3:61:69 Lease:0x6509d121}
I0919 10:15:16.673371 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.9 HWAddress:32:c:4b:e9:bc:da ID:1,32:c:4b:e9:bc:da Lease:0x650b2258}
I0919 10:15:16.673381 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.8 HWAddress:6e:d4:98:eb:9a:55 ID:1,6e:d4:98:eb:9a:55 Lease:0x650b2235}
I0919 10:15:16.673389 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.7 HWAddress:d6:48:60:54:1f:65 ID:1,d6:48:60:54:1f:65 Lease:0x650b21f9}
I0919 10:15:16.673400 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.6 HWAddress:be:4b:6c:1a:4b:67 ID:1,be:4b:6c:1a:4b:67 Lease:0x650b2183}
I0919 10:15:16.673416 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.5 HWAddress:82:ac:81:64:8:5 ID:1,82:ac:81:64:8:5 Lease:0x650b214b}
I0919 10:15:16.673432 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.4 HWAddress:86:49:8b:29:aa:4c ID:1,86:49:8b:29:aa:4c Lease:0x650b2047}
I0919 10:15:16.673455 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.3 HWAddress:e6:22:17:f0:35:9f ID:1,e6:22:17:f0:35:9f Lease:0x6509cebb}
I0919 10:15:16.673469 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.2 HWAddress:82:b4:f6:3f:4e:d5 ID:1,82:b4:f6:3f:4e:d5 Lease:0x650b1f1f}
I0919 10:15:18.674135 5780 main.go:141] libmachine: (calico-745000) DBG | Attempt 5
I0919 10:15:18.674163 5780 main.go:141] libmachine: (calico-745000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I0919 10:15:18.674299 5780 main.go:141] libmachine: (calico-745000) DBG | hyperkit pid from json: 5791
I0919 10:15:18.675606 5780 main.go:141] libmachine: (calico-745000) DBG | Searching for 6e:dc:b0:62:81:64 in /var/db/dhcpd_leases ...
I0919 10:15:18.675733 5780 main.go:141] libmachine: (calico-745000) DBG | Found 31 entries in /var/db/dhcpd_leases!
I0919 10:15:18.675753 5780 main.go:141] libmachine: (calico-745000) DBG | dhcp entry: {Name:minikube IPAddress:192.168.64.32 HWAddress:6e:dc:b0:62:81:64 ID:1,6e:dc:b0:62:81:64 Lease:0x650b28a4}
I0919 10:15:18.675797 5780 main.go:141] libmachine: (calico-745000) DBG | Found match: 6e:dc:b0:62:81:64
I0919 10:15:18.675828 5780 main.go:141] libmachine: (calico-745000) DBG | IP: 192.168.64.32
I0919 10:15:18.675864 5780 main.go:141] libmachine: (calico-745000) Calling .GetConfigRaw
I0919 10:15:18.676658 5780 main.go:141] libmachine: (calico-745000) Calling .DriverName
I0919 10:15:18.676796 5780 main.go:141] libmachine: (calico-745000) Calling .DriverName
I0919 10:15:18.676941 5780 main.go:141] libmachine: Waiting for machine to be running, this may take a few minutes...
I0919 10:15:18.676953 5780 main.go:141] libmachine: (calico-745000) Calling .GetState
I0919 10:15:18.677077 5780 main.go:141] libmachine: (calico-745000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I0919 10:15:18.677158 5780 main.go:141] libmachine: (calico-745000) DBG | hyperkit pid from json: 5791
I0919 10:15:18.678080 5780 main.go:141] libmachine: Detecting operating system of created instance...
I0919 10:15:18.678095 5780 main.go:141] libmachine: Waiting for SSH to be available...
I0919 10:15:18.678110 5780 main.go:141] libmachine: Getting to WaitForSSH function...
I0919 10:15:18.678118 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHHostname
I0919 10:15:18.678230 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHPort
I0919 10:15:18.678356 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHKeyPath
I0919 10:15:18.678449 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHKeyPath
I0919 10:15:18.678537 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHUsername
I0919 10:15:18.678662 5780 main.go:141] libmachine: Using SSH client type: native
I0919 10:15:18.678962 5780 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x13f2920] 0x13f5600 <nil> [] 0s} 192.168.64.32 22 <nil> <nil>}
I0919 10:15:18.678970 5780 main.go:141] libmachine: About to run SSH command:
exit 0
I0919 10:15:18.732885 5780 main.go:141] libmachine: SSH cmd err, output: <nil>:
I0919 10:15:18.732898 5780 main.go:141] libmachine: Detecting the provisioner...
I0919 10:15:18.732904 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHHostname
I0919 10:15:18.733031 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHPort
I0919 10:15:18.733127 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHKeyPath
I0919 10:15:18.733213 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHKeyPath
I0919 10:15:18.733285 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHUsername
I0919 10:15:18.733413 5780 main.go:141] libmachine: Using SSH client type: native
I0919 10:15:18.733677 5780 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x13f2920] 0x13f5600 <nil> [] 0s} 192.168.64.32 22 <nil> <nil>}
I0919 10:15:18.733685 5780 main.go:141] libmachine: About to run SSH command:
cat /etc/os-release
I0919 10:15:18.787538 5780 main.go:141] libmachine: SSH cmd err, output: <nil>: NAME=Buildroot
VERSION=2021.02.12-1-gb090841-dirty
ID=buildroot
VERSION_ID=2021.02.12
PRETTY_NAME="Buildroot 2021.02.12"
I0919 10:15:18.787591 5780 main.go:141] libmachine: found compatible host: buildroot
I0919 10:15:18.787598 5780 main.go:141] libmachine: Provisioning with buildroot...
I0919 10:15:18.787604 5780 main.go:141] libmachine: (calico-745000) Calling .GetMachineName
I0919 10:15:18.787743 5780 buildroot.go:166] provisioning hostname "calico-745000"
I0919 10:15:18.787755 5780 main.go:141] libmachine: (calico-745000) Calling .GetMachineName
I0919 10:15:18.787842 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHHostname
I0919 10:15:18.787940 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHPort
I0919 10:15:18.788016 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHKeyPath
I0919 10:15:18.788075 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHKeyPath
I0919 10:15:18.788160 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHUsername
I0919 10:15:18.788298 5780 main.go:141] libmachine: Using SSH client type: native
I0919 10:15:18.788553 5780 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x13f2920] 0x13f5600 <nil> [] 0s} 192.168.64.32 22 <nil> <nil>}
I0919 10:15:18.788562 5780 main.go:141] libmachine: About to run SSH command:
sudo hostname calico-745000 && echo "calico-745000" | sudo tee /etc/hostname
I0919 10:15:18.851615 5780 main.go:141] libmachine: SSH cmd err, output: <nil>: calico-745000
I0919 10:15:18.851634 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHHostname
I0919 10:15:18.851769 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHPort
I0919 10:15:18.851847 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHKeyPath
I0919 10:15:18.851924 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHKeyPath
I0919 10:15:18.851987 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHUsername
I0919 10:15:18.852143 5780 main.go:141] libmachine: Using SSH client type: native
I0919 10:15:18.852386 5780 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x13f2920] 0x13f5600 <nil> [] 0s} 192.168.64.32 22 <nil> <nil>}
I0919 10:15:18.852398 5780 main.go:141] libmachine: About to run SSH command:
if ! grep -xq '.*\scalico-745000' /etc/hosts; then
if grep -xq '127.0.1.1\s.*' /etc/hosts; then
sudo sed -i 's/^127.0.1.1\s.*/127.0.1.1 calico-745000/g' /etc/hosts;
else
echo '127.0.1.1 calico-745000' | sudo tee -a /etc/hosts;
fi
fi
I0919 10:15:18.912018 5780 main.go:141] libmachine: SSH cmd err, output: <nil>:
I0919 10:15:18.912038 5780 buildroot.go:172] set auth options {CertDir:/Users/jenkins/minikube-integration/17240-937/.minikube CaCertPath:/Users/jenkins/minikube-integration/17240-937/.minikube/certs/ca.pem CaPrivateKeyPath:/Users/jenkins/minikube-integration/17240-937/.minikube/certs/ca-key.pem CaCertRemotePath:/etc/docker/ca.pem ServerCertPath:/Users/jenkins/minikube-integration/17240-937/.minikube/machines/server.pem ServerKeyPath:/Users/jenkins/minikube-integration/17240-937/.minikube/machines/server-key.pem ClientKeyPath:/Users/jenkins/minikube-integration/17240-937/.minikube/certs/key.pem ServerCertRemotePath:/etc/docker/server.pem ServerKeyRemotePath:/etc/docker/server-key.pem ClientCertPath:/Users/jenkins/minikube-integration/17240-937/.minikube/certs/cert.pem ServerCertSANs:[] StorePath:/Users/jenkins/minikube-integration/17240-937/.minikube}
I0919 10:15:18.912054 5780 buildroot.go:174] setting up certificates
I0919 10:15:18.912066 5780 provision.go:83] configureAuth start
I0919 10:15:18.912075 5780 main.go:141] libmachine: (calico-745000) Calling .GetMachineName
I0919 10:15:18.912205 5780 main.go:141] libmachine: (calico-745000) Calling .GetIP
I0919 10:15:18.912300 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHHostname
I0919 10:15:18.912375 5780 provision.go:138] copyHostCerts
I0919 10:15:18.912454 5780 exec_runner.go:144] found /Users/jenkins/minikube-integration/17240-937/.minikube/ca.pem, removing ...
I0919 10:15:18.912465 5780 exec_runner.go:203] rm: /Users/jenkins/minikube-integration/17240-937/.minikube/ca.pem
I0919 10:15:18.912605 5780 exec_runner.go:151] cp: /Users/jenkins/minikube-integration/17240-937/.minikube/certs/ca.pem --> /Users/jenkins/minikube-integration/17240-937/.minikube/ca.pem (1082 bytes)
I0919 10:15:18.912894 5780 exec_runner.go:144] found /Users/jenkins/minikube-integration/17240-937/.minikube/cert.pem, removing ...
I0919 10:15:18.912925 5780 exec_runner.go:203] rm: /Users/jenkins/minikube-integration/17240-937/.minikube/cert.pem
I0919 10:15:18.913028 5780 exec_runner.go:151] cp: /Users/jenkins/minikube-integration/17240-937/.minikube/certs/cert.pem --> /Users/jenkins/minikube-integration/17240-937/.minikube/cert.pem (1123 bytes)
I0919 10:15:18.913184 5780 exec_runner.go:144] found /Users/jenkins/minikube-integration/17240-937/.minikube/key.pem, removing ...
I0919 10:15:18.913190 5780 exec_runner.go:203] rm: /Users/jenkins/minikube-integration/17240-937/.minikube/key.pem
I0919 10:15:18.913259 5780 exec_runner.go:151] cp: /Users/jenkins/minikube-integration/17240-937/.minikube/certs/key.pem --> /Users/jenkins/minikube-integration/17240-937/.minikube/key.pem (1675 bytes)
I0919 10:15:18.913388 5780 provision.go:112] generating server cert: /Users/jenkins/minikube-integration/17240-937/.minikube/machines/server.pem ca-key=/Users/jenkins/minikube-integration/17240-937/.minikube/certs/ca.pem private-key=/Users/jenkins/minikube-integration/17240-937/.minikube/certs/ca-key.pem org=jenkins.calico-745000 san=[192.168.64.32 192.168.64.32 localhost 127.0.0.1 minikube calico-745000]
I0919 10:15:19.002640 5780 provision.go:172] copyRemoteCerts
I0919 10:15:19.002719 5780 ssh_runner.go:195] Run: sudo mkdir -p /etc/docker /etc/docker /etc/docker
I0919 10:15:19.002749 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHHostname
I0919 10:15:19.002947 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHPort
I0919 10:15:19.003100 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHKeyPath
I0919 10:15:19.003244 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHUsername
I0919 10:15:19.003383 5780 sshutil.go:53] new ssh client: &{IP:192.168.64.32 Port:22 SSHKeyPath:/Users/jenkins/minikube-integration/17240-937/.minikube/machines/calico-745000/id_rsa Username:docker}
I0919 10:15:19.035990 5780 ssh_runner.go:362] scp /Users/jenkins/minikube-integration/17240-937/.minikube/certs/ca.pem --> /etc/docker/ca.pem (1082 bytes)
I0919 10:15:19.052855 5780 ssh_runner.go:362] scp /Users/jenkins/minikube-integration/17240-937/.minikube/machines/server.pem --> /etc/docker/server.pem (1216 bytes)
I0919 10:15:19.070027 5780 ssh_runner.go:362] scp /Users/jenkins/minikube-integration/17240-937/.minikube/machines/server-key.pem --> /etc/docker/server-key.pem (1679 bytes)
I0919 10:15:19.087313 5780 provision.go:86] duration metric: configureAuth took 175.233637ms
I0919 10:15:19.087326 5780 buildroot.go:189] setting minikube options for container-runtime
I0919 10:15:19.087464 5780 config.go:182] Loaded profile config "calico-745000": Driver=hyperkit, ContainerRuntime=docker, KubernetesVersion=v1.28.2
I0919 10:15:19.087478 5780 main.go:141] libmachine: (calico-745000) Calling .DriverName
I0919 10:15:19.087619 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHHostname
I0919 10:15:19.087710 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHPort
I0919 10:15:19.087795 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHKeyPath
I0919 10:15:19.087897 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHKeyPath
I0919 10:15:19.087990 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHUsername
I0919 10:15:19.088118 5780 main.go:141] libmachine: Using SSH client type: native
I0919 10:15:19.088373 5780 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x13f2920] 0x13f5600 <nil> [] 0s} 192.168.64.32 22 <nil> <nil>}
I0919 10:15:19.088382 5780 main.go:141] libmachine: About to run SSH command:
df --output=fstype / | tail -n 1
I0919 10:15:19.145592 5780 main.go:141] libmachine: SSH cmd err, output: <nil>: tmpfs
I0919 10:15:19.145608 5780 buildroot.go:70] root file system type: tmpfs
I0919 10:15:19.145686 5780 provision.go:309] Updating docker unit: /lib/systemd/system/docker.service ...
I0919 10:15:19.145702 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHHostname
I0919 10:15:19.145831 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHPort
I0919 10:15:19.145916 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHKeyPath
I0919 10:15:19.145994 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHKeyPath
I0919 10:15:19.146096 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHUsername
I0919 10:15:19.146219 5780 main.go:141] libmachine: Using SSH client type: native
I0919 10:15:19.146468 5780 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x13f2920] 0x13f5600 <nil> [] 0s} 192.168.64.32 22 <nil> <nil>}
I0919 10:15:19.146523 5780 main.go:141] libmachine: About to run SSH command:
sudo mkdir -p /lib/systemd/system && printf %s "[Unit]
Description=Docker Application Container Engine
Documentation=https://docs.docker.com
After=network.target minikube-automount.service docker.socket
Requires= minikube-automount.service docker.socket
StartLimitBurst=3
StartLimitIntervalSec=60
[Service]
Type=notify
Restart=on-failure
# This file is a systemd drop-in unit that inherits from the base dockerd configuration.
# The base configuration already specifies an 'ExecStart=...' command. The first directive
# here is to clear out that command inherited from the base configuration. Without this,
# the command from the base configuration and the command specified here are treated as
# a sequence of commands, which is not the desired behavior, nor is it valid -- systemd
# will catch this invalid input and refuse to start the service with an error like:
# Service has more than one ExecStart= setting, which is only allowed for Type=oneshot services.
# NOTE: default-ulimit=nofile is set to an arbitrary number for consistency with other
# container runtimes. If left unlimited, it may result in OOM issues with MySQL.
ExecStart=
ExecStart=/usr/bin/dockerd -H tcp://0.0.0.0:2376 -H unix:///var/run/docker.sock --default-ulimit=nofile=1048576:1048576 --tlsverify --tlscacert /etc/docker/ca.pem --tlscert /etc/docker/server.pem --tlskey /etc/docker/server-key.pem --label provider=hyperkit --insecure-registry 10.96.0.0/12
ExecReload=/bin/kill -s HUP \$MAINPID
# Having non-zero Limit*s causes performance problems due to accounting overhead
# in the kernel. We recommend using cgroups to do container-local accounting.
LimitNOFILE=infinity
LimitNPROC=infinity
LimitCORE=infinity
# Uncomment TasksMax if your systemd version supports it.
# Only systemd 226 and above support this version.
TasksMax=infinity
TimeoutStartSec=0
# set delegate yes so that systemd does not reset the cgroups of docker containers
Delegate=yes
# kill only the docker process, not all processes in the cgroup
KillMode=process
[Install]
WantedBy=multi-user.target
" | sudo tee /lib/systemd/system/docker.service.new
I0919 10:15:19.210217 5780 main.go:141] libmachine: SSH cmd err, output: <nil>: [Unit]
Description=Docker Application Container Engine
Documentation=https://docs.docker.com
After=network.target minikube-automount.service docker.socket
Requires= minikube-automount.service docker.socket
StartLimitBurst=3
StartLimitIntervalSec=60
[Service]
Type=notify
Restart=on-failure
# This file is a systemd drop-in unit that inherits from the base dockerd configuration.
# The base configuration already specifies an 'ExecStart=...' command. The first directive
# here is to clear out that command inherited from the base configuration. Without this,
# the command from the base configuration and the command specified here are treated as
# a sequence of commands, which is not the desired behavior, nor is it valid -- systemd
# will catch this invalid input and refuse to start the service with an error like:
# Service has more than one ExecStart= setting, which is only allowed for Type=oneshot services.
# NOTE: default-ulimit=nofile is set to an arbitrary number for consistency with other
# container runtimes. If left unlimited, it may result in OOM issues with MySQL.
ExecStart=
ExecStart=/usr/bin/dockerd -H tcp://0.0.0.0:2376 -H unix:///var/run/docker.sock --default-ulimit=nofile=1048576:1048576 --tlsverify --tlscacert /etc/docker/ca.pem --tlscert /etc/docker/server.pem --tlskey /etc/docker/server-key.pem --label provider=hyperkit --insecure-registry 10.96.0.0/12
ExecReload=/bin/kill -s HUP $MAINPID
# Having non-zero Limit*s causes performance problems due to accounting overhead
# in the kernel. We recommend using cgroups to do container-local accounting.
LimitNOFILE=infinity
LimitNPROC=infinity
LimitCORE=infinity
# Uncomment TasksMax if your systemd version supports it.
# Only systemd 226 and above support this version.
TasksMax=infinity
TimeoutStartSec=0
# set delegate yes so that systemd does not reset the cgroups of docker containers
Delegate=yes
# kill only the docker process, not all processes in the cgroup
KillMode=process
[Install]
WantedBy=multi-user.target
I0919 10:15:19.210243 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHHostname
I0919 10:15:19.210389 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHPort
I0919 10:15:19.210477 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHKeyPath
I0919 10:15:19.210581 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHKeyPath
I0919 10:15:19.210729 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHUsername
I0919 10:15:19.210883 5780 main.go:141] libmachine: Using SSH client type: native
I0919 10:15:19.211160 5780 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x13f2920] 0x13f5600 <nil> [] 0s} 192.168.64.32 22 <nil> <nil>}
I0919 10:15:19.211174 5780 main.go:141] libmachine: About to run SSH command:
sudo diff -u /lib/systemd/system/docker.service /lib/systemd/system/docker.service.new || { sudo mv /lib/systemd/system/docker.service.new /lib/systemd/system/docker.service; sudo systemctl -f daemon-reload && sudo systemctl -f enable docker && sudo systemctl -f restart docker; }
I0919 10:15:19.713836 5780 main.go:141] libmachine: SSH cmd err, output: <nil>: diff: can't stat '/lib/systemd/system/docker.service': No such file or directory
Created symlink /etc/systemd/system/multi-user.target.wants/docker.service → /usr/lib/systemd/system/docker.service.
I0919 10:15:19.713852 5780 main.go:141] libmachine: Checking connection to Docker...
I0919 10:15:19.713858 5780 main.go:141] libmachine: (calico-745000) Calling .GetURL
I0919 10:15:19.714006 5780 main.go:141] libmachine: Docker is up and running!
I0919 10:15:19.714013 5780 main.go:141] libmachine: Reticulating splines...
I0919 10:15:19.714018 5780 client.go:171] LocalClient.Create took 11.715489401s
I0919 10:15:19.714054 5780 start.go:167] duration metric: libmachine.API.Create for "calico-745000" took 11.715537964s
I0919 10:15:19.714062 5780 start.go:300] post-start starting for "calico-745000" (driver="hyperkit")
I0919 10:15:19.714070 5780 start.go:329] creating required directories: [/etc/kubernetes/addons /etc/kubernetes/manifests /var/tmp/minikube /var/lib/minikube /var/lib/minikube/certs /var/lib/minikube/images /var/lib/minikube/binaries /tmp/gvisor /usr/share/ca-certificates /etc/ssl/certs]
I0919 10:15:19.714084 5780 main.go:141] libmachine: (calico-745000) Calling .DriverName
I0919 10:15:19.714231 5780 ssh_runner.go:195] Run: sudo mkdir -p /etc/kubernetes/addons /etc/kubernetes/manifests /var/tmp/minikube /var/lib/minikube /var/lib/minikube/certs /var/lib/minikube/images /var/lib/minikube/binaries /tmp/gvisor /usr/share/ca-certificates /etc/ssl/certs
I0919 10:15:19.714246 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHHostname
I0919 10:15:19.714344 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHPort
I0919 10:15:19.714449 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHKeyPath
I0919 10:15:19.714545 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHUsername
I0919 10:15:19.714642 5780 sshutil.go:53] new ssh client: &{IP:192.168.64.32 Port:22 SSHKeyPath:/Users/jenkins/minikube-integration/17240-937/.minikube/machines/calico-745000/id_rsa Username:docker}
I0919 10:15:19.747180 5780 ssh_runner.go:195] Run: cat /etc/os-release
I0919 10:15:19.750036 5780 info.go:137] Remote host: Buildroot 2021.02.12
I0919 10:15:19.750056 5780 filesync.go:126] Scanning /Users/jenkins/minikube-integration/17240-937/.minikube/addons for local assets ...
I0919 10:15:19.750159 5780 filesync.go:126] Scanning /Users/jenkins/minikube-integration/17240-937/.minikube/files for local assets ...
I0919 10:15:19.750328 5780 filesync.go:149] local asset: /Users/jenkins/minikube-integration/17240-937/.minikube/files/etc/ssl/certs/13852.pem -> 13852.pem in /etc/ssl/certs
I0919 10:15:19.750510 5780 ssh_runner.go:195] Run: sudo mkdir -p /etc/ssl/certs
I0919 10:15:19.756153 5780 ssh_runner.go:362] scp /Users/jenkins/minikube-integration/17240-937/.minikube/files/etc/ssl/certs/13852.pem --> /etc/ssl/certs/13852.pem (1708 bytes)
I0919 10:15:19.772907 5780 start.go:303] post-start completed in 58.835797ms
I0919 10:15:19.772941 5780 main.go:141] libmachine: (calico-745000) Calling .GetConfigRaw
I0919 10:15:19.773506 5780 main.go:141] libmachine: (calico-745000) Calling .GetIP
I0919 10:15:19.773657 5780 profile.go:148] Saving config to /Users/jenkins/minikube-integration/17240-937/.minikube/profiles/calico-745000/config.json ...
I0919 10:15:19.773963 5780 start.go:128] duration metric: createHost completed in 11.805489553s
I0919 10:15:19.773980 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHHostname
I0919 10:15:19.774070 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHPort
I0919 10:15:19.774158 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHKeyPath
I0919 10:15:19.774251 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHKeyPath
I0919 10:15:19.774331 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHUsername
I0919 10:15:19.774434 5780 main.go:141] libmachine: Using SSH client type: native
I0919 10:15:19.774670 5780 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x13f2920] 0x13f5600 <nil> [] 0s} 192.168.64.32 22 <nil> <nil>}
I0919 10:15:19.774678 5780 main.go:141] libmachine: About to run SSH command:
date +%s.%N
I0919 10:15:19.829247 5780 main.go:141] libmachine: SSH cmd err, output: <nil>: 1695143719.785198548
I0919 10:15:19.829263 5780 fix.go:206] guest clock: 1695143719.785198548
I0919 10:15:19.829269 5780 fix.go:219] Guest: 2023-09-19 10:15:19.785198548 -0700 PDT Remote: 2023-09-19 10:15:19.773972 -0700 PDT m=+12.338577459 (delta=11.226548ms)
I0919 10:15:19.829291 5780 fix.go:190] guest clock delta is within tolerance: 11.226548ms
I0919 10:15:19.829295 5780 start.go:83] releasing machines lock for "calico-745000", held for 11.860906378s
I0919 10:15:19.829313 5780 main.go:141] libmachine: (calico-745000) Calling .DriverName
I0919 10:15:19.829448 5780 main.go:141] libmachine: (calico-745000) Calling .GetIP
I0919 10:15:19.829536 5780 main.go:141] libmachine: (calico-745000) Calling .DriverName
I0919 10:15:19.829827 5780 main.go:141] libmachine: (calico-745000) Calling .DriverName
I0919 10:15:19.829926 5780 main.go:141] libmachine: (calico-745000) Calling .DriverName
I0919 10:15:19.830020 5780 ssh_runner.go:195] Run: curl -sS -m 2 https://registry.k8s.io/
I0919 10:15:19.830050 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHHostname
I0919 10:15:19.830054 5780 ssh_runner.go:195] Run: cat /version.json
I0919 10:15:19.830063 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHHostname
I0919 10:15:19.830160 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHPort
I0919 10:15:19.830172 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHPort
I0919 10:15:19.830246 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHKeyPath
I0919 10:15:19.830250 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHKeyPath
I0919 10:15:19.830331 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHUsername
I0919 10:15:19.830346 5780 main.go:141] libmachine: (calico-745000) Calling .GetSSHUsername
I0919 10:15:19.830417 5780 sshutil.go:53] new ssh client: &{IP:192.168.64.32 Port:22 SSHKeyPath:/Users/jenkins/minikube-integration/17240-937/.minikube/machines/calico-745000/id_rsa Username:docker}
I0919 10:15:19.830441 5780 sshutil.go:53] new ssh client: &{IP:192.168.64.32 Port:22 SSHKeyPath:/Users/jenkins/minikube-integration/17240-937/.minikube/machines/calico-745000/id_rsa Username:docker}
I0919 10:15:19.936807 5780 ssh_runner.go:195] Run: systemctl --version
I0919 10:15:19.941341 5780 ssh_runner.go:195] Run: sh -c "stat /etc/cni/net.d/*loopback.conf*"
W0919 10:15:19.944777 5780 cni.go:209] loopback cni configuration skipped: "/etc/cni/net.d/*loopback.conf*" not found
I0919 10:15:19.944833 5780 ssh_runner.go:195] Run: sudo find /etc/cni/net.d -maxdepth 1 -type f ( ( -name *bridge* -or -name *podman* ) -and -not -name *.mk_disabled ) -printf "%p, " -exec sh -c "sudo mv {} {}.mk_disabled" ;
I0919 10:15:19.955828 5780 cni.go:262] disabled [/etc/cni/net.d/87-podman-bridge.conflist] bridge cni config(s)
I0919 10:15:19.955840 5780 start.go:469] detecting cgroup driver to use...
I0919 10:15:19.955950 5780 ssh_runner.go:195] Run: /bin/bash -c "sudo mkdir -p /etc && printf %s "runtime-endpoint: unix:///run/containerd/containerd.sock
" | sudo tee /etc/crictl.yaml"
I0919 10:15:19.967768 5780 ssh_runner.go:195] Run: sh -c "sudo sed -i -r 's|^( *)sandbox_image = .*$|\1sandbox_image = "registry.k8s.io/pause:3.9"|' /etc/containerd/config.toml"
I0919 10:15:19.974925 5780 ssh_runner.go:195] Run: sh -c "sudo sed -i -r 's|^( *)restrict_oom_score_adj = .*$|\1restrict_oom_score_adj = false|' /etc/containerd/config.toml"
I0919 10:15:19.982125 5780 containerd.go:145] configuring containerd to use "cgroupfs" as cgroup driver...
I0919 10:15:19.982166 5780 ssh_runner.go:195] Run: sh -c "sudo sed -i -r 's|^( *)SystemdCgroup = .*$|\1SystemdCgroup = false|g' /etc/containerd/config.toml"
I0919 10:15:19.989300 5780 ssh_runner.go:195] Run: sh -c "sudo sed -i 's|"io.containerd.runtime.v1.linux"|"io.containerd.runc.v2"|g' /etc/containerd/config.toml"
I0919 10:15:19.996462 5780 ssh_runner.go:195] Run: sh -c "sudo sed -i '/systemd_cgroup/d' /etc/containerd/config.toml"
I0919 10:15:20.003777 5780 ssh_runner.go:195] Run: sh -c "sudo sed -i 's|"io.containerd.runc.v1"|"io.containerd.runc.v2"|g' /etc/containerd/config.toml"
I0919 10:15:20.010933 5780 ssh_runner.go:195] Run: sh -c "sudo rm -rf /etc/cni/net.mk"
I0919 10:15:20.018143 5780 ssh_runner.go:195] Run: sh -c "sudo sed -i -r 's|^( *)conf_dir = .*$|\1conf_dir = "/etc/cni/net.d"|g' /etc/containerd/config.toml"
I0919 10:15:20.025384 5780 ssh_runner.go:195] Run: sudo sysctl net.bridge.bridge-nf-call-iptables
I0919 10:15:20.031790 5780 ssh_runner.go:195] Run: sudo sh -c "echo 1 > /proc/sys/net/ipv4/ip_forward"
I0919 10:15:20.038007 5780 ssh_runner.go:195] Run: sudo systemctl daemon-reload
I0919 10:15:20.122730 5780 ssh_runner.go:195] Run: sudo systemctl restart containerd
I0919 10:15:20.133809 5780 start.go:469] detecting cgroup driver to use...
I0919 10:15:20.133884 5780 ssh_runner.go:195] Run: sudo systemctl cat docker.service
I0919 10:15:20.144322 5780 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service containerd
I0919 10:15:20.153323 5780 ssh_runner.go:195] Run: sudo systemctl stop -f containerd
I0919 10:15:20.165700 5780 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service containerd
I0919 10:15:20.174570 5780 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service crio
I0919 10:15:20.183398 5780 ssh_runner.go:195] Run: sudo systemctl stop -f crio
I0919 10:15:20.206168 5780 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service crio
I0919 10:15:20.215422 5780 ssh_runner.go:195] Run: /bin/bash -c "sudo mkdir -p /etc && printf %s "runtime-endpoint: unix:///var/run/cri-dockerd.sock
" | sudo tee /etc/crictl.yaml"
I0919 10:15:20.227409 5780 ssh_runner.go:195] Run: which cri-dockerd
I0919 10:15:20.229896 5780 ssh_runner.go:195] Run: sudo mkdir -p /etc/systemd/system/cri-docker.service.d
I0919 10:15:20.236251 5780 ssh_runner.go:362] scp memory --> /etc/systemd/system/cri-docker.service.d/10-cni.conf (189 bytes)
I0919 10:15:20.247383 5780 ssh_runner.go:195] Run: sudo systemctl unmask docker.service
I0919 10:15:20.338718 5780 ssh_runner.go:195] Run: sudo systemctl enable docker.socket
I0919 10:15:20.435358 5780 docker.go:535] configuring docker to use "cgroupfs" as cgroup driver...
I0919 10:15:20.435376 5780 ssh_runner.go:362] scp memory --> /etc/docker/daemon.json (144 bytes)
I0919 10:15:20.448063 5780 ssh_runner.go:195] Run: sudo systemctl daemon-reload
I0919 10:15:20.536379 5780 ssh_runner.go:195] Run: sudo systemctl restart docker
I0919 10:15:21.763300 5780 ssh_runner.go:235] Completed: sudo systemctl restart docker: (1.226924266s)
I0919 10:15:21.763358 5780 ssh_runner.go:195] Run: sudo systemctl enable cri-docker.socket
I0919 10:15:21.854319 5780 ssh_runner.go:195] Run: sudo systemctl unmask cri-docker.socket
I0919 10:15:21.952441 5780 ssh_runner.go:195] Run: sudo systemctl enable cri-docker.socket
I0919 10:15:22.048802 5780 ssh_runner.go:195] Run: sudo systemctl daemon-reload
I0919 10:15:22.145529 5780 ssh_runner.go:195] Run: sudo systemctl restart cri-docker.socket
I0919 10:15:22.182955 5780 out.go:177]
W0919 10:15:22.203976 5780 out.go:239] X Exiting due to RUNTIME_ENABLE: Failed to enable container runtime: sudo systemctl restart cri-docker.socket: Process exited with status 1
stdout:
stderr:
Job failed. See "journalctl -xe" for details.
X Exiting due to RUNTIME_ENABLE: Failed to enable container runtime: sudo systemctl restart cri-docker.socket: Process exited with status 1
stdout:
stderr:
Job failed. See "journalctl -xe" for details.
W0919 10:15:22.203993 5780 out.go:239] *
*
W0919 10:15:22.204932 5780 out.go:239] ╭─────────────────────────────────────────────────────────────────────────────────────────────╮
│ │
│ * If the above advice does not help, please let us know: │
│ https://github.com/kubernetes/minikube/issues/new/choose │
│ │
│ * Please run `minikube logs --file=logs.txt` and attach logs.txt to the GitHub issue. │
│ │
╰─────────────────────────────────────────────────────────────────────────────────────────────╯
╭─────────────────────────────────────────────────────────────────────────────────────────────╮
│ │
│ * If the above advice does not help, please let us know: │
│ https://github.com/kubernetes/minikube/issues/new/choose │
│ │
│ * Please run `minikube logs --file=logs.txt` and attach logs.txt to the GitHub issue. │
│ │
╰─────────────────────────────────────────────────────────────────────────────────────────────╯
I0919 10:15:22.287813 5780 out.go:177]
** /stderr **
net_test.go:114: failed start: exit status 90
--- FAIL: TestNetworkPlugins/group/calico/Start (14.89s)