search

utmapp / UTM

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

Boot order on PowerPC in Mac99 #527

Closed dmkpoznan closed 4 years ago

dmkpoznan commented 4 years ago

Using UTM 2.0.9 @ iOS 14.2 on iPad Pro with PowerPC & mac99 OpenBIOS always try to boot from cd:... even, when I delete CD image and leave only hdd (as Disk Image attached to ide). Am I doing something wrong? Or this is known issue and there is some workaround?

Best regards!

IMG_0153

image

osy commented 4 years ago

The boot order should be the order of the drives. You can move them around in edit mode.

dmkpoznan commented 4 years ago

Yes, but it’s not working. I tried with two drives (CD and HDD), I tried deleting CD and it’s not affecting OpenBIOS boot drive. So this must be bug (not passing order of drives to OpenBIOS)?

dmkpoznan commented 4 years ago

Adding qemu parameter „-boot drive=c” solved problem, but configuration based on drives order is not working. I searched code and it looks like it’s hardcoded arg „-boot drive=d”, but I’m not 100% sure (I don’t know whole project structure, so this is only my suspicion).

osy commented 4 years ago

Can you post your debug log (without adding boot arg)? The hard coded param shouldn’t be triggered in any VM created since an old version of UTM.

dmkpoznan commented 4 years ago

