utmapp / UTM

Virtual machines for iOS and macOS
https://getutm.app
Apache License 2.0
26.59k stars 1.33k forks source link

UTM 4.2.5 on MacOS M1, "cannot create vmnet interface: unknown vmnet error" when using Shared Network #5374

Open pambram opened 1 year ago

pambram commented 1 year ago

Describe the issue
Trying to create a VM with a Shared Network, even if it's the only network interface I add to it and I make no changes or customizations to the network CIDR, I can't start the VM and get this generic, non-descript error.

image

Configuration

Crash log
Doesn't crash, just errors out.

Debug log
debug.log

Console Log (system log queried with "UTM")

default 15:19:40.662266+0000 runningboardd Acquiring assertion targeting [app<application.com.utmapp.UTM.77498694.77676312(501)>:67608] from originator [daemon<com.apple.WindowServer(88)>:391] with description <RBSAssertionDescriptor| "FUSBFrontmostProcess" ID:410-391-151012 target:67608 attributes:[ <RBSDomainAttribute| domain:"com.apple.fuseboard" name:"Frontmost" sourceEnvironment:"(null)">, <RBSAcquisitionCompletionAttribute| policy:AfterApplication> ]> default 15:19:40.662342+0000 runningboardd Assertion 410-391-151012 (target:[app<application.com.utmapp.UTM.77498694.77676312(501)>:67608]) will be created as active default 15:19:40.672745+0000 runningboardd Acquiring assertion targeting [app<application.com.utmapp.UTM.77498694.77676312(501)>:67608] from originator [daemon:360] with description <RBSAssertionDescriptor| "frontmost:67608" ID:410-360-151013 target:67608 attributes:[ <RBSDomainAttribute| domain:"com.apple.launchservicesd" name:"RoleUserInteractiveFocal" sourceEnvironment:"(null)"> ]> default 15:19:40.672748+0000 runningboardd Calculated state for app<application.com.utmapp.UTM.77498694.77676312(501)>: running-active (role: UserInteractiveFocal) default 15:19:40.672951+0000 runningboardd [app<application.com.utmapp.UTM.77498694.77676312(501)>:67608] Ignoring jetsam update because this process is not memory-managed default 15:19:40.673480+0000 runningboardd [app<application.com.utmapp.UTM.77498694.77676312(501)>:67608] Ignoring suspend because this process is not lifecycle managed default 15:19:40.673088+0000 runningboardd Assertion 410-360-151013 (target:[app<application.com.utmapp.UTM.77498694.77676312(501)>:67608]) will be created as active default 15:19:40.673736+0000 runningboardd [app<application.com.utmapp.UTM.77498694.77676312(501)>:67608] Set darwin role to: UserInteractiveFocal default 15:19:40.674107+0000 runningboardd [app<application.com.utmapp.UTM.77498694.77676312(501)>:67608] Ignoring GPU update because this process is not GPU managed default 15:19:40.677840+0000 runningboardd Calculated state for app<application.com.utmapp.UTM.77498694.77676312(501)>: running-active (role: UserInteractiveFocal) default 15:19:40.681386+0000 runningboardd Acquiring assertion targeting [app<application.com.utmapp.UTM.77498694.77676312(501)>:67608] from originator [daemon<com.apple.coreservices.appleevents(55)>:524] with description <RBSAssertionDescriptor| "AE/UTM" ID:410-524-151015 target:67608 attributes:[ <RBSDomainAttribute| domain:"com.apple.launchservicesd" name:"LSNotification" sourceEnvironment:"(null)"> ]> default 15:19:40.681581+0000 runningboardd Assertion 410-524-151015 (target:[app<application.com.utmapp.UTM.77498694.77676312(501)>:67608]) will be created as active default 15:19:40.684686+0000 runningboardd Acquiring assertion targeting [app<application.com.utmapp.UTM.77498694.77676312(501)>:67608] from originator [daemon:360] with description <RBSAssertionDescriptor| "notification:67608" ID:410-360-151016 target:67608 attributes:[ <RBSDomainAttribute| domain:"com.apple.launchservicesd" name:"LSNotification" sourceEnvironment:"(null)"> ]> default 15:19:40.685045+0000 runningboardd Assertion 410-360-151016 (target:[app<application.com.utmapp.UTM.77498694.77676312(501)>:67608]) will be created as active default 15:19:40.686079+0000 runningboardd [app<application.com.utmapp.UTM.77498694.77676312(501)>:67608] Ignoring jetsam update because this process is not memory-managed default 15:19:40.686269+0000 runningboardd [app<application.com.utmapp.UTM.77498694.77676312(501)>:67608] Ignoring suspend because this process is not lifecycle managed default 15:19:40.686485+0000 runningboardd Invalidating assertion 410-360-150998 (target:[app<application.com.utmapp.UTM.77498694.77676312(501)>:67608]) from originator [daemon:360] default 15:19:40.686394+0000 runningboardd [app<application.com.utmapp.UTM.77498694.77676312(501)>:67608] Ignoring GPU update because this process is not GPU managed default 15:19:40.734179+0000 runningboardd Acquiring assertion targeting [app<application.com.utmapp.UTM.77498694.77676312(501)>:67608] from originator [daemon<com.apple.WindowServer(88)>:391] with description <RBSAssertionDescriptor| "AppVisible" ID:410-391-151018 target:67608 attributes:[ <RBSDomainAttribute| domain:"com.apple.appnap" name:"AppVisible" sourceEnvironment:"(null)">, <RBSAcquisitionCompletionAttribute| policy:AfterApplication> ]> default 15:19:40.734232+0000 runningboardd Assertion 410-391-151018 (target:[app<application.com.utmapp.UTM.77498694.77676312(501)>:67608]) will be created as active default 15:19:40.735018+0000 runningboardd [app<application.com.utmapp.UTM.77498694.77676312(501)>:67608] Ignoring jetsam update because this process is not memory-managed default 15:19:40.735032+0000 runningboardd [app<application.com.utmapp.UTM.77498694.77676312(501)>:67608] Ignoring suspend because this process is not lifecycle managed default 15:19:40.735047+0000 runningboardd [app<application.com.utmapp.UTM.77498694.77676312(501)>:67608] Ignoring GPU update because this process is not GPU managed default 15:19:40.735416+0000 runningboardd Calculated state for app<application.com.utmapp.UTM.77498694.77676312(501)>: running-active (role: UserInteractiveFocal) default 15:19:40.759833+0000 runningboardd Acquiring assertion targeting [app<application.com.utmapp.UTM.77498694.77676312(501)>:67608] from originator [daemon<com.apple.WindowServer(88)>:391] with description <RBSAssertionDescriptor| "FUSBProcessWindowState: visible" ID:410-391-151019 target:67608 attributes:[ <RBSDomainAttribute| domain:"com.apple.fuseboard" name:"Visible" sourceEnvironment:"(null)">, <RBSAcquisitionCompletionAttribute| policy:AfterApplication> ]> default 15:19:40.759941+0000 runningboardd Assertion 410-391-151019 (target:[app<application.com.utmapp.UTM.77498694.77676312(501)>:67608]) will be created as active default 15:19:40.760381+0000 runningboardd Calculated state for app<application.com.utmapp.UTM.77498694.77676312(501)>: running-active (role: UserInteractiveFocal) default 15:19:40.760417+0000 runningboardd [app<application.com.utmapp.UTM.77498694.77676312(501)>:67608] Ignoring jetsam update because this process is not memory-managed default 15:19:40.760482+0000 runningboardd [app<application.com.utmapp.UTM.77498694.77676312(501)>:67608] Ignoring suspend because this process is not lifecycle managed default 15:19:40.760565+0000 runningboardd [app<application.com.utmapp.UTM.77498694.77676312(501)>:67608] Ignoring GPU update because this process is not GPU managed default 15:19:40.761411+0000 runningboardd Invalidating assertion 410-391-151009 (target:[app<application.com.utmapp.UTM.77498694.77676312(501)>:67608]) from originator [daemon<com.apple.WindowServer(88)>:391] default 15:19:40.806262+0000 runningboardd [app<application.com.utmapp.UTM.77498694.77676312(501)>:67608] Ignoring jetsam update because this process is not memory-managed default 15:19:40.806554+0000 runningboardd [app<application.com.utmapp.UTM.77498694.77676312(501)>:67608] Ignoring suspend because this process is not lifecycle managed default 15:19:40.806658+0000 runningboardd [app<application.com.utmapp.UTM.77498694.77676312(501)>:67608] Ignoring GPU update because this process is not GPU managed default 15:19:40.806829+0000 runningboardd Calculated state for app<application.com.utmapp.UTM.77498694.77676312(501)>: running-active (role: UserInteractiveFocal) default 15:19:40.976644+0000 runningboardd Assertion did invalidate due to timeout: 410-524-150997 (target:[app<application.com.utmapp.UTM.77498694.77676312(501)>:67608]) fault 15:19:41.844854+0000 UTM Invalid timestamps for HID response delay: 100151903243958 to 2403646415738 fault 15:19:42.043801+0000 UTM NSToolbarItem.minSize and NSToolbarItem.maxSize methods are deprecated. Usage may result in clipping of items. It is recommended to let the system measure the item automatically using constraints. fault 15:19:42.043888+0000 UTM NSToolbarItem.minSize and NSToolbarItem.maxSize methods are deprecated. Usage may result in clipping of items. It is recommended to let the system measure the item automatically using constraints. fault 15:19:42.089364+0000 UTM Invalid timestamps for HID response delay: 100152105224833 to 2403652284951 fault 15:19:42.124900+0000 UTM Publishing changes from background threads is not allowed; make sure to publish values from the main thread (via operators like receive(on:)) on model updates. default 15:19:42.132205+0000 UTM container_create_or_lookup_app_group_path_by_app_group_identifier: success default 15:19:42.132824+0000 UTM container_create_or_lookup_app_group_path_by_app_group_identifier: success default 15:19:42.133480+0000 UTM container_create_or_lookup_app_group_path_by_app_group_identifier: success default 15:19:42.145524+0000 UTM Running: -L /Applications/UTM.app/Contents/Resources/qemu -S -spice "unix=on,addr=/Users/pabloambram/Library/Group Containers/WDNLXAD4W8.com.utmapp.UTM/D19F2FDB-7354-41AB-9FBC-6911881F67A5.spice,disable-ticketing=on,image-compression=off,playback-compression=off,streaming-video=off,gl=off" -chardev spiceport,id=org.qemu.monitor.qmp,name=org.qemu.monitor.qmp.0 -mon chardev=org.qemu.monitor.qmp,mode=control -nodefaults -vga none -device e1000,mac=FA:A2:51:1C:23:5B,netdev=net0 -netdev user,id=net0,net=10.0.2.0/24,dhcpstart=10.0.2.15,hostfwd=tcp:127.0.0.1:4082-10.0.2.16:4081 -device e1000,mac=7A:F5:CD:52:FD:2E,netdev=net1 -netdev vmnet-bridged,id=net1,ifname=en0 -device e1000,mac=AE:66:0B:56:55:BE,netdev=net2 -netdev vmnet-shared,id=net2 -device virtio-vga -smp cpus=1,sockets=1,cores=1,threads=1 -machine q35,vmport=off,i8042=off -accel tcg,tb-size=1024 -global PIIX4_PM.disable_s3=1 -global ICH9-LPC.disable_s3=1 -m 4096 -audiodev coreaudio,id=audio0 -device intel-hda -device hda-duplex,audiodev=audio0 -u<…> default 15:19:42.332417+0000 UTM Failed to connect to SPICE: (null) default 15:19:42.817794+0000 runningboardd Invalidating assertion 410-360-151013 (target:[app<application.com.utmapp.UTM.77498694.77676312(501)>:67608]) from originator [daemon:360] default 15:19:42.827080+0000 runningboardd Invalidating assertion 410-391-151012 (target:[app<application.com.utmapp.UTM.77498694.77676312(501)>:67608]) from originator [daemon<com.apple.WindowServer(88)>:391] default 15:19:42.829400+0000 runningboardd Invalidating assertion 410-391-151018 (target:[app<application.com.utmapp.UTM.77498694.77676312(501)>:67608]) from originator [daemon<com.apple.WindowServer(88)>:391] default 15:19:42.862734+0000 runningboardd Acquiring assertion targeting [app<application.com.utmapp.UTM.77498694.77676312(501)>:67608] from originator [daemon<com.apple.WindowServer(88)>:391] with description <RBSAssertionDescriptor| "FUSBProcessWindowState: occluded" ID:410-391-151036 target:67608 attributes:[ <RBSDomainAttribute| domain:"com.apple.fuseboard" name:"Occluded" sourceEnvironment:"(null)">, <RBSAcquisitionCompletionAttribute| policy:AfterApplication> ]> default 15:19:42.862799+0000 runningboardd Assertion 410-391-151036 (target:[app<application.com.utmapp.UTM.77498694.77676312(501)>:67608]) will be created as active default 15:19:42.863048+0000 runningboardd [app<application.com.utmapp.UTM.77498694.77676312(501)>:67608] Ignoring jetsam update because this process is not memory-managed default 15:19:42.863046+0000 runningboardd Calculated state for app<application.com.utmapp.UTM.77498694.77676312(501)>: running-active (role: UserInteractiveFocal) default 15:19:42.863121+0000 runningboardd [app<application.com.utmapp.UTM.77498694.77676312(501)>:67608] Ignoring suspend because this process is not lifecycle managed default 15:19:42.863230+0000 runningboardd [app<application.com.utmapp.UTM.77498694.77676312(501)>:67608] Ignoring GPU update because this process is not GPU managed default 15:19:42.863881+0000 runningboardd Invalidating assertion 410-391-151019 (target:[app<application.com.utmapp.UTM.77498694.77676312(501)>:67608]) from originator [daemon<com.apple.WindowServer(88)>:391] default 15:19:42.908987+0000 runningboardd [app<application.com.utmapp.UTM.77498694.77676312(501)>:67608] Ignoring jetsam update because this process is not memory-managed default 15:19:42.909003+0000 runningboardd [app<application.com.utmapp.UTM.77498694.77676312(501)>:67608] Ignoring suspend because this process is not lifecycle managed default 15:19:42.909038+0000 runningboardd [app<application.com.utmapp.UTM.77498694.77676312(501)>:67608] Set darwin role to: UserInteractiveNonFocal default 15:19:42.909254+0000 runningboardd [app<application.com.utmapp.UTM.77498694.77676312(501)>:67608] Ignoring GPU update because this process is not GPU managed default 15:19:42.909341+0000 runningboardd Calculated state for app<application.com.utmapp.UTM.77498694.77676312(501)>: running-active (role: UserInteractiveNonFocal) default 15:19:43.255574+0000 UTM Failed to connect to SPICE: Error Domain=com.utmapp.utm Code=-1 "Internal error trying to connect to SPICE server." UserInfo={NSLocalizedDescription=Internal error trying to connect to SPICE server.}

Upload VM
config.plist.zip

edit: added the screenshot of the error

avig2023 commented 1 year ago

I'm getting the same error, only when I switch from Shared network to Bridge mode...

pambram commented 1 year ago

Upgrading to MacOs Ventura 13.4.1 fixed this specific issue for me (like, I don't get this error whenever I used to get it). I need to test more to see if I hit it at some point but at least a couple of my VMs didn't error out yet...

pambram commented 1 year ago

Well now, shared network adapters were good for about 2 days of testing, now the shared network adapter is not getting an IP from the router. Plus, somehow I also have a rogue Host network that I have not added to the VM, but it appears nonetheless.