=== RUN TestNetworkPlugins/group/calico/Start
net_test.go:112: (dbg) Run: out/minikube-darwin-amd64 start -p calico-246000 --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-246000 --memory=3072 --alsologtostderr --wait=true --wait-timeout=15m --cni=calico --driver=hyperkit : exit status 90 (15.453672767s)
-- stdout --
* [calico-246000] minikube v1.32.0 on Darwin 14.2
- MINIKUBE_LOCATION=17777
- KUBECONFIG=/Users/jenkins/minikube-integration/17777-1259/kubeconfig
- MINIKUBE_BIN=out/minikube-darwin-amd64
- MINIKUBE_SUPPRESS_DOCKER_PERFORMANCE=true
- MINIKUBE_HOME=/Users/jenkins/minikube-integration/17777-1259/.minikube
- MINIKUBE_FORCE_SYSTEMD=
* Using the hyperkit driver based on user configuration
* Starting control plane node calico-246000 in cluster calico-246000
* Creating hyperkit VM (CPUs=2, Memory=3072MB, Disk=20000MB) ...
-- /stdout --
** stderr **
I1212 15:33:15.610297 5584 out.go:296] Setting OutFile to fd 1 ...
I1212 15:33:15.610734 5584 out.go:343] TERM=,COLORTERM=, which probably does not support color
I1212 15:33:15.610743 5584 out.go:309] Setting ErrFile to fd 2...
I1212 15:33:15.610750 5584 out.go:343] TERM=,COLORTERM=, which probably does not support color
I1212 15:33:15.610955 5584 root.go:338] Updating PATH: /Users/jenkins/minikube-integration/17777-1259/.minikube/bin
I1212 15:33:15.612847 5584 out.go:303] Setting JSON to false
I1212 15:33:15.643540 5584 start.go:128] hostinfo: {"hostname":"MacOS-Agent-2.local","uptime":3766,"bootTime":1702420229,"procs":513,"os":"darwin","platform":"darwin","platformFamily":"Standalone Workstation","platformVersion":"14.2","kernelVersion":"23.2.0","kernelArch":"x86_64","virtualizationSystem":"","virtualizationRole":"","hostId":"2965c349-98a5-5970-aaa9-9eedd3ae5959"}
W1212 15:33:15.643683 5584 start.go:136] gopshost.Virtualization returned error: not implemented yet
I1212 15:33:15.776960 5584 out.go:177] * [calico-246000] minikube v1.32.0 on Darwin 14.2
I1212 15:33:15.799003 5584 out.go:177] - MINIKUBE_LOCATION=17777
I1212 15:33:15.799027 5584 notify.go:220] Checking for updates...
I1212 15:33:15.840774 5584 out.go:177] - KUBECONFIG=/Users/jenkins/minikube-integration/17777-1259/kubeconfig
I1212 15:33:15.862875 5584 out.go:177] - MINIKUBE_BIN=out/minikube-darwin-amd64
I1212 15:33:15.883994 5584 out.go:177] - MINIKUBE_SUPPRESS_DOCKER_PERFORMANCE=true
I1212 15:33:15.904996 5584 out.go:177] - MINIKUBE_HOME=/Users/jenkins/minikube-integration/17777-1259/.minikube
I1212 15:33:15.978986 5584 out.go:177] - MINIKUBE_FORCE_SYSTEMD=
I1212 15:33:16.032630 5584 config.go:182] Loaded profile config "kindnet-246000": Driver=hyperkit, ContainerRuntime=docker, KubernetesVersion=v1.28.4
I1212 15:33:16.032762 5584 config.go:182] Loaded profile config "multinode-449000-m01": Driver=hyperkit, ContainerRuntime=docker, KubernetesVersion=v1.28.4
I1212 15:33:16.032861 5584 driver.go:392] Setting default libvirt URI to qemu:///system
I1212 15:33:16.061907 5584 out.go:177] * Using the hyperkit driver based on user configuration
I1212 15:33:16.119894 5584 start.go:298] selected driver: hyperkit
I1212 15:33:16.119907 5584 start.go:902] validating driver "hyperkit" against <nil>
I1212 15:33:16.119923 5584 start.go:913] status for hyperkit: {Installed:true Healthy:true Running:true NeedsImprovement:false Error:<nil> Reason: Fix: Doc: Version:}
I1212 15:33:16.123120 5584 install.go:52] acquiring lock: {Name:mk4023283b30b374c3f04c8805d539e68824c0b8 Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I1212 15:33:16.123230 5584 install.go:117] Validating docker-machine-driver-hyperkit, PATH=/Users/jenkins/minikube-integration/17777-1259/.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
I1212 15:33:16.131284 5584 install.go:137] /Users/jenkins/workspace/out/docker-machine-driver-hyperkit version is 1.32.0
I1212 15:33:16.135340 5584 install.go:79] stdout: /Users/jenkins/workspace/out/docker-machine-driver-hyperkit
I1212 15:33:16.135378 5584 install.go:81] /Users/jenkins/workspace/out/docker-machine-driver-hyperkit looks good
I1212 15:33:16.135409 5584 start_flags.go:309] no existing cluster config was found, will generate one from the flags
I1212 15:33:16.135605 5584 start_flags.go:931] Waiting for all components: map[apiserver:true apps_running:true default_sa:true extra:true kubelet:true node_ready:true system_pods:true]
I1212 15:33:16.135690 5584 cni.go:84] Creating CNI manager for "calico"
I1212 15:33:16.135707 5584 start_flags.go:318] Found "Calico" CNI - setting NetworkPlugin=cni
I1212 15:33:16.135718 5584 start_flags.go:323] config:
{Name:calico-246000 KeepContext:false EmbedCerts:false MinikubeISO: KicBaseImage:gcr.io/k8s-minikube/kicbase-builds:v0.0.42-1702334074-17764@sha256:242468f3f874ac6982f8a024f9c4a97f957667e2ee92ef27b2ae70cc267db401 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.4 ClusterName:calico-246000 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 GPUs:}
I1212 15:33:16.135871 5584 iso.go:125] acquiring lock: {Name:mk96a55b7848c6dd3321ed62339797ab51ac6b5a Clock:{} Delay:500ms Timeout:10m0s Cancel:<nil>}
I1212 15:33:16.156967 5584 out.go:177] * Starting control plane node calico-246000 in cluster calico-246000
I1212 15:33:16.214968 5584 preload.go:132] Checking if preload exists for k8s version v1.28.4 and runtime docker
I1212 15:33:16.215013 5584 preload.go:148] Found local preload: /Users/jenkins/minikube-integration/17777-1259/.minikube/cache/preloaded-tarball/preloaded-images-k8s-v18-v1.28.4-docker-overlay2-amd64.tar.lz4
I1212 15:33:16.215030 5584 cache.go:56] Caching tarball of preloaded images
I1212 15:33:16.215135 5584 preload.go:174] Found /Users/jenkins/minikube-integration/17777-1259/.minikube/cache/preloaded-tarball/preloaded-images-k8s-v18-v1.28.4-docker-overlay2-amd64.tar.lz4 in cache, skipping download
I1212 15:33:16.215144 5584 cache.go:59] Finished verifying existence of preloaded tar for v1.28.4 on docker
I1212 15:33:16.215227 5584 profile.go:148] Saving config to /Users/jenkins/minikube-integration/17777-1259/.minikube/profiles/calico-246000/config.json ...
I1212 15:33:16.215246 5584 lock.go:35] WriteFile acquiring /Users/jenkins/minikube-integration/17777-1259/.minikube/profiles/calico-246000/config.json: {Name:mk5b6e5851786e374ff2493ff460b095ba6e52da Clock:{} Delay:500ms Timeout:1m0s Cancel:<nil>}
I1212 15:33:16.215537 5584 start.go:365] acquiring machines lock for calico-246000: {Name:mk51496c390b032727acf9b9a5f67e389f19ec26 Clock:{} Delay:500ms Timeout:13m0s Cancel:<nil>}
I1212 15:33:16.215587 5584 start.go:369] acquired machines lock for "calico-246000" in 39.977µs
I1212 15:33:16.215609 5584 start.go:93] Provisioning new machine with config: &{Name:calico-246000 KeepContext:false EmbedCerts:false MinikubeISO:https://storage.googleapis.com/minikube-builds/iso/17738/minikube-v1.32.1-1701996673-17738-amd64.iso KicBaseImage:gcr.io/k8s-minikube/kicbase-builds:v0.0.42-1702334074-17764@sha256:242468f3f874ac6982f8a024f9c4a97f957667e2ee92ef27b2ae70cc267db401 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.4 ClusterName:calico-246000 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.4 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 GPUs:} &{Name: IP: Port:8443 KubernetesVersion:v1.28.4 ContainerRuntime:docker ControlPlane:true Worker:true}
I1212 15:33:16.215655 5584 start.go:125] createHost starting for "" (driver="hyperkit")
I1212 15:33:16.236960 5584 out.go:204] * Creating hyperkit VM (CPUs=2, Memory=3072MB, Disk=20000MB) ...
I1212 15:33:16.237283 5584 main.go:141] libmachine: Found binary path at /Users/jenkins/workspace/out/docker-machine-driver-hyperkit
I1212 15:33:16.237344 5584 main.go:141] libmachine: Launching plugin server for driver hyperkit
I1212 15:33:16.245786 5584 main.go:141] libmachine: Plugin server listening at address 127.0.0.1:53278
I1212 15:33:16.246266 5584 main.go:141] libmachine: () Calling .GetVersion
I1212 15:33:16.246686 5584 main.go:141] libmachine: Using API Version 1
I1212 15:33:16.246698 5584 main.go:141] libmachine: () Calling .SetConfigRaw
I1212 15:33:16.246900 5584 main.go:141] libmachine: () Calling .GetMachineName
I1212 15:33:16.246996 5584 main.go:141] libmachine: (calico-246000) Calling .GetMachineName
I1212 15:33:16.247078 5584 main.go:141] libmachine: (calico-246000) Calling .DriverName
I1212 15:33:16.247164 5584 start.go:159] libmachine.API.Create for "calico-246000" (driver="hyperkit")
I1212 15:33:16.247189 5584 client.go:168] LocalClient.Create starting
I1212 15:33:16.247221 5584 main.go:141] libmachine: Reading certificate data from /Users/jenkins/minikube-integration/17777-1259/.minikube/certs/ca.pem
I1212 15:33:16.247273 5584 main.go:141] libmachine: Decoding PEM data...
I1212 15:33:16.247289 5584 main.go:141] libmachine: Parsing certificate...
I1212 15:33:16.247346 5584 main.go:141] libmachine: Reading certificate data from /Users/jenkins/minikube-integration/17777-1259/.minikube/certs/cert.pem
I1212 15:33:16.247385 5584 main.go:141] libmachine: Decoding PEM data...
I1212 15:33:16.247396 5584 main.go:141] libmachine: Parsing certificate...
I1212 15:33:16.247409 5584 main.go:141] libmachine: Running pre-create checks...
I1212 15:33:16.247420 5584 main.go:141] libmachine: (calico-246000) Calling .PreCreateCheck
I1212 15:33:16.247494 5584 main.go:141] libmachine: (calico-246000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I1212 15:33:16.247689 5584 main.go:141] libmachine: (calico-246000) Calling .GetConfigRaw
I1212 15:33:16.274491 5584 main.go:141] libmachine: Creating machine...
I1212 15:33:16.274528 5584 main.go:141] libmachine: (calico-246000) Calling .Create
I1212 15:33:16.274696 5584 main.go:141] libmachine: (calico-246000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I1212 15:33:16.274980 5584 main.go:141] libmachine: (calico-246000) DBG | I1212 15:33:16.274673 5592 common.go:145] Making disk image using store path: /Users/jenkins/minikube-integration/17777-1259/.minikube
I1212 15:33:16.275108 5584 main.go:141] libmachine: (calico-246000) Downloading /Users/jenkins/minikube-integration/17777-1259/.minikube/cache/boot2docker.iso from file:///Users/jenkins/minikube-integration/17777-1259/.minikube/cache/iso/amd64/minikube-v1.32.1-1701996673-17738-amd64.iso...
I1212 15:33:16.448838 5584 main.go:141] libmachine: (calico-246000) DBG | I1212 15:33:16.448771 5592 common.go:152] Creating ssh key: /Users/jenkins/minikube-integration/17777-1259/.minikube/machines/calico-246000/id_rsa...
I1212 15:33:16.757087 5584 main.go:141] libmachine: (calico-246000) DBG | I1212 15:33:16.756993 5592 common.go:158] Creating raw disk image: /Users/jenkins/minikube-integration/17777-1259/.minikube/machines/calico-246000/calico-246000.rawdisk...
I1212 15:33:16.757108 5584 main.go:141] libmachine: (calico-246000) DBG | Writing magic tar header
I1212 15:33:16.757119 5584 main.go:141] libmachine: (calico-246000) DBG | Writing SSH key tar header
I1212 15:33:16.757595 5584 main.go:141] libmachine: (calico-246000) DBG | I1212 15:33:16.757553 5592 common.go:172] Fixing permissions on /Users/jenkins/minikube-integration/17777-1259/.minikube/machines/calico-246000 ...
I1212 15:33:17.091833 5584 main.go:141] libmachine: (calico-246000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I1212 15:33:17.091852 5584 main.go:141] libmachine: (calico-246000) DBG | clean start, hyperkit pid file doesn't exist: /Users/jenkins/minikube-integration/17777-1259/.minikube/machines/calico-246000/hyperkit.pid
I1212 15:33:17.091866 5584 main.go:141] libmachine: (calico-246000) DBG | Using UUID d3086f26-9946-11ee-84ae-f01898ef957c
I1212 15:33:17.118814 5584 main.go:141] libmachine: (calico-246000) DBG | Generated MAC be:a:8f:f8:67:68
I1212 15:33:17.118836 5584 main.go:141] libmachine: (calico-246000) 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-246000
I1212 15:33:17.118891 5584 main.go:141] libmachine: (calico-246000) DBG | 2023/12/12 15:33:17 DEBUG: hyperkit: Start &hyperkit.HyperKit{HyperKit:"/usr/local/bin/hyperkit", Argv0:"", StateDir:"/Users/jenkins/minikube-integration/17777-1259/.minikube/machines/calico-246000", VPNKitSock:"", VPNKitUUID:"", VPNKitPreferredIPv4:"", UUID:"d3086f26-9946-11ee-84ae-f01898ef957c", Disks:[]hyperkit.Disk{(*hyperkit.RawDisk)(0xc000282360)}, ISOImages:[]string{"/Users/jenkins/minikube-integration/17777-1259/.minikube/machines/calico-246000/boot2docker.iso"}, VSock:false, VSockDir:"", VSockPorts:[]int(nil), VSockGuestCID:3, VMNet:true, Sockets9P:[]hyperkit.Socket9P(nil), Kernel:"/Users/jenkins/minikube-integration/17777-1259/.minikube/machines/calico-246000/bzimage", Initrd:"/Users/jenkins/minikube-integration/17777-1259/.minikube/machines/calico-246000/initrd", Bootrom:"", CPUs:2, Memory:3072, Console:1, Serials:[]hyperkit.Serial(nil), Pid:0, Arguments:[]string(nil), CmdLine:"", process:(*os.Process)(nil)}
I1212 15:33:17.118943 5584 main.go:141] libmachine: (calico-246000) DBG | 2023/12/12 15:33:17 DEBUG: hyperkit: check &hyperkit.HyperKit{HyperKit:"/usr/local/bin/hyperkit", Argv0:"", StateDir:"/Users/jenkins/minikube-integration/17777-1259/.minikube/machines/calico-246000", VPNKitSock:"", VPNKitUUID:"", VPNKitPreferredIPv4:"", UUID:"d3086f26-9946-11ee-84ae-f01898ef957c", Disks:[]hyperkit.Disk{(*hyperkit.RawDisk)(0xc000282360)}, ISOImages:[]string{"/Users/jenkins/minikube-integration/17777-1259/.minikube/machines/calico-246000/boot2docker.iso"}, VSock:false, VSockDir:"", VSockPorts:[]int(nil), VSockGuestCID:3, VMNet:true, Sockets9P:[]hyperkit.Socket9P(nil), Kernel:"/Users/jenkins/minikube-integration/17777-1259/.minikube/machines/calico-246000/bzimage", Initrd:"/Users/jenkins/minikube-integration/17777-1259/.minikube/machines/calico-246000/initrd", Bootrom:"", CPUs:2, Memory:3072, Console:1, Serials:[]hyperkit.Serial(nil), Pid:0, Arguments:[]string(nil), CmdLine:"", process:(*os.Process)(nil)}
I1212 15:33:17.118998 5584 main.go:141] libmachine: (calico-246000) DBG | 2023/12/12 15:33:17 DEBUG: hyperkit: Arguments: []string{"-A", "-u", "-F", "/Users/jenkins/minikube-integration/17777-1259/.minikube/machines/calico-246000/hyperkit.pid", "-c", "2", "-m", "3072M", "-s", "0:0,hostbridge", "-s", "31,lpc", "-s", "1:0,virtio-net", "-U", "d3086f26-9946-11ee-84ae-f01898ef957c", "-s", "2:0,virtio-blk,/Users/jenkins/minikube-integration/17777-1259/.minikube/machines/calico-246000/calico-246000.rawdisk", "-s", "3,ahci-cd,/Users/jenkins/minikube-integration/17777-1259/.minikube/machines/calico-246000/boot2docker.iso", "-s", "4,virtio-rnd", "-l", "com1,autopty=/Users/jenkins/minikube-integration/17777-1259/.minikube/machines/calico-246000/tty,log=/Users/jenkins/minikube-integration/17777-1259/.minikube/machines/calico-246000/console-ring", "-f", "kexec,/Users/jenkins/minikube-integration/17777-1259/.minikube/machines/calico-246000/bzimage,/Users/jenkins/minikube-integration/17777-1259/.minikube/machine
s/calico-246000/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-246000"}
I1212 15:33:17.119049 5584 main.go:141] libmachine: (calico-246000) DBG | 2023/12/12 15:33:17 DEBUG: hyperkit: CmdLine: "/usr/local/bin/hyperkit -A -u -F /Users/jenkins/minikube-integration/17777-1259/.minikube/machines/calico-246000/hyperkit.pid -c 2 -m 3072M -s 0:0,hostbridge -s 31,lpc -s 1:0,virtio-net -U d3086f26-9946-11ee-84ae-f01898ef957c -s 2:0,virtio-blk,/Users/jenkins/minikube-integration/17777-1259/.minikube/machines/calico-246000/calico-246000.rawdisk -s 3,ahci-cd,/Users/jenkins/minikube-integration/17777-1259/.minikube/machines/calico-246000/boot2docker.iso -s 4,virtio-rnd -l com1,autopty=/Users/jenkins/minikube-integration/17777-1259/.minikube/machines/calico-246000/tty,log=/Users/jenkins/minikube-integration/17777-1259/.minikube/machines/calico-246000/console-ring -f kexec,/Users/jenkins/minikube-integration/17777-1259/.minikube/machines/calico-246000/bzimage,/Users/jenkins/minikube-integration/17777-1259/.minikube/machines/calico-246000/initrd,earlyprintk=serial loglevel=3 console=t
tyS0 console=tty0 noembed nomodeset norestore waitusb=10 systemd.legacy_systemd_cgroup_controller=yes random.trust_cpu=on hw_rng_model=virtio base host=calico-246000"
I1212 15:33:17.119070 5584 main.go:141] libmachine: (calico-246000) DBG | 2023/12/12 15:33:17 DEBUG: hyperkit: Redirecting stdout/stderr to logger
I1212 15:33:17.122428 5584 main.go:141] libmachine: (calico-246000) DBG | 2023/12/12 15:33:17 DEBUG: hyperkit: Pid is 5593
I1212 15:33:17.123180 5584 main.go:141] libmachine: (calico-246000) DBG | Attempt 0
I1212 15:33:17.123231 5584 main.go:141] libmachine: (calico-246000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I1212 15:33:17.123289 5584 main.go:141] libmachine: (calico-246000) DBG | hyperkit pid from json: 5593
I1212 15:33:17.124817 5584 main.go:141] libmachine: (calico-246000) DBG | Searching for be:a:8f:f8:67:68 in /var/db/dhcpd_leases ...
I1212 15:33:17.124916 5584 main.go:141] libmachine: (calico-246000) DBG | Found 31 entries in /var/db/dhcpd_leases!
I1212 15:33:17.124935 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.32 HWAddress:2e:f0:88:28:e9:f0 ID:1,2e:f0:88:28:e9:f0 Lease:0x657a3f22}
I1212 15:33:17.125034 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.31 HWAddress:e6:fc:c5:79:3:fe ID:1,e6:fc:c5:79:3:fe Lease:0x657a3ef2}
I1212 15:33:17.125060 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.30 HWAddress:9a:41:62:a7:55:94 ID:1,9a:41:62:a7:55:94 Lease:0x6578ed96}
I1212 15:33:17.125073 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.29 HWAddress:86:2a:19:7f:73:11 ID:1,86:2a:19:7f:73:11 Lease:0x6578ed51}
I1212 15:33:17.125088 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.28 HWAddress:12:a7:c5:2a:83:68 ID:1,12:a7:c5:2a:83:68 Lease:0x657a3e95}
I1212 15:33:17.125098 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.27 HWAddress:ca:17:c1:a2:b3:9a ID:1,ca:17:c1:a2:b3:9a Lease:0x657a3e6b}
I1212 15:33:17.125106 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.26 HWAddress:de:91:ef:2f:c8:e6 ID:1,de:91:ef:2f:c8:e6 Lease:0x657a3e4e}
I1212 15:33:17.125120 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.25 HWAddress:c2:1:1c:d2:d:70 ID:1,c2:1:1c:d2:d:70 Lease:0x657a3d51}
I1212 15:33:17.125130 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.24 HWAddress:b2:38:3b:1c:7b:20 ID:1,b2:38:3b:1c:7b:20 Lease:0x657a3d1b}
I1212 15:33:17.125138 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.23 HWAddress:9e:62:f3:45:4a:1c ID:1,9e:62:f3:45:4a:1c Lease:0x657a3d0f}
I1212 15:33:17.125147 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.22 HWAddress:ca:3e:b:b3:65:c6 ID:1,ca:3e:b:b3:65:c6 Lease:0x6578eb8e}
I1212 15:33:17.125156 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.21 HWAddress:16:c9:34:3e:5:c ID:1,16:c9:34:3e:5:c Lease:0x657a3ce6}
I1212 15:33:17.125164 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.20 HWAddress:9a:8:ff:ec:e2:b0 ID:1,9a:8:ff:ec:e2:b0 Lease:0x657a3cc7}
I1212 15:33:17.125172 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.19 HWAddress:b2:4:5e:b3:6c:e8 ID:1,b2:4:5e:b3:6c:e8 Lease:0x657a3caf}
I1212 15:33:17.125179 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.18 HWAddress:e2:5f:6f:53:5d:21 ID:1,e2:5f:6f:53:5d:21 Lease:0x657a3c43}
I1212 15:33:17.125188 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.17 HWAddress:2:cb:91:2c:14:6a ID:1,2:cb:91:2c:14:6a Lease:0x657a3bd7}
I1212 15:33:17.125201 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.16 HWAddress:fa:97:74:1a:2f:1 ID:1,fa:97:74:1a:2f:1 Lease:0x657a3b9f}
I1212 15:33:17.125227 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.15 HWAddress:ea:8:9b:fa:1f:1b ID:1,ea:8:9b:fa:1f:1b Lease:0x657a3b0a}
I1212 15:33:17.125242 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.14 HWAddress:3a:47:ed:bd:6e:e1 ID:1,3a:47:ed:bd:6e:e1 Lease:0x657a3ae3}
I1212 15:33:17.125257 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.13 HWAddress:f2:78:2:3f:65:80 ID:1,f2:78:2:3f:65:80 Lease:0x657a3ab0}
I1212 15:33:17.125266 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.12 HWAddress:ae:69:eb:53:8c:5b ID:1,ae:69:eb:53:8c:5b Lease:0x6578e85b}
I1212 15:33:17.125281 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.11 HWAddress:6a:5c:e0:d8:73:5b ID:1,6a:5c:e0:d8:73:5b Lease:0x6578e846}
I1212 15:33:17.125292 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.10 HWAddress:22:bc:7e:11:6c:f5 ID:1,22:bc:7e:11:6c:f5 Lease:0x657a397e}
I1212 15:33:17.125303 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.9 HWAddress:fe:39:cb:bf:ae:44 ID:1,fe:39:cb:bf:ae:44 Lease:0x657a3959}
I1212 15:33:17.125314 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.8 HWAddress:9a:c9:f7:34:af:5d ID:1,9a:c9:f7:34:af:5d Lease:0x657a391e}
I1212 15:33:17.125329 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.7 HWAddress:1e:8d:b0:a8:5f:be ID:1,1e:8d:b0:a8:5f:be Lease:0x657a388a}
I1212 15:33:17.125339 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.6 HWAddress:e2:94:44:d7:9:11 ID:1,e2:94:44:d7:9:11 Lease:0x6578e6f7}
I1212 15:33:17.125346 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.5 HWAddress:9a:a8:f:4a:47:90 ID:1,9a:a8:f:4a:47:90 Lease:0x657a3755}
I1212 15:33:17.125354 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.4 HWAddress:c6:cb:3c:63:0:f6 ID:1,c6:cb:3c:63:0:f6 Lease:0x657a3728}
I1212 15:33:17.125365 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.3 HWAddress:ea:48:d3:f6:3:6b ID:1,ea:48:d3:f6:3:6b Lease:0x657a3638}
I1212 15:33:17.125378 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name: IPAddress:192.169.0.2 HWAddress:82:2b:f6:5b:7f:bf ID:1,82:2b:f6:5b:7f:bf Lease:0x657a35f5}
I1212 15:33:17.130337 5584 main.go:141] libmachine: (calico-246000) DBG | 2023/12/12 15:33:17 INFO : hyperkit: stderr: Using fd 5 for I/O notifications
I1212 15:33:17.139178 5584 main.go:141] libmachine: (calico-246000) DBG | 2023/12/12 15:33:17 INFO : hyperkit: stderr: /Users/jenkins/minikube-integration/17777-1259/.minikube/machines/calico-246000/boot2docker.iso: fcntl(F_PUNCHHOLE) Operation not permitted: block device will not support TRIM/DISCARD
I1212 15:33:17.140037 5584 main.go:141] libmachine: (calico-246000) DBG | 2023/12/12 15:33:17 INFO : hyperkit: stderr: vmx_set_ctlreg: cap_field: 2 bit: 22 unspecified don't care: bit is 0
I1212 15:33:17.140062 5584 main.go:141] libmachine: (calico-246000) DBG | 2023/12/12 15:33:17 INFO : hyperkit: stderr: vmx_set_ctlreg: cap_field: 4 bit: 12 unspecified don't care: bit is 0
I1212 15:33:17.140077 5584 main.go:141] libmachine: (calico-246000) DBG | 2023/12/12 15:33:17 INFO : hyperkit: stderr: vmx_set_ctlreg: cap_field: 4 bit: 20 unspecified don't care: bit is 0
I1212 15:33:17.140088 5584 main.go:141] libmachine: (calico-246000) DBG | 2023/12/12 15:33:17 INFO : hyperkit: stderr: vmx_set_ctlreg: cap_field: 3 bit: 13 unspecified don't care: bit is 0
I1212 15:33:17.534243 5584 main.go:141] libmachine: (calico-246000) DBG | 2023/12/12 15:33:17 INFO : hyperkit: stderr: rdmsr to register 0x3a on vcpu 0
I1212 15:33:17.534259 5584 main.go:141] libmachine: (calico-246000) DBG | 2023/12/12 15:33:17 INFO : hyperkit: stderr: rdmsr to register 0x140 on vcpu 0
I1212 15:33:17.638400 5584 main.go:141] libmachine: (calico-246000) DBG | 2023/12/12 15:33:17 INFO : hyperkit: stderr: vmx_set_ctlreg: cap_field: 2 bit: 22 unspecified don't care: bit is 0
I1212 15:33:17.638435 5584 main.go:141] libmachine: (calico-246000) DBG | 2023/12/12 15:33:17 INFO : hyperkit: stderr: vmx_set_ctlreg: cap_field: 4 bit: 12 unspecified don't care: bit is 0
I1212 15:33:17.638446 5584 main.go:141] libmachine: (calico-246000) DBG | 2023/12/12 15:33:17 INFO : hyperkit: stderr: vmx_set_ctlreg: cap_field: 4 bit: 20 unspecified don't care: bit is 0
I1212 15:33:17.638462 5584 main.go:141] libmachine: (calico-246000) DBG | 2023/12/12 15:33:17 INFO : hyperkit: stderr: vmx_set_ctlreg: cap_field: 3 bit: 13 unspecified don't care: bit is 0
I1212 15:33:17.639201 5584 main.go:141] libmachine: (calico-246000) DBG | 2023/12/12 15:33:17 INFO : hyperkit: stderr: rdmsr to register 0x3a on vcpu 1
I1212 15:33:17.639223 5584 main.go:141] libmachine: (calico-246000) DBG | 2023/12/12 15:33:17 INFO : hyperkit: stderr: rdmsr to register 0x140 on vcpu 1
I1212 15:33:19.126145 5584 main.go:141] libmachine: (calico-246000) DBG | Attempt 1
I1212 15:33:19.126162 5584 main.go:141] libmachine: (calico-246000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I1212 15:33:19.126267 5584 main.go:141] libmachine: (calico-246000) DBG | hyperkit pid from json: 5593
I1212 15:33:19.127109 5584 main.go:141] libmachine: (calico-246000) DBG | Searching for be:a:8f:f8:67:68 in /var/db/dhcpd_leases ...
I1212 15:33:19.127193 5584 main.go:141] libmachine: (calico-246000) DBG | Found 31 entries in /var/db/dhcpd_leases!
I1212 15:33:19.127213 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.32 HWAddress:2e:f0:88:28:e9:f0 ID:1,2e:f0:88:28:e9:f0 Lease:0x657a3f22}
I1212 15:33:19.127238 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.31 HWAddress:e6:fc:c5:79:3:fe ID:1,e6:fc:c5:79:3:fe Lease:0x657a3ef2}
I1212 15:33:19.127263 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.30 HWAddress:9a:41:62:a7:55:94 ID:1,9a:41:62:a7:55:94 Lease:0x6578ed96}
I1212 15:33:19.127301 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.29 HWAddress:86:2a:19:7f:73:11 ID:1,86:2a:19:7f:73:11 Lease:0x6578ed51}
I1212 15:33:19.127320 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.28 HWAddress:12:a7:c5:2a:83:68 ID:1,12:a7:c5:2a:83:68 Lease:0x657a3e95}
I1212 15:33:19.127338 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.27 HWAddress:ca:17:c1:a2:b3:9a ID:1,ca:17:c1:a2:b3:9a Lease:0x657a3e6b}
I1212 15:33:19.127359 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.26 HWAddress:de:91:ef:2f:c8:e6 ID:1,de:91:ef:2f:c8:e6 Lease:0x657a3e4e}
I1212 15:33:19.127370 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.25 HWAddress:c2:1:1c:d2:d:70 ID:1,c2:1:1c:d2:d:70 Lease:0x657a3d51}
I1212 15:33:19.127378 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.24 HWAddress:b2:38:3b:1c:7b:20 ID:1,b2:38:3b:1c:7b:20 Lease:0x657a3d1b}
I1212 15:33:19.127384 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.23 HWAddress:9e:62:f3:45:4a:1c ID:1,9e:62:f3:45:4a:1c Lease:0x657a3d0f}
I1212 15:33:19.127391 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.22 HWAddress:ca:3e:b:b3:65:c6 ID:1,ca:3e:b:b3:65:c6 Lease:0x6578eb8e}
I1212 15:33:19.127398 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.21 HWAddress:16:c9:34:3e:5:c ID:1,16:c9:34:3e:5:c Lease:0x657a3ce6}
I1212 15:33:19.127408 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.20 HWAddress:9a:8:ff:ec:e2:b0 ID:1,9a:8:ff:ec:e2:b0 Lease:0x657a3cc7}
I1212 15:33:19.127435 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.19 HWAddress:b2:4:5e:b3:6c:e8 ID:1,b2:4:5e:b3:6c:e8 Lease:0x657a3caf}
I1212 15:33:19.127448 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.18 HWAddress:e2:5f:6f:53:5d:21 ID:1,e2:5f:6f:53:5d:21 Lease:0x657a3c43}
I1212 15:33:19.127458 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.17 HWAddress:2:cb:91:2c:14:6a ID:1,2:cb:91:2c:14:6a Lease:0x657a3bd7}
I1212 15:33:19.127466 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.16 HWAddress:fa:97:74:1a:2f:1 ID:1,fa:97:74:1a:2f:1 Lease:0x657a3b9f}
I1212 15:33:19.127473 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.15 HWAddress:ea:8:9b:fa:1f:1b ID:1,ea:8:9b:fa:1f:1b Lease:0x657a3b0a}
I1212 15:33:19.127481 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.14 HWAddress:3a:47:ed:bd:6e:e1 ID:1,3a:47:ed:bd:6e:e1 Lease:0x657a3ae3}
I1212 15:33:19.127488 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.13 HWAddress:f2:78:2:3f:65:80 ID:1,f2:78:2:3f:65:80 Lease:0x657a3ab0}
I1212 15:33:19.127496 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.12 HWAddress:ae:69:eb:53:8c:5b ID:1,ae:69:eb:53:8c:5b Lease:0x6578e85b}
I1212 15:33:19.127504 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.11 HWAddress:6a:5c:e0:d8:73:5b ID:1,6a:5c:e0:d8:73:5b Lease:0x6578e846}
I1212 15:33:19.127512 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.10 HWAddress:22:bc:7e:11:6c:f5 ID:1,22:bc:7e:11:6c:f5 Lease:0x657a397e}
I1212 15:33:19.127520 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.9 HWAddress:fe:39:cb:bf:ae:44 ID:1,fe:39:cb:bf:ae:44 Lease:0x657a3959}
I1212 15:33:19.127529 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.8 HWAddress:9a:c9:f7:34:af:5d ID:1,9a:c9:f7:34:af:5d Lease:0x657a391e}
I1212 15:33:19.127537 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.7 HWAddress:1e:8d:b0:a8:5f:be ID:1,1e:8d:b0:a8:5f:be Lease:0x657a388a}
I1212 15:33:19.127545 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.6 HWAddress:e2:94:44:d7:9:11 ID:1,e2:94:44:d7:9:11 Lease:0x6578e6f7}
I1212 15:33:19.127555 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.5 HWAddress:9a:a8:f:4a:47:90 ID:1,9a:a8:f:4a:47:90 Lease:0x657a3755}
I1212 15:33:19.127563 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.4 HWAddress:c6:cb:3c:63:0:f6 ID:1,c6:cb:3c:63:0:f6 Lease:0x657a3728}
I1212 15:33:19.127571 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.3 HWAddress:ea:48:d3:f6:3:6b ID:1,ea:48:d3:f6:3:6b Lease:0x657a3638}
I1212 15:33:19.127580 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name: IPAddress:192.169.0.2 HWAddress:82:2b:f6:5b:7f:bf ID:1,82:2b:f6:5b:7f:bf Lease:0x657a35f5}
I1212 15:33:21.127494 5584 main.go:141] libmachine: (calico-246000) DBG | Attempt 2
I1212 15:33:21.127512 5584 main.go:141] libmachine: (calico-246000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I1212 15:33:21.127573 5584 main.go:141] libmachine: (calico-246000) DBG | hyperkit pid from json: 5593
I1212 15:33:21.128417 5584 main.go:141] libmachine: (calico-246000) DBG | Searching for be:a:8f:f8:67:68 in /var/db/dhcpd_leases ...
I1212 15:33:21.128482 5584 main.go:141] libmachine: (calico-246000) DBG | Found 31 entries in /var/db/dhcpd_leases!
I1212 15:33:21.128499 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.32 HWAddress:2e:f0:88:28:e9:f0 ID:1,2e:f0:88:28:e9:f0 Lease:0x657a3f22}
I1212 15:33:21.128523 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.31 HWAddress:e6:fc:c5:79:3:fe ID:1,e6:fc:c5:79:3:fe Lease:0x657a3ef2}
I1212 15:33:21.128536 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.30 HWAddress:9a:41:62:a7:55:94 ID:1,9a:41:62:a7:55:94 Lease:0x6578ed96}
I1212 15:33:21.128551 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.29 HWAddress:86:2a:19:7f:73:11 ID:1,86:2a:19:7f:73:11 Lease:0x6578ed51}
I1212 15:33:21.128558 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.28 HWAddress:12:a7:c5:2a:83:68 ID:1,12:a7:c5:2a:83:68 Lease:0x657a3e95}
I1212 15:33:21.128566 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.27 HWAddress:ca:17:c1:a2:b3:9a ID:1,ca:17:c1:a2:b3:9a Lease:0x657a3e6b}
I1212 15:33:21.128573 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.26 HWAddress:de:91:ef:2f:c8:e6 ID:1,de:91:ef:2f:c8:e6 Lease:0x657a3e4e}
I1212 15:33:21.128585 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.25 HWAddress:c2:1:1c:d2:d:70 ID:1,c2:1:1c:d2:d:70 Lease:0x657a3d51}
I1212 15:33:21.128593 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.24 HWAddress:b2:38:3b:1c:7b:20 ID:1,b2:38:3b:1c:7b:20 Lease:0x657a3d1b}
I1212 15:33:21.128624 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.23 HWAddress:9e:62:f3:45:4a:1c ID:1,9e:62:f3:45:4a:1c Lease:0x657a3d0f}
I1212 15:33:21.128638 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.22 HWAddress:ca:3e:b:b3:65:c6 ID:1,ca:3e:b:b3:65:c6 Lease:0x6578eb8e}
I1212 15:33:21.128648 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.21 HWAddress:16:c9:34:3e:5:c ID:1,16:c9:34:3e:5:c Lease:0x657a3ce6}
I1212 15:33:21.128657 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.20 HWAddress:9a:8:ff:ec:e2:b0 ID:1,9a:8:ff:ec:e2:b0 Lease:0x657a3cc7}
I1212 15:33:21.128666 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.19 HWAddress:b2:4:5e:b3:6c:e8 ID:1,b2:4:5e:b3:6c:e8 Lease:0x657a3caf}
I1212 15:33:21.128674 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.18 HWAddress:e2:5f:6f:53:5d:21 ID:1,e2:5f:6f:53:5d:21 Lease:0x657a3c43}
I1212 15:33:21.128683 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.17 HWAddress:2:cb:91:2c:14:6a ID:1,2:cb:91:2c:14:6a Lease:0x657a3bd7}
I1212 15:33:21.128691 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.16 HWAddress:fa:97:74:1a:2f:1 ID:1,fa:97:74:1a:2f:1 Lease:0x657a3b9f}
I1212 15:33:21.128699 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.15 HWAddress:ea:8:9b:fa:1f:1b ID:1,ea:8:9b:fa:1f:1b Lease:0x657a3b0a}
I1212 15:33:21.128707 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.14 HWAddress:3a:47:ed:bd:6e:e1 ID:1,3a:47:ed:bd:6e:e1 Lease:0x657a3ae3}
I1212 15:33:21.128716 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.13 HWAddress:f2:78:2:3f:65:80 ID:1,f2:78:2:3f:65:80 Lease:0x657a3ab0}
I1212 15:33:21.128724 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.12 HWAddress:ae:69:eb:53:8c:5b ID:1,ae:69:eb:53:8c:5b Lease:0x6578e85b}
I1212 15:33:21.128732 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.11 HWAddress:6a:5c:e0:d8:73:5b ID:1,6a:5c:e0:d8:73:5b Lease:0x6578e846}
I1212 15:33:21.128740 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.10 HWAddress:22:bc:7e:11:6c:f5 ID:1,22:bc:7e:11:6c:f5 Lease:0x657a397e}
I1212 15:33:21.128749 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.9 HWAddress:fe:39:cb:bf:ae:44 ID:1,fe:39:cb:bf:ae:44 Lease:0x657a3959}
I1212 15:33:21.128763 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.8 HWAddress:9a:c9:f7:34:af:5d ID:1,9a:c9:f7:34:af:5d Lease:0x657a391e}
I1212 15:33:21.128780 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.7 HWAddress:1e:8d:b0:a8:5f:be ID:1,1e:8d:b0:a8:5f:be Lease:0x657a388a}
I1212 15:33:21.128805 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.6 HWAddress:e2:94:44:d7:9:11 ID:1,e2:94:44:d7:9:11 Lease:0x6578e6f7}
I1212 15:33:21.128814 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.5 HWAddress:9a:a8:f:4a:47:90 ID:1,9a:a8:f:4a:47:90 Lease:0x657a3755}
I1212 15:33:21.128825 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.4 HWAddress:c6:cb:3c:63:0:f6 ID:1,c6:cb:3c:63:0:f6 Lease:0x657a3728}
I1212 15:33:21.128834 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.3 HWAddress:ea:48:d3:f6:3:6b ID:1,ea:48:d3:f6:3:6b Lease:0x657a3638}
I1212 15:33:21.128844 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name: IPAddress:192.169.0.2 HWAddress:82:2b:f6:5b:7f:bf ID:1,82:2b:f6:5b:7f:bf Lease:0x657a35f5}
I1212 15:33:22.591423 5584 main.go:141] libmachine: (calico-246000) DBG | 2023/12/12 15:33:22 INFO : hyperkit: stderr: rdmsr to register 0x64d on vcpu 1
I1212 15:33:22.591467 5584 main.go:141] libmachine: (calico-246000) DBG | 2023/12/12 15:33:22 INFO : hyperkit: stderr: rdmsr to register 0x64e on vcpu 1
I1212 15:33:22.591486 5584 main.go:141] libmachine: (calico-246000) DBG | 2023/12/12 15:33:22 INFO : hyperkit: stderr: rdmsr to register 0x34 on vcpu 1
I1212 15:33:23.129410 5584 main.go:141] libmachine: (calico-246000) DBG | Attempt 3
I1212 15:33:23.129434 5584 main.go:141] libmachine: (calico-246000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I1212 15:33:23.129534 5584 main.go:141] libmachine: (calico-246000) DBG | hyperkit pid from json: 5593
I1212 15:33:23.130380 5584 main.go:141] libmachine: (calico-246000) DBG | Searching for be:a:8f:f8:67:68 in /var/db/dhcpd_leases ...
I1212 15:33:23.130445 5584 main.go:141] libmachine: (calico-246000) DBG | Found 31 entries in /var/db/dhcpd_leases!
I1212 15:33:23.130456 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.32 HWAddress:2e:f0:88:28:e9:f0 ID:1,2e:f0:88:28:e9:f0 Lease:0x657a3f22}
I1212 15:33:23.130491 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.31 HWAddress:e6:fc:c5:79:3:fe ID:1,e6:fc:c5:79:3:fe Lease:0x657a3ef2}
I1212 15:33:23.130502 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.30 HWAddress:9a:41:62:a7:55:94 ID:1,9a:41:62:a7:55:94 Lease:0x6578ed96}
I1212 15:33:23.130518 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.29 HWAddress:86:2a:19:7f:73:11 ID:1,86:2a:19:7f:73:11 Lease:0x6578ed51}
I1212 15:33:23.130540 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.28 HWAddress:12:a7:c5:2a:83:68 ID:1,12:a7:c5:2a:83:68 Lease:0x657a3e95}
I1212 15:33:23.130558 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.27 HWAddress:ca:17:c1:a2:b3:9a ID:1,ca:17:c1:a2:b3:9a Lease:0x657a3e6b}
I1212 15:33:23.130583 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.26 HWAddress:de:91:ef:2f:c8:e6 ID:1,de:91:ef:2f:c8:e6 Lease:0x657a3e4e}
I1212 15:33:23.130594 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.25 HWAddress:c2:1:1c:d2:d:70 ID:1,c2:1:1c:d2:d:70 Lease:0x657a3d51}
I1212 15:33:23.130612 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.24 HWAddress:b2:38:3b:1c:7b:20 ID:1,b2:38:3b:1c:7b:20 Lease:0x657a3d1b}
I1212 15:33:23.130632 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.23 HWAddress:9e:62:f3:45:4a:1c ID:1,9e:62:f3:45:4a:1c Lease:0x657a3d0f}
I1212 15:33:23.130644 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.22 HWAddress:ca:3e:b:b3:65:c6 ID:1,ca:3e:b:b3:65:c6 Lease:0x6578eb8e}
I1212 15:33:23.130653 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.21 HWAddress:16:c9:34:3e:5:c ID:1,16:c9:34:3e:5:c Lease:0x657a3ce6}
I1212 15:33:23.130661 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.20 HWAddress:9a:8:ff:ec:e2:b0 ID:1,9a:8:ff:ec:e2:b0 Lease:0x657a3cc7}
I1212 15:33:23.130667 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.19 HWAddress:b2:4:5e:b3:6c:e8 ID:1,b2:4:5e:b3:6c:e8 Lease:0x657a3caf}
I1212 15:33:23.130674 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.18 HWAddress:e2:5f:6f:53:5d:21 ID:1,e2:5f:6f:53:5d:21 Lease:0x657a3c43}
I1212 15:33:23.130681 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.17 HWAddress:2:cb:91:2c:14:6a ID:1,2:cb:91:2c:14:6a Lease:0x657a3bd7}
I1212 15:33:23.130689 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.16 HWAddress:fa:97:74:1a:2f:1 ID:1,fa:97:74:1a:2f:1 Lease:0x657a3b9f}
I1212 15:33:23.130697 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.15 HWAddress:ea:8:9b:fa:1f:1b ID:1,ea:8:9b:fa:1f:1b Lease:0x657a3b0a}
I1212 15:33:23.130706 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.14 HWAddress:3a:47:ed:bd:6e:e1 ID:1,3a:47:ed:bd:6e:e1 Lease:0x657a3ae3}
I1212 15:33:23.130714 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.13 HWAddress:f2:78:2:3f:65:80 ID:1,f2:78:2:3f:65:80 Lease:0x657a3ab0}
I1212 15:33:23.130724 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.12 HWAddress:ae:69:eb:53:8c:5b ID:1,ae:69:eb:53:8c:5b Lease:0x6578e85b}
I1212 15:33:23.130732 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.11 HWAddress:6a:5c:e0:d8:73:5b ID:1,6a:5c:e0:d8:73:5b Lease:0x6578e846}
I1212 15:33:23.130740 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.10 HWAddress:22:bc:7e:11:6c:f5 ID:1,22:bc:7e:11:6c:f5 Lease:0x657a397e}
I1212 15:33:23.130748 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.9 HWAddress:fe:39:cb:bf:ae:44 ID:1,fe:39:cb:bf:ae:44 Lease:0x657a3959}
I1212 15:33:23.130754 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.8 HWAddress:9a:c9:f7:34:af:5d ID:1,9a:c9:f7:34:af:5d Lease:0x657a391e}
I1212 15:33:23.130769 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.7 HWAddress:1e:8d:b0:a8:5f:be ID:1,1e:8d:b0:a8:5f:be Lease:0x657a388a}
I1212 15:33:23.130782 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.6 HWAddress:e2:94:44:d7:9:11 ID:1,e2:94:44:d7:9:11 Lease:0x6578e6f7}
I1212 15:33:23.130791 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.5 HWAddress:9a:a8:f:4a:47:90 ID:1,9a:a8:f:4a:47:90 Lease:0x657a3755}
I1212 15:33:23.130800 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.4 HWAddress:c6:cb:3c:63:0:f6 ID:1,c6:cb:3c:63:0:f6 Lease:0x657a3728}
I1212 15:33:23.130808 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.3 HWAddress:ea:48:d3:f6:3:6b ID:1,ea:48:d3:f6:3:6b Lease:0x657a3638}
I1212 15:33:23.130817 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name: IPAddress:192.169.0.2 HWAddress:82:2b:f6:5b:7f:bf ID:1,82:2b:f6:5b:7f:bf Lease:0x657a35f5}
I1212 15:33:25.131608 5584 main.go:141] libmachine: (calico-246000) DBG | Attempt 4
I1212 15:33:25.131634 5584 main.go:141] libmachine: (calico-246000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I1212 15:33:25.131722 5584 main.go:141] libmachine: (calico-246000) DBG | hyperkit pid from json: 5593
I1212 15:33:25.132654 5584 main.go:141] libmachine: (calico-246000) DBG | Searching for be:a:8f:f8:67:68 in /var/db/dhcpd_leases ...
I1212 15:33:25.132708 5584 main.go:141] libmachine: (calico-246000) DBG | Found 31 entries in /var/db/dhcpd_leases!
I1212 15:33:25.132732 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.32 HWAddress:2e:f0:88:28:e9:f0 ID:1,2e:f0:88:28:e9:f0 Lease:0x657a3f22}
I1212 15:33:25.132758 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.31 HWAddress:e6:fc:c5:79:3:fe ID:1,e6:fc:c5:79:3:fe Lease:0x657a3ef2}
I1212 15:33:25.132778 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.30 HWAddress:9a:41:62:a7:55:94 ID:1,9a:41:62:a7:55:94 Lease:0x6578ed96}
I1212 15:33:25.132813 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.29 HWAddress:86:2a:19:7f:73:11 ID:1,86:2a:19:7f:73:11 Lease:0x6578ed51}
I1212 15:33:25.132828 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.28 HWAddress:12:a7:c5:2a:83:68 ID:1,12:a7:c5:2a:83:68 Lease:0x657a3e95}
I1212 15:33:25.132838 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.27 HWAddress:ca:17:c1:a2:b3:9a ID:1,ca:17:c1:a2:b3:9a Lease:0x657a3e6b}
I1212 15:33:25.132847 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.26 HWAddress:de:91:ef:2f:c8:e6 ID:1,de:91:ef:2f:c8:e6 Lease:0x657a3e4e}
I1212 15:33:25.132858 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.25 HWAddress:c2:1:1c:d2:d:70 ID:1,c2:1:1c:d2:d:70 Lease:0x657a3d51}
I1212 15:33:25.132866 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.24 HWAddress:b2:38:3b:1c:7b:20 ID:1,b2:38:3b:1c:7b:20 Lease:0x657a3d1b}
I1212 15:33:25.132882 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.23 HWAddress:9e:62:f3:45:4a:1c ID:1,9e:62:f3:45:4a:1c Lease:0x657a3d0f}
I1212 15:33:25.132904 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.22 HWAddress:ca:3e:b:b3:65:c6 ID:1,ca:3e:b:b3:65:c6 Lease:0x6578eb8e}
I1212 15:33:25.132918 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.21 HWAddress:16:c9:34:3e:5:c ID:1,16:c9:34:3e:5:c Lease:0x657a3ce6}
I1212 15:33:25.132927 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.20 HWAddress:9a:8:ff:ec:e2:b0 ID:1,9a:8:ff:ec:e2:b0 Lease:0x657a3cc7}
I1212 15:33:25.132937 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.19 HWAddress:b2:4:5e:b3:6c:e8 ID:1,b2:4:5e:b3:6c:e8 Lease:0x657a3caf}
I1212 15:33:25.132946 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.18 HWAddress:e2:5f:6f:53:5d:21 ID:1,e2:5f:6f:53:5d:21 Lease:0x657a3c43}
I1212 15:33:25.132956 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.17 HWAddress:2:cb:91:2c:14:6a ID:1,2:cb:91:2c:14:6a Lease:0x657a3bd7}
I1212 15:33:25.132973 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.16 HWAddress:fa:97:74:1a:2f:1 ID:1,fa:97:74:1a:2f:1 Lease:0x657a3b9f}
I1212 15:33:25.132987 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.15 HWAddress:ea:8:9b:fa:1f:1b ID:1,ea:8:9b:fa:1f:1b Lease:0x657a3b0a}
I1212 15:33:25.132998 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.14 HWAddress:3a:47:ed:bd:6e:e1 ID:1,3a:47:ed:bd:6e:e1 Lease:0x657a3ae3}
I1212 15:33:25.133007 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.13 HWAddress:f2:78:2:3f:65:80 ID:1,f2:78:2:3f:65:80 Lease:0x657a3ab0}
I1212 15:33:25.133016 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.12 HWAddress:ae:69:eb:53:8c:5b ID:1,ae:69:eb:53:8c:5b Lease:0x6578e85b}
I1212 15:33:25.133029 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.11 HWAddress:6a:5c:e0:d8:73:5b ID:1,6a:5c:e0:d8:73:5b Lease:0x6578e846}
I1212 15:33:25.133038 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.10 HWAddress:22:bc:7e:11:6c:f5 ID:1,22:bc:7e:11:6c:f5 Lease:0x657a397e}
I1212 15:33:25.133048 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.9 HWAddress:fe:39:cb:bf:ae:44 ID:1,fe:39:cb:bf:ae:44 Lease:0x657a3959}
I1212 15:33:25.133064 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.8 HWAddress:9a:c9:f7:34:af:5d ID:1,9a:c9:f7:34:af:5d Lease:0x657a391e}
I1212 15:33:25.133075 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.7 HWAddress:1e:8d:b0:a8:5f:be ID:1,1e:8d:b0:a8:5f:be Lease:0x657a388a}
I1212 15:33:25.133088 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.6 HWAddress:e2:94:44:d7:9:11 ID:1,e2:94:44:d7:9:11 Lease:0x6578e6f7}
I1212 15:33:25.133099 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.5 HWAddress:9a:a8:f:4a:47:90 ID:1,9a:a8:f:4a:47:90 Lease:0x657a3755}
I1212 15:33:25.133108 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.4 HWAddress:c6:cb:3c:63:0:f6 ID:1,c6:cb:3c:63:0:f6 Lease:0x657a3728}
I1212 15:33:25.133118 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.3 HWAddress:ea:48:d3:f6:3:6b ID:1,ea:48:d3:f6:3:6b Lease:0x657a3638}
I1212 15:33:25.133129 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name: IPAddress:192.169.0.2 HWAddress:82:2b:f6:5b:7f:bf ID:1,82:2b:f6:5b:7f:bf Lease:0x657a35f5}
I1212 15:33:27.133595 5584 main.go:141] libmachine: (calico-246000) DBG | Attempt 5
I1212 15:33:27.133612 5584 main.go:141] libmachine: (calico-246000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I1212 15:33:27.133687 5584 main.go:141] libmachine: (calico-246000) DBG | hyperkit pid from json: 5593
I1212 15:33:27.134515 5584 main.go:141] libmachine: (calico-246000) DBG | Searching for be:a:8f:f8:67:68 in /var/db/dhcpd_leases ...
I1212 15:33:27.134588 5584 main.go:141] libmachine: (calico-246000) DBG | Found 32 entries in /var/db/dhcpd_leases!
I1212 15:33:27.134601 5584 main.go:141] libmachine: (calico-246000) DBG | dhcp entry: {Name:minikube IPAddress:192.169.0.33 HWAddress:be:a:8f:f8:67:68 ID:1,be:a:8f:f8:67:68 Lease:0x657a3f45}
I1212 15:33:27.134611 5584 main.go:141] libmachine: (calico-246000) DBG | Found match: be:a:8f:f8:67:68
I1212 15:33:27.134622 5584 main.go:141] libmachine: (calico-246000) DBG | IP: 192.169.0.33
I1212 15:33:27.134669 5584 main.go:141] libmachine: (calico-246000) Calling .GetConfigRaw
I1212 15:33:27.150273 5584 main.go:141] libmachine: (calico-246000) Calling .DriverName
I1212 15:33:27.150453 5584 main.go:141] libmachine: (calico-246000) Calling .DriverName
I1212 15:33:27.150556 5584 main.go:141] libmachine: Waiting for machine to be running, this may take a few minutes...
I1212 15:33:27.150566 5584 main.go:141] libmachine: (calico-246000) Calling .GetState
I1212 15:33:27.150658 5584 main.go:141] libmachine: (calico-246000) DBG | exe=/Users/jenkins/workspace/out/docker-machine-driver-hyperkit uid=0
I1212 15:33:27.150712 5584 main.go:141] libmachine: (calico-246000) DBG | hyperkit pid from json: 5593
I1212 15:33:27.151601 5584 main.go:141] libmachine: Detecting operating system of created instance...
I1212 15:33:27.151614 5584 main.go:141] libmachine: Waiting for SSH to be available...
I1212 15:33:27.151638 5584 main.go:141] libmachine: Getting to WaitForSSH function...
I1212 15:33:27.151646 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHHostname
I1212 15:33:27.151728 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHPort
I1212 15:33:27.151811 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHKeyPath
I1212 15:33:27.151890 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHKeyPath
I1212 15:33:27.151980 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHUsername
I1212 15:33:27.152092 5584 main.go:141] libmachine: Using SSH client type: native
I1212 15:33:27.152400 5584 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x1406180] 0x1408e60 <nil> [] 0s} 192.169.0.33 22 <nil> <nil>}
I1212 15:33:27.152408 5584 main.go:141] libmachine: About to run SSH command:
exit 0
I1212 15:33:27.208768 5584 main.go:141] libmachine: SSH cmd err, output: <nil>:
I1212 15:33:27.208783 5584 main.go:141] libmachine: Detecting the provisioner...
I1212 15:33:27.208789 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHHostname
I1212 15:33:27.208915 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHPort
I1212 15:33:27.209009 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHKeyPath
I1212 15:33:27.209097 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHKeyPath
I1212 15:33:27.209186 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHUsername
I1212 15:33:27.209304 5584 main.go:141] libmachine: Using SSH client type: native
I1212 15:33:27.209553 5584 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x1406180] 0x1408e60 <nil> [] 0s} 192.169.0.33 22 <nil> <nil>}
I1212 15:33:27.209562 5584 main.go:141] libmachine: About to run SSH command:
cat /etc/os-release
I1212 15:33:27.266956 5584 main.go:141] libmachine: SSH cmd err, output: <nil>: NAME=Buildroot
VERSION=2021.02.12-1-g0ec83c8-dirty
ID=buildroot
VERSION_ID=2021.02.12
PRETTY_NAME="Buildroot 2021.02.12"
I1212 15:33:27.267014 5584 main.go:141] libmachine: found compatible host: buildroot
I1212 15:33:27.267021 5584 main.go:141] libmachine: Provisioning with buildroot...
I1212 15:33:27.267043 5584 main.go:141] libmachine: (calico-246000) Calling .GetMachineName
I1212 15:33:27.267186 5584 buildroot.go:166] provisioning hostname "calico-246000"
I1212 15:33:27.267202 5584 main.go:141] libmachine: (calico-246000) Calling .GetMachineName
I1212 15:33:27.267299 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHHostname
I1212 15:33:27.267423 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHPort
I1212 15:33:27.267518 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHKeyPath
I1212 15:33:27.267636 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHKeyPath
I1212 15:33:27.267784 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHUsername
I1212 15:33:27.267938 5584 main.go:141] libmachine: Using SSH client type: native
I1212 15:33:27.268198 5584 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x1406180] 0x1408e60 <nil> [] 0s} 192.169.0.33 22 <nil> <nil>}
I1212 15:33:27.268207 5584 main.go:141] libmachine: About to run SSH command:
sudo hostname calico-246000 && echo "calico-246000" | sudo tee /etc/hostname
I1212 15:33:27.333449 5584 main.go:141] libmachine: SSH cmd err, output: <nil>: calico-246000
I1212 15:33:27.333482 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHHostname
I1212 15:33:27.333668 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHPort
I1212 15:33:27.333785 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHKeyPath
I1212 15:33:27.333889 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHKeyPath
I1212 15:33:27.333997 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHUsername
I1212 15:33:27.334129 5584 main.go:141] libmachine: Using SSH client type: native
I1212 15:33:27.334407 5584 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x1406180] 0x1408e60 <nil> [] 0s} 192.169.0.33 22 <nil> <nil>}
I1212 15:33:27.334419 5584 main.go:141] libmachine: About to run SSH command:
if ! grep -xq '.*\scalico-246000' /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-246000/g' /etc/hosts;
else
echo '127.0.1.1 calico-246000' | sudo tee -a /etc/hosts;
fi
fi
I1212 15:33:27.396613 5584 main.go:141] libmachine: SSH cmd err, output: <nil>:
I1212 15:33:27.396653 5584 buildroot.go:172] set auth options {CertDir:/Users/jenkins/minikube-integration/17777-1259/.minikube CaCertPath:/Users/jenkins/minikube-integration/17777-1259/.minikube/certs/ca.pem CaPrivateKeyPath:/Users/jenkins/minikube-integration/17777-1259/.minikube/certs/ca-key.pem CaCertRemotePath:/etc/docker/ca.pem ServerCertPath:/Users/jenkins/minikube-integration/17777-1259/.minikube/machines/server.pem ServerKeyPath:/Users/jenkins/minikube-integration/17777-1259/.minikube/machines/server-key.pem ClientKeyPath:/Users/jenkins/minikube-integration/17777-1259/.minikube/certs/key.pem ServerCertRemotePath:/etc/docker/server.pem ServerKeyRemotePath:/etc/docker/server-key.pem ClientCertPath:/Users/jenkins/minikube-integration/17777-1259/.minikube/certs/cert.pem ServerCertSANs:[] StorePath:/Users/jenkins/minikube-integration/17777-1259/.minikube}
I1212 15:33:27.396695 5584 buildroot.go:174] setting up certificates
I1212 15:33:27.396709 5584 provision.go:83] configureAuth start
I1212 15:33:27.396718 5584 main.go:141] libmachine: (calico-246000) Calling .GetMachineName
I1212 15:33:27.396869 5584 main.go:141] libmachine: (calico-246000) Calling .GetIP
I1212 15:33:27.396978 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHHostname
I1212 15:33:27.397065 5584 provision.go:138] copyHostCerts
I1212 15:33:27.397142 5584 exec_runner.go:144] found /Users/jenkins/minikube-integration/17777-1259/.minikube/cert.pem, removing ...
I1212 15:33:27.397151 5584 exec_runner.go:203] rm: /Users/jenkins/minikube-integration/17777-1259/.minikube/cert.pem
I1212 15:33:27.397289 5584 exec_runner.go:151] cp: /Users/jenkins/minikube-integration/17777-1259/.minikube/certs/cert.pem --> /Users/jenkins/minikube-integration/17777-1259/.minikube/cert.pem (1123 bytes)
I1212 15:33:27.397546 5584 exec_runner.go:144] found /Users/jenkins/minikube-integration/17777-1259/.minikube/key.pem, removing ...
I1212 15:33:27.397553 5584 exec_runner.go:203] rm: /Users/jenkins/minikube-integration/17777-1259/.minikube/key.pem
I1212 15:33:27.397628 5584 exec_runner.go:151] cp: /Users/jenkins/minikube-integration/17777-1259/.minikube/certs/key.pem --> /Users/jenkins/minikube-integration/17777-1259/.minikube/key.pem (1675 bytes)
I1212 15:33:27.397801 5584 exec_runner.go:144] found /Users/jenkins/minikube-integration/17777-1259/.minikube/ca.pem, removing ...
I1212 15:33:27.397807 5584 exec_runner.go:203] rm: /Users/jenkins/minikube-integration/17777-1259/.minikube/ca.pem
I1212 15:33:27.397877 5584 exec_runner.go:151] cp: /Users/jenkins/minikube-integration/17777-1259/.minikube/certs/ca.pem --> /Users/jenkins/minikube-integration/17777-1259/.minikube/ca.pem (1082 bytes)
I1212 15:33:27.398030 5584 provision.go:112] generating server cert: /Users/jenkins/minikube-integration/17777-1259/.minikube/machines/server.pem ca-key=/Users/jenkins/minikube-integration/17777-1259/.minikube/certs/ca.pem private-key=/Users/jenkins/minikube-integration/17777-1259/.minikube/certs/ca-key.pem org=jenkins.calico-246000 san=[192.169.0.33 192.169.0.33 localhost 127.0.0.1 minikube calico-246000]
I1212 15:33:27.481486 5584 provision.go:172] copyRemoteCerts
I1212 15:33:27.481550 5584 ssh_runner.go:195] Run: sudo mkdir -p /etc/docker /etc/docker /etc/docker
I1212 15:33:27.481570 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHHostname
I1212 15:33:27.481760 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHPort
I1212 15:33:27.481865 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHKeyPath
I1212 15:33:27.481972 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHUsername
I1212 15:33:27.482076 5584 sshutil.go:53] new ssh client: &{IP:192.169.0.33 Port:22 SSHKeyPath:/Users/jenkins/minikube-integration/17777-1259/.minikube/machines/calico-246000/id_rsa Username:docker}
I1212 15:33:27.516836 5584 ssh_runner.go:362] scp /Users/jenkins/minikube-integration/17777-1259/.minikube/machines/server-key.pem --> /etc/docker/server-key.pem (1679 bytes)
I1212 15:33:27.533653 5584 ssh_runner.go:362] scp /Users/jenkins/minikube-integration/17777-1259/.minikube/certs/ca.pem --> /etc/docker/ca.pem (1082 bytes)
I1212 15:33:27.549912 5584 ssh_runner.go:362] scp /Users/jenkins/minikube-integration/17777-1259/.minikube/machines/server.pem --> /etc/docker/server.pem (1216 bytes)
I1212 15:33:27.566016 5584 provision.go:86] duration metric: configureAuth took 169.295763ms
I1212 15:33:27.566031 5584 buildroot.go:189] setting minikube options for container-runtime
I1212 15:33:27.566175 5584 config.go:182] Loaded profile config "calico-246000": Driver=hyperkit, ContainerRuntime=docker, KubernetesVersion=v1.28.4
I1212 15:33:27.566190 5584 main.go:141] libmachine: (calico-246000) Calling .DriverName
I1212 15:33:27.566339 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHHostname
I1212 15:33:27.566443 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHPort
I1212 15:33:27.566533 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHKeyPath
I1212 15:33:27.566602 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHKeyPath
I1212 15:33:27.566672 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHUsername
I1212 15:33:27.566776 5584 main.go:141] libmachine: Using SSH client type: native
I1212 15:33:27.567017 5584 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x1406180] 0x1408e60 <nil> [] 0s} 192.169.0.33 22 <nil> <nil>}
I1212 15:33:27.567025 5584 main.go:141] libmachine: About to run SSH command:
df --output=fstype / | tail -n 1
I1212 15:33:27.625389 5584 main.go:141] libmachine: SSH cmd err, output: <nil>: tmpfs
I1212 15:33:27.625409 5584 buildroot.go:70] root file system type: tmpfs
I1212 15:33:27.625490 5584 provision.go:309] Updating docker unit: /lib/systemd/system/docker.service ...
I1212 15:33:27.625509 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHHostname
I1212 15:33:27.625658 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHPort
I1212 15:33:27.625781 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHKeyPath
I1212 15:33:27.625879 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHKeyPath
I1212 15:33:27.625977 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHUsername
I1212 15:33:27.626095 5584 main.go:141] libmachine: Using SSH client type: native
I1212 15:33:27.626355 5584 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x1406180] 0x1408e60 <nil> [] 0s} 192.169.0.33 22 <nil> <nil>}
I1212 15:33:27.626405 5584 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
I1212 15:33:27.692254 5584 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
I1212 15:33:27.692277 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHHostname
I1212 15:33:27.692435 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHPort
I1212 15:33:27.692566 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHKeyPath
I1212 15:33:27.692680 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHKeyPath
I1212 15:33:27.692817 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHUsername
I1212 15:33:27.693039 5584 main.go:141] libmachine: Using SSH client type: native
I1212 15:33:27.693307 5584 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x1406180] 0x1408e60 <nil> [] 0s} 192.169.0.33 22 <nil> <nil>}
I1212 15:33:27.693320 5584 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; }
I1212 15:33:28.290527 5584 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.
I1212 15:33:28.290546 5584 main.go:141] libmachine: Checking connection to Docker...
I1212 15:33:28.290555 5584 main.go:141] libmachine: (calico-246000) Calling .GetURL
I1212 15:33:28.290717 5584 main.go:141] libmachine: Docker is up and running!
I1212 15:33:28.290726 5584 main.go:141] libmachine: Reticulating splines...
I1212 15:33:28.290735 5584 client.go:171] LocalClient.Create took 12.043638313s
I1212 15:33:28.290746 5584 start.go:167] duration metric: libmachine.API.Create for "calico-246000" took 12.043686675s
I1212 15:33:28.290754 5584 start.go:300] post-start starting for "calico-246000" (driver="hyperkit")
I1212 15:33:28.290762 5584 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]
I1212 15:33:28.290772 5584 main.go:141] libmachine: (calico-246000) Calling .DriverName
I1212 15:33:28.290949 5584 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
I1212 15:33:28.290961 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHHostname
I1212 15:33:28.291073 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHPort
I1212 15:33:28.291208 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHKeyPath
I1212 15:33:28.291320 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHUsername
I1212 15:33:28.291419 5584 sshutil.go:53] new ssh client: &{IP:192.169.0.33 Port:22 SSHKeyPath:/Users/jenkins/minikube-integration/17777-1259/.minikube/machines/calico-246000/id_rsa Username:docker}
I1212 15:33:28.326541 5584 ssh_runner.go:195] Run: cat /etc/os-release
I1212 15:33:28.329422 5584 info.go:137] Remote host: Buildroot 2021.02.12
I1212 15:33:28.329439 5584 filesync.go:126] Scanning /Users/jenkins/minikube-integration/17777-1259/.minikube/addons for local assets ...
I1212 15:33:28.329552 5584 filesync.go:126] Scanning /Users/jenkins/minikube-integration/17777-1259/.minikube/files for local assets ...
I1212 15:33:28.329736 5584 filesync.go:149] local asset: /Users/jenkins/minikube-integration/17777-1259/.minikube/files/etc/ssl/certs/17202.pem -> 17202.pem in /etc/ssl/certs
I1212 15:33:28.329936 5584 ssh_runner.go:195] Run: sudo mkdir -p /etc/ssl/certs
I1212 15:33:28.336675 5584 ssh_runner.go:362] scp /Users/jenkins/minikube-integration/17777-1259/.minikube/files/etc/ssl/certs/17202.pem --> /etc/ssl/certs/17202.pem (1708 bytes)
I1212 15:33:28.352916 5584 start.go:303] post-start completed in 62.153856ms
I1212 15:33:28.352953 5584 main.go:141] libmachine: (calico-246000) Calling .GetConfigRaw
I1212 15:33:28.353558 5584 main.go:141] libmachine: (calico-246000) Calling .GetIP
I1212 15:33:28.353720 5584 profile.go:148] Saving config to /Users/jenkins/minikube-integration/17777-1259/.minikube/profiles/calico-246000/config.json ...
I1212 15:33:28.354073 5584 start.go:128] duration metric: createHost completed in 12.138506836s
I1212 15:33:28.354089 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHHostname
I1212 15:33:28.354200 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHPort
I1212 15:33:28.354298 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHKeyPath
I1212 15:33:28.354406 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHKeyPath
I1212 15:33:28.354510 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHUsername
I1212 15:33:28.354624 5584 main.go:141] libmachine: Using SSH client type: native
I1212 15:33:28.354873 5584 main.go:141] libmachine: &{{{<nil> 0 [] [] []} docker [0x1406180] 0x1408e60 <nil> [] 0s} 192.169.0.33 22 <nil> <nil>}
I1212 15:33:28.354881 5584 main.go:141] libmachine: About to run SSH command:
date +%s.%N
I1212 15:33:28.412968 5584 main.go:141] libmachine: SSH cmd err, output: <nil>: 1702424008.494998639
I1212 15:33:28.412980 5584 fix.go:206] guest clock: 1702424008.494998639
I1212 15:33:28.412986 5584 fix.go:219] Guest: 2023-12-12 15:33:28.494998639 -0800 PST Remote: 2023-12-12 15:33:28.354082 -0800 PST m=+12.816878675 (delta=140.916639ms)
I1212 15:33:28.413009 5584 fix.go:190] guest clock delta is within tolerance: 140.916639ms
I1212 15:33:28.413014 5584 start.go:83] releasing machines lock for "calico-246000", held for 12.197523558s
I1212 15:33:28.413033 5584 main.go:141] libmachine: (calico-246000) Calling .DriverName
I1212 15:33:28.413165 5584 main.go:141] libmachine: (calico-246000) Calling .GetIP
I1212 15:33:28.413260 5584 main.go:141] libmachine: (calico-246000) Calling .DriverName
I1212 15:33:28.413565 5584 main.go:141] libmachine: (calico-246000) Calling .DriverName
I1212 15:33:28.413690 5584 main.go:141] libmachine: (calico-246000) Calling .DriverName
I1212 15:33:28.413790 5584 ssh_runner.go:195] Run: curl -sS -m 2 https://registry.k8s.io/
I1212 15:33:28.413833 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHHostname
I1212 15:33:28.413918 5584 ssh_runner.go:195] Run: cat /version.json
I1212 15:33:28.413934 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHHostname
I1212 15:33:28.413954 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHPort
I1212 15:33:28.414120 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHPort
I1212 15:33:28.414139 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHKeyPath
I1212 15:33:28.414241 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHUsername
I1212 15:33:28.414261 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHKeyPath
I1212 15:33:28.414372 5584 sshutil.go:53] new ssh client: &{IP:192.169.0.33 Port:22 SSHKeyPath:/Users/jenkins/minikube-integration/17777-1259/.minikube/machines/calico-246000/id_rsa Username:docker}
I1212 15:33:28.414379 5584 main.go:141] libmachine: (calico-246000) Calling .GetSSHUsername
I1212 15:33:28.414507 5584 sshutil.go:53] new ssh client: &{IP:192.169.0.33 Port:22 SSHKeyPath:/Users/jenkins/minikube-integration/17777-1259/.minikube/machines/calico-246000/id_rsa Username:docker}
I1212 15:33:28.495285 5584 ssh_runner.go:195] Run: systemctl --version
I1212 15:33:28.499118 5584 ssh_runner.go:195] Run: sh -c "stat /etc/cni/net.d/*loopback.conf*"
W1212 15:33:28.502663 5584 cni.go:209] loopback cni configuration skipped: "/etc/cni/net.d/*loopback.conf*" not found
I1212 15:33:28.503150 5584 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" ;
I1212 15:33:28.514695 5584 cni.go:262] disabled [/etc/cni/net.d/87-podman-bridge.conflist] bridge cni config(s)
I1212 15:33:28.514717 5584 start.go:475] detecting cgroup driver to use...
I1212 15:33:28.514828 5584 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"
I1212 15:33:28.527731 5584 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"
I1212 15:33:28.534996 5584 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"
I1212 15:33:28.542400 5584 containerd.go:145] configuring containerd to use "cgroupfs" as cgroup driver...
I1212 15:33:28.542463 5584 ssh_runner.go:195] Run: sh -c "sudo sed -i -r 's|^( *)SystemdCgroup = .*$|\1SystemdCgroup = false|g' /etc/containerd/config.toml"
I1212 15:33:28.550068 5584 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"
I1212 15:33:28.557646 5584 ssh_runner.go:195] Run: sh -c "sudo sed -i '/systemd_cgroup/d' /etc/containerd/config.toml"
I1212 15:33:28.564806 5584 ssh_runner.go:195] Run: sh -c "sudo sed -i 's|"io.containerd.runc.v1"|"io.containerd.runc.v2"|g' /etc/containerd/config.toml"
I1212 15:33:28.572154 5584 ssh_runner.go:195] Run: sh -c "sudo rm -rf /etc/cni/net.mk"
I1212 15:33:28.579900 5584 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"
I1212 15:33:28.587365 5584 ssh_runner.go:195] Run: sudo sysctl net.bridge.bridge-nf-call-iptables
I1212 15:33:28.594119 5584 ssh_runner.go:195] Run: sudo sh -c "echo 1 > /proc/sys/net/ipv4/ip_forward"
I1212 15:33:28.600971 5584 ssh_runner.go:195] Run: sudo systemctl daemon-reload
I1212 15:33:28.685562 5584 ssh_runner.go:195] Run: sudo systemctl restart containerd
I1212 15:33:28.696911 5584 start.go:475] detecting cgroup driver to use...
I1212 15:33:28.696980 5584 ssh_runner.go:195] Run: sudo systemctl cat docker.service
I1212 15:33:28.706966 5584 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service containerd
I1212 15:33:28.715850 5584 ssh_runner.go:195] Run: sudo systemctl stop -f containerd
I1212 15:33:28.728164 5584 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service containerd
I1212 15:33:28.736859 5584 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service crio
I1212 15:33:28.746140 5584 ssh_runner.go:195] Run: sudo systemctl stop -f crio
I1212 15:33:28.768855 5584 ssh_runner.go:195] Run: sudo systemctl is-active --quiet service crio
I1212 15:33:28.778723 5584 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"
I1212 15:33:28.791342 5584 ssh_runner.go:195] Run: which cri-dockerd
I1212 15:33:28.793852 5584 ssh_runner.go:195] Run: sudo mkdir -p /etc/systemd/system/cri-docker.service.d
I1212 15:33:28.800558 5584 ssh_runner.go:362] scp memory --> /etc/systemd/system/cri-docker.service.d/10-cni.conf (189 bytes)
I1212 15:33:28.811930 5584 ssh_runner.go:195] Run: sudo systemctl unmask docker.service
I1212 15:33:28.909197 5584 ssh_runner.go:195] Run: sudo systemctl enable docker.socket
I1212 15:33:29.004486 5584 docker.go:560] configuring docker to use "cgroupfs" as cgroup driver...
I1212 15:33:29.004574 5584 ssh_runner.go:362] scp memory --> /etc/docker/daemon.json (130 bytes)
I1212 15:33:29.016893 5584 ssh_runner.go:195] Run: sudo systemctl daemon-reload
I1212 15:33:29.113689 5584 ssh_runner.go:195] Run: sudo systemctl restart docker
I1212 15:33:30.434889 5584 ssh_runner.go:235] Completed: sudo systemctl restart docker: (1.32118611s)
I1212 15:33:30.434957 5584 ssh_runner.go:195] Run: sudo systemctl enable cri-docker.socket
I1212 15:33:30.519121 5584 ssh_runner.go:195] Run: sudo systemctl unmask cri-docker.socket
I1212 15:33:30.614568 5584 ssh_runner.go:195] Run: sudo systemctl enable cri-docker.socket
I1212 15:33:30.717677 5584 ssh_runner.go:195] Run: sudo systemctl daemon-reload
I1212 15:33:30.818314 5584 ssh_runner.go:195] Run: sudo systemctl restart cri-docker.socket
I1212 15:33:30.830073 5584 ssh_runner.go:195] Run: sudo journalctl --no-pager -u cri-docker.socket
I1212 15:33:30.861186 5584 out.go:177]
W1212 15:33:30.886296 5584 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.
sudo journalctl --no-pager -u cri-docker.socket:
-- stdout --
-- Journal begins at Tue 2023-12-12 23:33:24 UTC, ends at Tue 2023-12-12 23:33:30 UTC. --
Dec 12 23:33:25 minikube systemd[1]: Starting CRI Docker Socket for the API.
Dec 12 23:33:25 minikube systemd[1]: Listening on CRI Docker Socket for the API.
Dec 12 23:33:28 calico-246000 systemd[1]: cri-docker.socket: Succeeded.
Dec 12 23:33:28 calico-246000 systemd[1]: Closed CRI Docker Socket for the API.
Dec 12 23:33:28 calico-246000 systemd[1]: Stopping CRI Docker Socket for the API.
Dec 12 23:33:28 calico-246000 systemd[1]: Starting CRI Docker Socket for the API.
Dec 12 23:33:28 calico-246000 systemd[1]: Listening on CRI Docker Socket for the API.
Dec 12 23:33:30 calico-246000 systemd[1]: cri-docker.socket: Succeeded.
Dec 12 23:33:30 calico-246000 systemd[1]: Closed CRI Docker Socket for the API.
Dec 12 23:33:30 calico-246000 systemd[1]: Stopping CRI Docker Socket for the API.
Dec 12 23:33:30 calico-246000 systemd[1]: cri-docker.socket: Socket service cri-docker.service already active, refusing.
Dec 12 23:33:30 calico-246000 systemd[1]: Failed to listen on CRI Docker Socket for the API.
-- /stdout --
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.
sudo journalctl --no-pager -u cri-docker.socket:
-- stdout --
-- Journal begins at Tue 2023-12-12 23:33:24 UTC, ends at Tue 2023-12-12 23:33:30 UTC. --
Dec 12 23:33:25 minikube systemd[1]: Starting CRI Docker Socket for the API.
Dec 12 23:33:25 minikube systemd[1]: Listening on CRI Docker Socket for the API.
Dec 12 23:33:28 calico-246000 systemd[1]: cri-docker.socket: Succeeded.
Dec 12 23:33:28 calico-246000 systemd[1]: Closed CRI Docker Socket for the API.
Dec 12 23:33:28 calico-246000 systemd[1]: Stopping CRI Docker Socket for the API.
Dec 12 23:33:28 calico-246000 systemd[1]: Starting CRI Docker Socket for the API.
Dec 12 23:33:28 calico-246000 systemd[1]: Listening on CRI Docker Socket for the API.
Dec 12 23:33:30 calico-246000 systemd[1]: cri-docker.socket: Succeeded.
Dec 12 23:33:30 calico-246000 systemd[1]: Closed CRI Docker Socket for the API.
Dec 12 23:33:30 calico-246000 systemd[1]: Stopping CRI Docker Socket for the API.
Dec 12 23:33:30 calico-246000 systemd[1]: cri-docker.socket: Socket service cri-docker.service already active, refusing.
Dec 12 23:33:30 calico-246000 systemd[1]: Failed to listen on CRI Docker Socket for the API.
-- /stdout --
W1212 15:33:30.886328 5584 out.go:239] *
*
W1212 15:33:30.887570 5584 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. │
│ │
╰─────────────────────────────────────────────────────────────────────────────────────────────╯
I1212 15:33:30.949877 5584 out.go:177]
** /stderr **
net_test.go:114: failed start: exit status 90
--- FAIL: TestNetworkPlugins/group/calico/Start (15.47s)