-[CSConnection init]:251 2020-11-12 21:28:12.240 UTM[8995:5332914] -[CSConnection init]:251 Loading libqemu-system-ppc.utm.dylib 2020-11-12 21:28:12.309 UTM[8995:5332914] Loading libqemu-system-ppc.utm.dylib Running: -L /private/var/containers/Bundle/Application/4A3E250B-C5D8-41B8-9BD9-61DD61B06B7E/UTM.app/qemu -S -qmp tcp:localhost:4000,server,nowait -spice port=4001,addr=127.0.0.1,disable-ticketing,image-compression=off,playback-compression=off,streaming-video=off -smp cpus=1,sockets=1 -machine mac99,via=pmu -accel tcg,mirror-rwx=on -boot order=d -m 1024 -name MacOS -drive if=ide,media=disk,id=drive0,file=/var/mobile/Containers/Data/Application/D97396BF-2D61-48D6-9551-1FA4AD762F6C/Documents/MacOS.utm/Images/disk-0.qcow2 -device rtl8139,netdev=net0 -netdev user,id=net0 -device usb-ehci -device usb-tablet -device usb-mouse -device usb-kbd -device virtio-serial -device virtserialport,chardev=vdagent,name=com.redhat.spice.0 -chardev spicevmc,id=vdagent,debug=0,name=vdagent -uuid 0CF147D8-43EC-4E58-B033-49921DD871FA -rtc base=localtime 2020-11-12 21:28:12.411 UTM[8995:5332914] Running: -L /private/var/containers/Bundle/Application/4A3E250B-C5D8-41B8-9BD9-61DD61B06B7E/UTM.app/qemu -S -qmp tcp:localhost:4000,server,nowait -spice port=4001,addr=127.0.0.1,disable-ticketing,image-compression=off,playback-compression=off,streaming-video=off -smp cpus=1,sockets=1 -machine mac99,via=pmu -accel tcg,mirror-rwx=on -boot order=d -m 1024 -name MacOS -drive if=ide,media=disk,id=drive0,file=/var/mobile/Containers/Data/Application/D97396BF-2D61-48D6-9551-1FA4AD762F6C/Documents/MacOS.utm/Images/disk-0.qcow2 -device rtl8139,netdev=net0 -netdev user,id=net0 -device usb-ehci -device usb-tablet -device usb-mouse -device usb-kbd -device virtio-serial -device virtserialport,chardev=vdagent,name=com.redhat.spice.0 -chardev spicevmc,id=vdagent,debug=0,name=vdagent -uuid 0CF147D8-43EC-4E58-B033-49921DD871FA -rtc base=localtime SPICE port not in use yet, retries left: 29 2020-11-12 21:28:12.412 UTM[8995:5595442] SPICE port not in use yet, retries left: 29 Current location: 52.32283807520112 16.80613556815807 Current location: 52.32283807520112 16.80613556815807 2020-11-12 21:28:12.414 UTM[8995:5332914] Current location: 52.32283807520112 16.80613556815807 2020-11-12 21:28:12.414 UTM[8995:5332914] Current location: 52.32283807520112 16.80613556815807 Stream error Error Domain=NSPOSIXErrorDomain Code=61 "Connection refused" UserInfo={_kCFStreamErrorCodeKey=61, _kCFStreamErrorDomainKey=1} QMP stream error seen: Error Domain=NSPOSIXErrorDomain Code=61 "Connection refused" UserInfo={_kCFStreamErrorCodeKey=61, _kCFStreamErrorDomainKey=1} QMP connection failed, retries left: 29 2020-11-12 21:28:12.415 UTM[8995:5595442] Stream error Error Domain=NSPOSIXErrorDomain Code=61 "Connection refused" UserInfo={_kCFStreamErrorCodeKey=61, _kCFStreamErrorDomainKey=1} 2020-11-12 21:28:12.415 UTM[8995:5595442] QMP stream error seen: Error Domain=NSPOSIXErrorDomain Code=61 "Connection refused" UserInfo={_kCFStreamErrorCodeKey=61, _kCFStreamErrorDomainKey=1} 2020-11-12 21:28:12.415 UTM[8995:5595442] QMP connection failed, retries left: 29 qemu-system: info: Spice: reds.c:4214:spice_server_set_seamless_migration: seamless migration enabled=0 qemu-system: info: Spice: reds.c:3359:do_spice_init: starting 0.14.1 qemu-system: info: Spice: char-device.c:690:red_char_device_reset_dev_instance: sin 0x0, char device 0x11ff9c110 qemu-system: info: Spice: reds.c:2561:reds_init_socket: bound to 127.0.0.1:4001 qemu-system: info: Spice: main:0 (0x11ffa40a0): thread_id 0x16e0b7000 qemu-system: info: Spice: inputs:0 (0x11ffa0170): thread_id 0x16e0b7000 qemu-system: info: Spice: reds.c:3297:spice_server_add_interface: SPICE_INTERFACE_MIGRATION qemu-system: info: Spice: reds.c:3214:spice_server_add_interface: SPICE_INTERFACE_KEYBOARD qemu-system: info: Spice: reds.c:3224:spice_server_add_interface: SPICE_INTERFACE_MOUSE qemu-system: info: Spice: reds.c:3236:spice_server_add_interface: SPICE_INTERFACE_QXL qemu-system: info: Spice: cursor-channel.c:238:cursor_channel_new: create cursor channel qemu-system: info: Spice: cursor:0 (0x11ec88d40): thread_id 0x16e0b7000 qemu-system: info: Spice: display-channel.c:2235:display_channel_new: create display channel qemu-system: info: Spice: display:0 (0x11ffa4160): thread_id 0x16e0b7000 qemu-system: info: Spice: display-channel.c:236:display_channel_set_stream_video: sv off qemu-system: info: Spice: red-worker.c:1360:red_worker_main: begin qemu-system: info: Spice: red-worker.c:490:dev_create_primary_surface: trace qemu-system: info: Spice: display-channel.c:181:monitors_config_debug: monitors config count:1 max:1 qemu-system: info: Spice: display-channel.c:185:monitors_config_debug: +0+0 640x480 qemu-system: info: Spice: cursor-channel.c:318:cursor_channel_init_client: during_target_migrate: skip init Current location: 52.32283988653834 16.806127826881 2020-11-12 21:28:12.612 UTM[8995:5332914] Current location: 52.32283988653834 16.806127826881 Connected to stream QMP connection successful! (readStream:1) Connected to stream QMP connection successful! (readStream:0) 2020-11-12 21:28:13.419 UTM[8995:5595442] Connected to stream 2020-11-12 21:28:13.419 UTM[8995:5595442] QMP connection successful! (readStream:1) 2020-11-12 21:28:13.419 UTM[8995:5595442] Connected to stream 2020-11-12 21:28:13.419 UTM[8995:5595442] QMP connection successful! (readStream:0) Debug JSON recieved <- { QMP = { capabilities = ( oob ); version = { package = ""; qemu = { major = 5; micro = 0; minor = 1; }; }; }; } 2020-11-12 21:28:13.420 UTM[8995:5595442] Debug JSON recieved <- { QMP = { Got QMP handshake: { QMP = { capabilities = ( oob ); version = { package = ""; qemu = { major = 5; micro = 0; minor = 1; }; }; }; } capabilities = ( Debug JSON send -> { execute = "qmp_capabilities"; } oob ); version = { package = ""; qemu = { major = 5; micro = 0; minor = 1; }; }; }; } 2020-11-12 21:28:13.420 UTM[8995:5595442] Got QMP handshake: { QMP = { capabilities = ( oob ); version = { package = ""; qemu = { major = 5; micro = 0; minor = 1; }; }; }; } 2020-11-12 21:28:13.420 UTM[8995:5595442] Debug JSON send -> { execute = "qmp_capabilities"; } Debug JSON recieved <- { return = { }; } 2020-11-12 21:28:13.422 UTM[8995:5332923] Debug JSON recieved <- { qemuQmpDidConnect return = { }; } Debug JSON send -> { execute = "query-block"; } 2020-11-12 21:28:13.422 UTM[8995:5595442] qemuQmpDidConnect 2020-11-12 21:28:13.422 UTM[8995:5595442] Debug JSON send -> { execute = "query-block"; } -[CSSession initWithSession:]:310 2020-11-12 21:28:13.423 UTM[8995:5595444] -[CSSession initWithSession:]:310 shared directory disabled 2020-11-12 21:28:13.424 UTM[8995:5595444] shared directory disabled qemu-system: info: GSpice: spice-session.c:1802 no migration in progress Debug JSON recieved <- { return = ( { device = drive0; inserted = { "backing_file_depth" = 0; bps = 0; "bps_rd" = 0; "bps_wr" = 0; cache = { direct = 0; "no-flush" = 0; writeback = 1; }; "detect_zeroes" = off; drv = qcow2; encrypted = 0; "encryption_key_missing" = 0; file = "/var/mobile/Containers/Data/Application/D97396BF-2D61-48D6-9551-1FA4AD762F6C/Documents/MacOS.utm/Images/disk-0.qcow2"; image = { "actual-size" = 12086583296; "cluster-size" = 65536; "dirty-flag" = 0; filename = "/var/mobile/Containers/Data/Application/D97396BF-2D61-48D6-9551-1FA4AD762F6C/Documents/MacOS.utm/Images/disk-0.qcow2"; format = qcow2; "format-specific" = { data = { compat = "1.1"; "compression-type" = zlib; corrupt = 0; "lazy-refcounts" = 0; "refcount-bits" = 16; }; type = qcow2; }; "virtual-size" = 21223178240; }; iops = 0; "iops_rd" = 0; "iops_wr" = 0; "node-name" = "#block180"; ro = 0; "write_threshold" = 0; }; "io-status" = ok; locked = 0; qdev = "/machine/unattached/device[10]"; removable = 0; type = unknown; }, { device = "ide1-cd0"; "io-status" = ok; locked = 0; qdev = "/machine/unattached/device[11]"; removable = 1; "tray_open" = 0; type = unknown; }, { device = floppy0; locked = 0; removable = 1; type = unknown; }, { device = sd0; locked = 0; removable = 1; type = unknown; } ); } 2020-11-12 21:28:13.425 UTM[8995:5332923] Debug JSON recieved <- { return = ( { device = drive0; inserted = { "backing_file_depth" = 0; bps = 0; Debug JSON send -> { execute = cont; } "bps_rd" = 0; "bps_wr" = 0; cache = { direct = 0; "no-flush" = 0; writeback = 1; }; "detect_zeroes" = off; drv = qcow2; encrypted = 0; "encryption_key_missing" = 0; file = "/var/mobile/Containers/Data/Application/D97396BF-2D61-48D6-9551-1FA4AD762F6C/Documents/MacOS.utm/Images/disk-0.qcow2"; image = { "actual-size" = 12086583296; "cluster-size" = 65536; "dirty-flag" = 0; filename = "/var/mobile/Containers/Data/Application/D97396BF-2D61-48D6-9551-1FA4AD762F6C/Documents/MacOS.utm/Images/disk-0.qcow2"; format = qcow2; "format-specific" = { Debug JSON recieved <- { event = RESUME; timestamp = { microseconds = 427222; seconds = 1605212893; }; } data = { compat = "1.1"; Debug JSON recieved <- { return = { }; } "compression-type" = zlib; qemuHasResumed corrupt = 0; "lazy-refcounts" = 0; "refcount-bits" = 16; }; type = qcow2; }; "virtual-size" = 21223178240; }; iops = 0; "iops_rd" = 0; "iops_wr" = 0; "node-name" = "#block180"; ro = 0; "write_threshold" = 0; }; "io-status" = ok; locked = 0; qdev = "/machine/unattached/device[10]"; removable = 0; type = unknown; }, { device = "ide1-cd0"; "io-status" = ok; locked = 0; qdev = "/machine/unattached/device[11]"; removable = 1; "tray_open" = 0; type = unknown; }, { device = floppy0; locked = 0; removable = 1; type = unknown; }, { device = sd0; locked = 0; removable = 1; type = unknown; } ); } 2020-11-12 21:28:13.426 UTM[8995:5595442] Debug JSON send -> { execute = cont; } 2020-11-12 21:28:13.427 UTM[8995:5332923] Debug JSON recieved <- { event = RESUME; timestamp = { microseconds = 427222; seconds = 1605212893; }; } 2020-11-12 21:28:13.427 UTM[8995:5332923] Debug JSON recieved <- { return = { }; } 2020-11-12 21:28:13.427 UTM[8995:5595626] qemuHasResumed Current location: 52.32284817706844 16.80612025906485 2020-11-12 21:28:13.872 UTM[8995:5332914] Current location: 52.32284817706844 16.80612025906485 qemu-system: info: GSpice: spice-channel.c:141 main-1:0: spice_channel_constructed qemu-system: info: GSpice: spice-session.c:2282 main-1:0: new main channel, switching 2020-11-12 20:28:14,201 DEBUG (null)-/Users/runner/work/UTM/UTM/CocoaSpice/CSConnection.m:134 new channel (#0) cs_channel_new:140 2020-11-12 20:28:14,253 DEBUG (null)-/Users/runner/work/UTM/UTM/CocoaSpice/CSConnection.m:137 new main channel 2020-11-12 21:28:14.253 UTM[8995:5595444] cs_channel_new:140 2020-11-12 20:28:14,253 DEBUG (null)-/Users/runner/work/UTM/UTM/CocoaSpice/CSSession.m:250 Changing main channel from 0x0 to 0x10c034700 qemu-system: info: GSpice: spice-channel.c:2707 main-1:0: Open coroutine starting 0x10c034700 qemu-system: info: GSpice: spice-channel.c:2544 main-1:0: Started background coroutine 0x10c032230 qemu-system: info: GSpice: spice-session.c:2234 main-1:0: Using plain text, port 4001 qemu-system: info: GSpice: spice-session.c:2165 open host 127.0.0.1:4001 qemu-system: info: GSpice: spice-session.c:2087 main-1:0: connecting 0x14fd3ec08... qemu-system: info: GSpice: spice-session.c:2071 main-1:0: connect ready Debug JSON recieved <- { data = { client = { family = ipv4; host = "127.0.0.1"; port = 52568; }; server = { family = ipv4; host = "127.0.0.1"; port = 4001; }; }; event = "SPICE_CONNECTED"; timestamp = { microseconds = 255327; seconds = 1605212894; }; } 2020-11-12 21:28:14.255 UTM[8995:5595444] Debug JSON recieved <- { data = { client = { family = ipv4; host = "127.0.0.1"; port = 52568; }; server = { family = ipv4; host = "127.0.0.1"; port = 4001; }; }; event = "SPICE_CONNECTED"; timestamp = { microseconds = 255327; seconds = 1605212894; }; } qemu-system: info: GSpice: spice-channel.c:1367 main-1:0: channel type 1 id 0 num common caps 1 num caps 1 qemu-system: info: GSpice: spice-channel.c:1391 main-1:0: Peer version: 2:2 qemu-system: info: GSpice: spice-channel.c:1947 main-1:0: spice_channel_recv_link_msg: 2 caps qemu-system: info: GSpice: spice-channel.c:1961 main-1:0: got remote common caps: qemu-system: info: GSpice: spice-channel.c:1897 0:0xB qemu-system: info: GSpice: spice-channel.c:1968 main-1:0: got remote channel caps: qemu-system: info: GSpice: spice-channel.c:1897 0:0x9 qemu-system: info: GSpice: spice-channel.c:2926 test cap 0 in 0xB: yes qemu-system: info: GSpice: spice-channel.c:2926 test cap 1 in 0xB: yes qemu-system: info: Spice: reds.c:2159:reds_handle_auth_mechanism: Auth method: 1 qemu-system: info: GSpice: spice-channel.c:2926 test cap 3 in 0xB: yes qemu-system: info: GSpice: spice-channel.c:2000 main-1:0: use mini header: 1 qemu-system: info: Spice: reds.c:1789:reds_handle_main_link: trace qemu-system: info: Spice: reds.c:603:reds_disconnect: trace Debug JSON recieved <- { data = { client = { "channel-id" = 0; "channel-type" = 1; "connection-id" = 16807; family = ipv4; host = "127.0.0.1"; port = 52568; tls = 0; }; server = { auth = none; family = ipv4; host = "127.0.0.1"; port = 4001; }; }; event = "SPICE_INITIALIZED"; timestamp = { microseconds = 284159; seconds = 1605212894; }; } qemu-system: info: Spice: reds.c:1642:reds_info_new_channel: channel 1:0, connected successfully, over Non Secure link qemu-system: info: Spice: red_channel_client_class_init 2020-11-12 20:28:14,284 MESSAGE (null)-main channel: opened qemu-system: info: GSpice: spice-channel.c:1298 main-1:0: channel up, state 3 qemu-system: info: Spice: reds.c:1828:reds_handle_main_link: NEW Client 0x11f003000 mcc 0x14d01e9e0 connect-id 16807 2020-11-12 21:28:14.284 UTM[8995:5595444] Debug JSON recieved <- { data = { client = { "channel-id" = 0; "channel-type" = 1; "connection-id" = 16807; family = ipv4; host = "127.0.0.1"; port = 52568; tls = 0; }; server = { auth = none; family = ipv4; host = "127.0.0.1"; port = 4001; }; }; event = "SPICE_INITIALIZED"; timestamp = { microseconds = 284159; seconds = 1605212894; }; } qemu-system: info: GSpice: spice-session.c:2386 set mm time: 494181550 qemu-system: info: GSpice: spice-session.c:2389 spice_session_set_mm_time: mm-time-reset, old 494181950, new 494181550 qemu-system: info: GSpice: channel-main.c:1693 server name: MacOS qemu-system: info: GSpice: channel-main.c:1704 server uuid: 0cf147d8-43ec-4e58-b033-49921dd871fa qemu-system: info: Spice: main:0 (0x11ffa40a0): net test: latency 0.380000 ms, bitrate 12564417177 bps (11982.361962 Mbps) qemu-system: info: Spice: red-channel-client.c:792:red_channel_client_start_connectivity_monitoring: trace qemu-system: info: Spice: channel-display-gst.c:718:gstvideo_debug_available_decoders: From 1 video decoder elements, 1 can handle caps image/jpeg: jpegdec qemu-system: info: Spice: channel-display-gst.c:748:gstvideo_has_codec: From 1 decoders, none can handle 'video/x-vp8' qemu-system: info: GSpice: channel-display.c:894 GStreamer does not support the vp8 codec cs_channel_new:147 qemu-system: info: Spice: channel-display-gst.c:748:gstvideo_has_codec: From 1 decoders, none can handle 'video/x-h264' 2020-11-12 20:28:14,285 DEBUG (null)-/Users/runner/work/UTM/UTM/CocoaSpice/CSConnection.m:134 new channel (#0) qemu-system: info: GSpice: channel-display.c:894 GStreamer does not support the h264 codec 2020-11-12 20:28:14,285 DEBUG (null)-/Users/runner/work/UTM/UTM/CocoaSpice/CSConnection.m:146 new display channel (#0) qemu-system: info: Spice: channel-display-gst.c:748:gstvideo_has_codec: From 1 decoders, none can handle 'video/x-vp9' 2020-11-12 20:28:14,285 DEBUG (null)-/Users/runner/work/UTM/UTM/CocoaSpice/CSConnection.m:134 new channel (#0) qemu-system: info: GSpice: channel-display.c:894 GStreamer does not support the vp9 codec 2020-11-12 20:28:14,285 DEBUG (null)-/Users/runner/work/UTM/UTM/CocoaSpice/CSConnection.m:134 new channel (#0) qemu-system: info: Spice: channel-display-gst.c:748:gstvideo_has_codec: From 1 decoders, none can handle 'video/x-h265' qemu-system: info: GSpice: channel-display.c:894 GStreamer does not support the h265 codec qemu-system: info: GSpice: spice-channel.c:141 display-2:0: spice_channel_constructed 2020-11-12 21:28:14.285 UTM[8995:5595643] cs_channel_new:147 qemu-system: info: GSpice: spice-channel.c:141 cursor-4:0: spice_channel_constructed qemu-system: info: GSpice: spice-channel.c:141 inputs-3:0: spice_channel_constructed qemu-system: info: GSpice: spice-channel.c:2707 display-2:0: Open coroutine starting 0x10709a3b0 qemu-system: info: GSpice: spice-channel.c:2544 display-2:0: Started background coroutine 0x107097ee0 qemu-system: info: GSpice: spice-session.c:2234 display-2:0: Using plain text, port 4001 qemu-system: info: GSpice: spice-session.c:2165 open host 127.0.0.1:4001 qemu-system: info: GSpice: spice-session.c:2087 display-2:0: connecting 0x150d3ec08... qemu-system: info: GSpice: spice-session.c:2071 display-2:0: connect ready qemu-system: info: GSpice: spice-channel.c:1367 display-2:0: channel type 2 id 0 num common caps 1 num caps 1 Debug JSON recieved <- { data = { client = { family = ipv4; host = "127.0.0.1"; port = 52569; }; server = { family = ipv4; host = "127.0.0.1"; port = 4001; }; }; event = "SPICE_CONNECTED"; timestamp = { microseconds = 286158; seconds = 1605212894; }; } 2020-11-12 21:28:14.286 UTM[8995:5595444] Debug JSON recieved <- { data = { client = { family = ipv4; host = "127.0.0.1"; port = 52569; }; server = { family = ipv4; host = "127.0.0.1"; port = 4001; }; }; event = "SPICE_CONNECTED"; timestamp = { microseconds = 286158; seconds = 1605212894; }; } qemu-system: info: GSpice: spice-channel.c:1391 display-2:0: Peer version: 2:2 qemu-system: info: GSpice: spice-channel.c:1947 display-2:0: spice_channel_recv_link_msg: 2 caps qemu-system: info: GSpice: spice-channel.c:1961 display-2:0: got remote common caps: qemu-system: info: GSpice: spice-channel.c:1897 0:0xB qemu-system: info: GSpice: spice-channel.c:1968 display-2:0: got remote channel caps: qemu-system: info: GSpice: spice-channel.c:1897 0:0x1052 qemu-system: info: GSpice: spice-channel.c:2926 test cap 0 in 0xB: yes qemu-system: info: GSpice: spice-channel.c:2926 test cap 1 in 0xB: yes qemu-system: info: Spice: reds.c:2159:reds_handle_auth_mechanism: Auth method: 1 qemu-system: info: GSpice: spice-channel.c:2926 test cap 3 in 0xB: yes qemu-system: info: GSpice: spice-channel.c:2000 display-2:0: use mini header: 1 qemu-system: info: Spice: reds.c:1642:reds_info_new_channel: channel 2:0, connected successfully, over Non Secure link qemu-system: info: Spice: red-qxl.c:80:red_qxl_set_display_peer: qemu-system: info: Spice: red-worker.c:719:handle_dev_display_connect: connect new client Debug JSON recieved <- { data = { client = { "channel-id" = 0; "channel-type" = 2; "connection-id" = 16807; family = ipv4; host = "127.0.0.1"; port = 52569; tls = 0; }; server = { auth = none; family = ipv4; host = "127.0.0.1"; port = 4001; }; }; event = "SPICE_INITIALIZED"; timestamp = { microseconds = 327589; seconds = 1605212894; }; } qemu-system: info: GSpice: spice-channel.c:1298 display-2:0: channel up, state 3 qemu-system: info: GSpice: channel-display.c:1069 display-2:0: spice_display_channel_up: cache_size 83886080, glz_window_size 12582912 (bytes) 2020-11-12 21:28:14.327 UTM[8995:5595444] Debug JSON recieved <- { data = { client = { "channel-id" = 0; "channel-type" = 2; "connection-id" = 16807; family = ipv4; host = "127.0.0.1"; port = 52569; tls = 0; }; server = { auth = none; family = ipv4; host = "127.0.0.1"; port = 4001; }; }; event = "SPICE_INITIALIZED"; timestamp = { microseconds = 327589; seconds = 1605212894; }; } qemu-system: info: Spice: dcc.c:518:dcc_new: New display (client 0x11f003000) dcc 0x14d020910 stream 0x28394b680 qemu-system: info: Spice: display-channel.c:2374:display_channel_update_compression: jpeg disabled qemu-system: info: Spice: display-channel.c:2375:display_channel_update_compression: zlib-over-glz disabled qemu-system: info: Spice: image-encoders.c:734:create_glz_dictionary: Lz Window 1 Size=3145728 qemu-system: info: Spice: dcc.c:551:display_channel_client_wait_for_init: creating encoder with id == 0 qemu-system: info: GSpice: channel-display.c:1899 surface flags: 1 qemu-system: info: GSpice: channel-display.c:947 display-2:0: Create primary canvas qemu-system: info: GSpice: spice-channel.c:2926 test cap 1 in 0x1052: yes qemu-system: info: GSpice: channel-display.c:1969 display-2:0: received new monitors config from guest: n: 1/1 -[CSDisplayMetal initWithSession:channelID:monitorID:]:304 qemu-system: info: GSpice: channel-display.c:1989 display-2:0: monitor id: 0, surface id: 0, +0+0-640x480 cs_channel_new:178 2020-11-12 21:28:14.332 UTM[8995:5595643] -[CSDisplayMetal initWithSession:channelID:monitorID:]:304 2020-11-12 21:28:14.332 UTM[8995:5595643] cs_channel_new:178 -[CSInput initWithSession:channelID:monitorID:]:435 qemu-system: info: GSpice: channel-display.c:559 display-2:0: get primary 0x151544000 2020-11-12 20:28:14,332 DEBUG (null)-/Users/runner/work/UTM/UTM/CocoaSpice/CSDisplayMetal.m:118 0:0 update monitor area 2020-11-12 21:28:14.332 UTM[8995:5595643] -[CSInput initWithSession:channelID:monitorID:]:435 2020-11-12 20:28:14,332 DEBUG (null)-/Users/runner/work/UTM/UTM/CocoaSpice/CSInput.m:64 0:0 mouse mode 1 qemu-system: info: GSpice: channel-display.c:1123 display-2:0: display_handle_mark qemu-system: info: GSpice: spice-channel.c:2707 inputs-3:0: Open coroutine starting 0x107127560 qemu-system: info: GSpice: spice-channel.c:2544 inputs-3:0: Started background coroutine 0x107125090 qemu-system: info: GSpice: spice-session.c:2234 inputs-3:0: Using plain text, port 4001 qemu-system: info: GSpice: spice-channel.c:2707 cursor-4:0: Open coroutine starting 0x107028560 qemu-system: info: GSpice: spice-channel.c:2544 cursor-4:0: Started background coroutine 0x107026090 qemu-system: info: GSpice: spice-session.c:2234 cursor-4:0: Using plain text, port 4001 qemu-system: info: GSpice: spice-session.c:2165 open host 127.0.0.1:4001 qemu-system: info: GSpice: spice-session.c:2087 inputs-3:0: connecting 0x15266ec08... qemu-system: info: GSpice: spice-session.c:2165 open host 127.0.0.1:4001 qemu-system: info: GSpice: spice-session.c:2087 cursor-4:0: connecting 0x15366ec08... qemu-system: info: GSpice: spice-session.c:2071 inputs-3:0: connect ready qemu-system: info: GSpice: spice-channel.c:1367 inputs-3:0: channel type 3 id 0 num common caps 1 num caps 0 Debug JSON recieved <- { data = { client = { family = ipv4; host = "127.0.0.1"; port = 52570; }; server = { family = ipv4; host = "127.0.0.1"; port = 4001; }; }; event = "SPICE_CONNECTED"; timestamp = { microseconds = 334385; seconds = 1605212894; }; } qemu-system: info: GSpice: spice-session.c:2071 cursor-4:0: connect ready qemu-system: info: GSpice: spice-channel.c:1367 cursor-4:0: channel type 4 id 0 num common caps 1 num caps 0 2020-11-12 21:28:14.334 UTM[8995:5595444] Debug JSON recieved <- { data = { client = { family = ipv4; host = "127.0.0.1"; port = 52570; }; server = { family = ipv4; host = "127.0.0.1"; port = 4001; }; }; event = "SPICE_CONNECTED"; timestamp = { microseconds = 334385; seconds = 1605212894; }; } resizing to (1366.000000, 1024.000000) 2020-11-12 21:28:14.335 UTM[8995:5332914] resizing to (1366.000000, 1024.000000) qemu-system: GSpice: spice_main_channel_send_monitor_config: assertion 'c->agent_connected' failed qemu-system: info: GSpice: spice-channel.c:1391 inputs-3:0: Peer version: 2:2 qemu-system: info: GSpice: spice-channel.c:1947 inputs-3:0: spice_channel_recv_link_msg: 2 caps Debug JSON recieved <- { data = { client = { family = ipv4; host = "127.0.0.1"; port = 52571; }; server = { family = ipv4; host = "127.0.0.1"; port = 4001; }; }; event = "SPICE_CONNECTED"; timestamp = { microseconds = 348126; seconds = 1605212894; }; } qemu-system: info: GSpice: spice-channel.c:1961 inputs-3:0: got remote common caps: qemu-system: info: GSpice: spice-channel.c:1897 0:0xB qemu-system: info: GSpice: spice-channel.c:1968 inputs-3:0: got remote channel caps: qemu-system: info: GSpice: spice-channel.c:1897 0:0x1 qemu-system: info: GSpice: spice-channel.c:2926 test cap 0 in 0xB: yes qemu-system: info: GSpice: spice-channel.c:2926 test cap 1 in 0xB: yes 2020-11-12 21:28:14.348 UTM[8995:5595626] Debug JSON recieved <- { data = { client = { family = ipv4; host = "127.0.0.1"; port = 52571; }; server = { family = ipv4; host = "127.0.0.1"; port = 4001; }; }; event = "SPICE_CONNECTED"; timestamp = { microseconds = 348126; seconds = 1605212894; }; } qemu-system: info: GSpice: spice-channel.c:2926 test cap 3 in 0xB: yes qemu-system: info: GSpice: spice-channel.c:2000 inputs-3:0: use mini header: 1 qemu-system: info: Spice: reds.c:2159:reds_handle_auth_mechanism: Auth method: 1 qemu-system: info: GSpice: spice-channel.c:1391 cursor-4:0: Peer version: 2:2 qemu-system: info: GSpice: spice-channel.c:1947 cursor-4:0: spice_channel_recv_link_msg: 1 caps qemu-system: info: GSpice: spice-channel.c:1961 cursor-4:0: got remote common caps: qemu-system: info: GSpice: spice-channel.c:1897 0:0xB qemu-system: info: GSpice: spice-channel.c:1968 cursor-4:0: got remote channel caps: Debug JSON recieved <- { data = { client = { "channel-id" = 0; "channel-type" = 3; "connection-id" = 16807; family = ipv4; host = "127.0.0.1"; port = 52570; tls = 0; }; server = { auth = none; family = ipv4; host = "127.0.0.1"; port = 4001; }; }; event = "SPICE_INITIALIZED"; timestamp = { microseconds = 383154; seconds = 1605212894; }; } qemu-system: info: GSpice: spice-channel.c:2926 test cap 0 in 0xB: yes qemu-system: info: GSpice: spice-channel.c:2926 test cap 1 in 0xB: yes qemu-system: info: GSpice: spice-channel.c:2926 test cap 3 in 0xB: yes qemu-system: info: GSpice: spice-channel.c:2000 cursor-4:0: use mini header: 1 qemu-system: info: Spice: reds.c:1642:reds_info_new_channel: channel 3:0, connected successfully, over Non Secure link qemu-system: info: Spice: reds.c:2159:reds_handle_auth_mechanism: Auth method: 1 qemu-system: info: GSpice: channel-base.c:81 main-1:0: spice_channel_handle_notify -- warn!!! #0: keyboard channel is insecure qemu-system: info: GSpice: spice-channel.c:1298 inputs-3:0: channel up, state 3 2020-11-12 21:28:14.383 UTM[8995:5595626] Debug JSON recieved <- { data = { client = { "channel-id" = 0; "channel-type" = 3; "connection-id" = 16807; family = ipv4; host = "127.0.0.1"; port = 52570; tls = 0; }; server = { auth = none; family = ipv4; host = "127.0.0.1"; port = 4001; }; }; event = "SPICE_INITIALIZED"; timestamp = { microseconds = 383154; seconds = 1605212894; }; } Debug JSON recieved <- { data = { client = { "channel-id" = 0; "channel-type" = 4; "connection-id" = 16807; family = ipv4; host = "127.0.0.1"; port = 52571; tls = 0; }; server = { auth = none; family = ipv4; host = "127.0.0.1"; port = 4001; }; }; event = "SPICE_INITIALIZED"; timestamp = { microseconds = 384638; seconds = 1605212894; }; } qemu-system: info: Spice: reds.c:1642:reds_info_new_channel: channel 4:0, connected successfully, over Non Secure link qemu-system: info: GSpice: spice-channel.c:1298 cursor-4:0: channel up, state 3 qemu-system: info: Spice: red-worker.c:815:handle_dev_cursor_connect: cursor connect qemu-system: info: Spice: cursor-channel.c:349:cursor_channel_connect: add cursor channel client 2020-11-12 21:28:14.384 UTM[8995:5595626] Debug JSON recieved <- { data = { client = { "channel-id" = 0; "channel-type" = 4; "connection-id" = 16807; family = ipv4; host = "127.0.0.1"; port = 52571; tls = 0; }; server = { auth = none; family = ipv4; host = "127.0.0.1"; port = 4001; }; }; event = "SPICE_INITIALIZED"; timestamp = { microseconds = 384638; seconds = 1605212894; }; } qemu-system: info: GSpice: channel-cursor.c:387 cursor-4:0: set_cursor: flags 1, size 0 qemu-system: info: Spice: red-channel-client.c:1394:red_channel_client_handle_pong: update roundtrip 0.32(ms) qemu-system: info: Spice: red-channel-client.c:1394:red_channel_client_handle_pong: update roundtrip 0.28(ms) qemu-system: info: Spice: red-worker.c:490:dev_create_primary_surface: trace qemu-system: info: GSpice: channel-cursor.c:542 cursor-4:0: cursor_handle_reset, init_done: 1 qemu-system: info: GSpice: channel-display.c:1941 display-2:0: 0: FIXME primary destroy, but is display really disabled? qemu-system: info: Spice: display-channel.c:173:monitors_config_unref: freeing monitors config qemu-system: info: Spice: display-channel.c:181:monitors_config_debug: monitors config count:1 max:1 2020-11-12 20:28:14,742 DEBUG (null)-/Users/runner/work/UTM/UTM/CocoaSpice/CSInput.m:135 0:0 cs_cursor_reset qemu-system: info: Spice: display-channel.c:185:monitors_config_debug: +0+0 800x600 qemu-system: info: GSpice: channel-display.c:1899 surface flags: 1 qemu-system: info: GSpice: channel-display.c:947 display-2:0: Create primary canvas 2020-11-12 20:28:14,743 DEBUG (null)-/Users/runner/work/UTM/UTM/CocoaSpice/CSDisplayMetal.m:118 0:0 update monitor area qemu-system: info: GSpice: spice-channel.c:2926 test cap 1 in 0x1052: yes qemu-system: info: GSpice: channel-display.c:1969 display-2:0: received new monitors config from guest: n: 1/1 2020-11-12 20:28:14,743 DEBUG (null)-/Users/runner/work/UTM/UTM/CocoaSpice/CSDisplayMetal.m:118 0:0 update monitor area qemu-system: info: GSpice: channel-display.c:1989 display-2:0: monitor id: 0, surface id: 0, +0+0-800x600 qemu-system: info: GSpice: channel-cursor.c:387 cursor-4:0: set_cursor: flags 1, size 0 qemu-system: info: GSpice: channel-display.c:1123 display-2:0: display_handle_mark 2020-11-12 20:28:16,610 DEBUG (null)-/Users/runner/work/UTM/UTM/CocoaSpice/CSInput.m:375 0:0 -[CSInput sendMouseButton:pressed:point:] press: button 1 2020-11-12 20:28:16,719 DEBUG (null)-/Users/runner/work/UTM/UTM/CocoaSpice/CSInput.m:375 0:0 -[CSInput sendMouseButton:pressed:point:] release: button 1 2020-11-12 20:28:17,894 DEBUG (null)-/Users/runner/work/UTM/UTM/CocoaSpice/CSInput.m:375 0:0 -[CSInput sendMouseButton:pressed:point:] press: button 1 2020-11-12 20:28:18,003 DEBUG (null)-/Users/runner/work/UTM/UTM/CocoaSpice/CSInput.m:375 0:0 -[CSInput sendMouseButton:pressed:point:] release: button 1 Current location: 52.32278684992808 16.80622294273185 2020-11-12 21:28:20.310 UTM[8995:5332914] Current location: 52.32278684992808 16.80622294273185 Debug JSON send -> { execute = "query-block"; } 2020-11-12 21:28:20.909 UTM[8995:5332914] Debug JSON send -> { execute = "query-block"; } Debug JSON recieved <- { return = ( { device = drive0; inserted = { "backing_file_depth" = 0; bps = 0; "bps_rd" = 0; "bps_wr" = 0; cache = { direct = 0; "no-flush" = 0; writeback = 1; }; "detect_zeroes" = off; drv = qcow2; encrypted = 0; "encryption_key_missing" = 0; file = "/var/mobile/Containers/Data/Application/D97396BF-2D61-48D6-9551-1FA4AD762F6C/Documents/MacOS.utm/Images/disk-0.qcow2"; image = { "actual-size" = 12086583296; "cluster-size" = 65536; "dirty-flag" = 0; filename = "/var/mobile/Containers/Data/Application/D97396BF-2D61-48D6-9551-1FA4AD762F6C/Documents/MacOS.utm/Images/disk-0.qcow2"; format = qcow2; "format-specific" = { data = { compat = "1.1"; "compression-type" = zlib; corrupt = 0; "lazy-refcounts" = 0; "refcount-bits" = 16; }; type = qcow2; }; "virtual-size" = 21223178240; }; iops = 0; "iops_rd" = 0; "iops_wr" = 0; "node-name" = "#block180"; ro = 0; "write_threshold" = 0; }; "io-status" = ok; locked = 0; qdev = "/machine/unattached/device[10]"; removable = 0; type = unknown; }, { device = "ide1-cd0"; "io-status" = ok; locked = 0; qdev = "/machine/unattached/device[11]"; removable = 1; "tray_open" = 0; type = unknown; }, { device = floppy0; locked = 0; removable = 1; type = unknown; }, { device = sd0; locked = 0; removable = 1; type = unknown; } ); } 2020-11-12 21:28:20.910 UTM[8995:5595442] Debug JSON recieved <- { return = ( { device = drive0; inserted = { "backing_file_depth" = 0; bps = 0; "bps_rd" = 0; "bps_wr" = 0; cache = { direct = 0; "no-flush" = 0; writeback = 1; }; "detect_zeroes" = off; drv = qcow2; encrypted = 0; "encryption_key_missing" = 0; file = "/var/mobile/Containers/Data/Application/D97396BF-2D61-48D6-9551-1FA4AD762F6C/Documents/MacOS.utm/Images/disk-0.qcow2"; image = { "actual-size" = 12086583296; "cluster-size" = 65536; "dirty-flag" = 0; filename = "/var/mobile/Containers/Data/Application/D97396BF-2D61-48D6-9551-1FA4AD762F6C/Documents/MacOS.utm/Images/disk-0.qcow2"; format = qcow2; "format-specific" = { data = { compat = "1.1"; "compression-type" = zlib; corrupt = 0; "lazy-refcounts" = 0; "refcount-bits" = 16; }; type = qcow2; }; "virtual-size" = 21223178240; }; iops = 0; "iops_rd" = 0; "iops_wr" = 0; "node-name" = "#block180"; ro = 0; "write_threshold" = 0; }; "io-status" = ok; locked = 0; qdev = "/machine/unattached/device[10]"; removable = 0; type = unknown; }, { device = "ide1-cd0"; "io-status" = ok; locked = 0; qdev = "/machine/unattached/device[11]"; removable = 1; "tray_open" = 0; type = unknown; }, { device = floppy0; locked = 0; removable = 1; type = unknown; }, { device = sd0; locked = 0; removable = 1; type = unknown; } ); } Debug JSON send -> { execute = quit; } 2020-11-12 21:28:20.912 UTM[8995:5595442] Debug JSON send -> { execute = quit; } Debug JSON recieved <- { return = { }; } Debug JSON recieved <- { data = { guest = 0; reason = "host-qmp-quit"; }; event = SHUTDOWN; timestamp = { microseconds = 913504; seconds = 1605212900; }; } 2020-11-12 21:28:20.913 UTM[8995:5595444] Debug JSON recieved <- { return = { }; } qemu-system: info: Spice: red-worker.c:602:handle_dev_stop: stop qemuWillQuit, reason = host-qmp-quit 2020-11-12 21:28:20.913 UTM[8995:5595444] Debug JSON recieved <- { data = { guest = 0; reason = "host-qmp-quit"; }; event = SHUTDOWN; timestamp = { microseconds = 913504; seconds = 1605212900; }; } 2020-11-12 21:28:20.913 UTM[8995:5595444] qemuWillQuit, reason = host-qmp-quit qemu-system: info: GSpice: spice-session.c:1994 session: disconnecting 0 qemu-system: info: GSpice: spice-channel.c:2888 inputs-3:0: channel disconnect 0 2020-11-12 20:28:20,914 DEBUG (null)-/Users/runner/work/UTM/UTM/CocoaSpice/CSDisplayMetal.m:213 0:0 channel_destroy 0 2020-11-12 20:28:20,914 DEBUG (null)-/Users/runner/work/UTM/UTM/CocoaSpice/CSInput.m:190 0:0 channel_destroy 0 qemu-system: info: GSpice: spice-channel.c:2680 inputs-3:0: Coroutine exit inputs-3:0 2020-11-12 20:28:20,914 DEBUG (null)-/Users/runner/work/UTM/UTM/CocoaSpice/CSDisplayMetal.m:213 0:0 channel_destroy 0 qemu-system: info: GSpice: spice-channel.c:2871 inputs-3:0: reset 2020-11-12 20:28:20,914 DEBUG (null)-/Users/runner/work/UTM/UTM/CocoaSpice/CSInput.m:190 0:0 channel_destroy 0 qemu-system: info: GSpice: spice-channel.c:2819 inputs-3:0: channel reset cs_channel_destroy:183 qemu-system: info: GSpice: spice-channel.c:2888 cursor-4:0: channel disconnect 0 qemu-system: info: GSpice: spice-channel.c:2680 cursor-4:0: Coroutine exit cursor-4:0 qemu-system: info: GSpice: spice-channel.c:2871 cursor-4:0: reset cs_channel_destroy:222 2020-11-12 20:28:20,915 DEBUG (null)-/Users/runner/work/UTM/UTM/CocoaSpice/CSConnection.m:184 zap display channel (#0) qemu-system: info: GSpice: spice-channel.c:2819 cursor-4:0: channel reset 2020-11-12 20:28:20,915 DEBUG (null)-/Users/runner/work/UTM/UTM/CocoaSpice/CSDisplayMetal.m:213 0:0 channel_destroy 0 2020-11-12 20:28:20,915 DEBUG (null)-/Users/runner/work/UTM/UTM/CocoaSpice/CSInput.m:190 0:0 channel_destroy 0 2020-11-12 21:28:20.915 UTM[8995:5595643] cs_channel_destroy:183 2020-11-12 21:28:20.915 UTM[8995:5595643] cs_channel_destroy:222 cs_channel_destroy:176 qemu-system: info: GSpice: spice-channel.c:2888 display-2:0: channel disconnect 0 qemu-system: info: GSpice: spice-channel.c:2680 display-2:0: Coroutine exit display-2:0 2020-11-12 20:28:20,915 DEBUG (null)-/Users/runner/work/UTM/UTM/CocoaSpice/CSConnection.m:177 zap main channel qemu-system: info: GSpice: spice-channel.c:2871 display-2:0: reset 2020-11-12 20:28:20,915 DEBUG (null)-/Users/runner/work/UTM/UTM/CocoaSpice/CSDisplayMetal.m:213 0:0 channel_destroy 0 qemu-system: info: GSpice: channel-display.c:1034 display-2:0: keeping existing primary surface, migration or reset qemu-system: info: GSpice: spice-channel.c:2819 display-2:0: channel reset 2020-11-12 20:28:20,915 DEBUG (null)-/Users/runner/work/UTM/UTM/CocoaSpice/CSInput.m:190 0:0 channel_destroy 0 qemu-system: info: GSpice: spice-session.c:2322 main-1:0: the session lost the main channel 2020-11-12 21:28:20.915 UTM[8995:5595643] cs_channel_destroy:176 qemu-system: info: Spice: dcc.c:1433:dcc_on_disconnect: trace qemu-system: info: GSpice: spice-channel.c:2888 main-1:0: channel disconnect 0 qemu-system: info: Spice: dcc.c:1445:dcc_on_disconnect: #draw=0, #glz_draw=0 qemu-system: info: GSpice: spice-channel.c:2680 main-1:0: Coroutine exit main-1:0 qemu-system: info: GSpice: spice-channel.c:2871 main-1:0: reset

tyrrtechinc commented 4 years ago

I was having this same issue as well and added the -boot order=c to the qemu parameters and then it started working for me.