search

utmapp / UTM

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

UTM freezes and device unresponsive #383

Closed reaowe closed 4 years ago

reaowe commented 4 years ago

Describe the bug UTM freezes when I put a app in split view mode. Either my device or UTM runs out of ram when trying to multitask. Also could be that I put too much ram and/or JIT cache to the vm. It makes my device unresponsive etc. (Can lock the device but not exit the app; I have to restart my iPad) To Reproduce Steps to reproduce the behavior: Btw this happened when I was using Leopard on iPad Air 3 (iPadOS 13.4.1 Jailbroken):

  1. Start up vm
  2. Wait for to finish loading
  3. Put a app in split view mode

Crash log App did not crash

Debug log

-[CSConnection init]:250 Loading libqemu-system-ppc.dylib Running: qemu -L /private/var/containers/Bundle/Application/3A6DCA94-0AA1-4060-B6D6-FA6B7FACCCDA/UTM.app/qemu -qmp tcp:localhost:4444,server,nowait -smp cpus=1,sockets=1 -machine mac99,via=pmu -tb-size 512 -m 512 -name "Mac OS X Leopard" -drive "file=/private/var/mobile/Containers/Data/Application/BFAC73F5-8A67-47E6-B4AA-8ABC67780F54/Documents/Mac OS X Leopard.utm/Images/osx leopard install.iso,if=ide,media=cdrom,id=drive0" -drive "file=/private/var/mobile/Containers/Data/Application/BFAC73F5-8A67-47E6-B4AA-8ABC67780F54/Documents/Mac OS X Leopard.utm/Images/hard drive,if=ide,media=disk,id=drive1" -spice port=5930,addr=127.0.0.1,disable-ticketing,image-compression=off,playback-compression=off,streaming-video=off -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 621B0D7B-CE27-4058-A1B7-6BD661C76B3C -rtc base=localtime qemu: info: Spice: reds.c:4214:spice_server_set_seamless_migration: seamless migration enabled=0 qemu: info: Spice: reds.c:3359:do_spice_init: starting 0.14.1 qemu: info: Spice: char-device.c:690:red_char_device_reset_dev_instance: sin 0x0, char device 0x112858110 qemu: info: Spice: reds.c:2561:reds_init_socket: bound to 127.0.0.1:5930 qemu: info: Spice: main:0 (0x112860080): thread_id 0x16fc8f000 qemu: info: Spice: inputs:0 (0x11285c1a0): thread_id 0x16fc8f000 qemu: info: Spice: reds.c:3297:spice_server_add_interface: SPICE_INTERFACE_MIGRATION qemu: info: Spice: reds.c:3214:spice_server_add_interface: SPICE_INTERFACE_KEYBOARD qemu: info: Spice: reds.c:3224:spice_server_add_interface: SPICE_INTERFACE_MOUSE qemu: info: Spice: reds.c:3236:spice_server_add_interface: SPICE_INTERFACE_QXL qemu: info: Spice: cursor-channel.c:238:cursor_channel_new: create cursor channel qemu: info: Spice: cursor:0 (0x110b78d40): thread_id 0x16fc8f000 qemu: info: Spice: display-channel.c:2235:display_channel_new: create display channel qemu: info: Spice: display:0 (0x112860140): thread_id 0x16fc8f000 qemu: info: Spice: display-channel.c:236:display_channel_set_stream_video: sv off qemu: info: Spice: red-worker.c:1360:red_worker_main: begin qemu: info: Spice: red-worker.c:490:dev_create_primary_surface: trace qemu: info: Spice: display-channel.c:181:monitors_config_debug: monitors config count:1 max:1 qemu: info: Spice: display-channel.c:185:monitors_config_debug: +0+0 640x480 qemu: info: Spice: cursor-channel.c:318:cursor_channel_init_client: during_target_migrate: skip init -[CSSession initWithSession:]:309 qemu: info: GSpice: spice-session.c:1802 no migration in progress qemu: info: GSpice: spice-channel.c:141 main-1:0: spice_channel_constructed qemu: info: GSpice: spice-session.c:2282 main-1:0: new main channel, switching cs_channel_new:139 2020-06-18 19:20:40,236 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSConnection.m:133 new channel (#0) 2020-06-18 19:20:40,237 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSConnection.m:136 new main channel 2020-06-18 19:20:40,237 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSSession.m:249 Changing main channel from 0x0 to 0x1052af700 qemu: info: GSpice: spice-channel.c:2707 main-1:0: Open coroutine starting 0x1052af700 qemu: info: GSpice: spice-channel.c:2544 main-1:0: Started background coroutine 0x1052ad230 qemu: info: GSpice: spice-session.c:2234 main-1:0: Using plain text, port 5930 Current location: 43.73136955739153 -79.41702210687261 Current location: 43.73136955739153 -79.41702210687261 qemu: info: GSpice: spice-session.c:2165 open host 127.0.0.1:5930 Connected to stream QMP connection successful! (readStream:1) Connected to stream QMP connection successful! (readStream:0) Debug JSON recieved <- { QMP = { capabilities = ( oob ); version = { package = ""; qemu = { major = 4; micro = 0; minor = 2; }; }; }; } qemu: info: GSpice: spice-session.c:2087 main-1:0: connecting 0x13833ac28... Got QMP handshake: { QMP = { capabilities = ( oob ); version = { package = ""; qemu = { major = 4; micro = 0; minor = 2; }; }; }; } Debug JSON send -> { arguments = { }; execute = "qmp_capabilities"; } Debug JSON recieved <- { return = { }; } qemu: info: GSpice: spice-session.c:2071 main-1:0: connect ready Debug JSON recieved <- { data = { client = { family = ipv4; host = "127.0.0.1"; port = 49214; }; server = { family = ipv4; host = "127.0.0.1"; port = 5930; }; }; event = "SPICE_CONNECTED"; timestamp = { microseconds = 241177; seconds = 1592508040; }; } qemu: info: GSpice: spice-channel.c:1367 main-1:0: channel type 1 id 0 num common caps 1 num caps 1 qemu: info: GSpice: spice-channel.c:1391 main-1:0: Peer version: 2:2 qemu: info: GSpice: spice-channel.c:1947 main-1:0: spice_channel_recv_link_msg: 2 caps qemu: info: GSpice: spice-channel.c:1961 main-1:0: got remote common caps: qemu: info: GSpice: spice-channel.c:1897 0:0xB qemu: info: GSpice: spice-channel.c:1968 main-1:0: got remote channel caps: qemu: info: GSpice: spice-channel.c:1897 0:0x9 qemu: info: GSpice: spice-channel.c:2926 test cap 0 in 0xB: yes qemu: info: GSpice: spice-channel.c:2926 test cap 1 in 0xB: yes qemu: info: GSpice: spice-channel.c:2926 test cap 3 in 0xB: yes qemu: info: GSpice: spice-channel.c:2000 main-1:0: use mini header: 1 qemu: info: Spice: reds.c:2159:reds_handle_auth_mechanism: Auth method: 1 qemu: info: Spice: reds.c:1789:reds_handle_main_link: trace Debug JSON recieved <- { data = { client = { "channel-id" = 0; "channel-type" = 1; "connection-id" = 16807; family = ipv4; host = "127.0.0.1"; port = 49214; tls = 0; }; server = { auth = none; family = ipv4; host = "127.0.0.1"; port = 5930; }; }; event = "SPICE_INITIALIZED"; timestamp = { microseconds = 257659; seconds = 1592508040; }; } qemu: info: Spice: reds.c:603:reds_disconnect: trace qemu: info: Spice: reds.c:1642:reds_info_new_channel: channel 1:0, connected successfully, over Non Secure link qemu: info: Spice: red_channel_client_class_init 2020-06-18 19:20:40,258 MESSAGE (null)-main channel: opened qemu: info: GSpice: spice-channel.c:1298 main-1:0: channel up, state 3 qemu: info: Spice: reds.c:1828:reds_handle_main_link: NEW Client 0x136cb1570 mcc 0x112e869e0 connect-id 16807 qemu: info: GSpice: spice-session.c:2386 set mm time: 6526449 qemu: info: GSpice: spice-session.c:2389 spice_session_set_mm_time: mm-time-reset, old 6526849, new 6526449 qemu: info: GSpice: channel-main.c:1693 server name: Mac OS X Leopard qemu: info: GSpice: channel-main.c:1704 server uuid: 621b0d7b-ce27-4058-a1b7-6bd661c76b3c qemu: info: Spice: main:0 (0x112860080): net test: latency 1.075000 ms, bitrate 292571428571 bps (279017.857142 Mbps) qemu: info: Spice: red-channel-client.c:792:red_channel_client_start_connectivity_monitoring: trace qemu: info: Spice: channel-display-gst.c:718:gstvideo_debug_available_decoders: From 1 video decoder elements, 1 can handle caps image/jpeg: jpegdec cs_channel_new:146 qemu: info: Spice: channel-display-gst.c:748:gstvideo_has_codec: From 1 decoders, none can handle 'video/x-vp8' 2020-06-18 19:20:40,260 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSConnection.m:133 new channel (#0) qemu: info: GSpice: channel-display.c:894 GStreamer does not support the vp8 codec 2020-06-18 19:20:40,260 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSConnection.m:145 new display channel (#0) qemu: info: Spice: channel-display-gst.c:748:gstvideo_has_codec: From 1 decoders, none can handle 'video/x-h264' 2020-06-18 19:20:40,260 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSConnection.m:133 new channel (#0) qemu: info: GSpice: channel-display.c:894 GStreamer does not support the h264 codec qemu: info: Spice: channel-display-gst.c:748:gstvideo_has_codec: From 1 decoders, none can handle 'video/x-vp9' qemu: info: GSpice: channel-display.c:894 GStreamer does not support the vp9 codec 2020-06-18 19:20:40,260 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSConnection.m:133 new channel (#0) qemu: info: Spice: channel-display-gst.c:748:gstvideo_has_codec: From 1 decoders, none can handle 'video/x-h265' qemu: info: GSpice: channel-display.c:894 GStreamer does not support the h265 codec qemu: info: GSpice: spice-channel.c:141 display-2:0: spice_channel_constructed qemu: info: GSpice: spice-channel.c:141 cursor-4:0: spice_channel_constructed qemu: info: GSpice: spice-channel.c:141 inputs-3:0: spice_channel_constructed qemu: info: GSpice: spice-channel.c:2707 display-2:0: Open coroutine starting 0x1041953b0 qemu: info: GSpice: spice-channel.c:2544 display-2:0: Started background coroutine 0x104192ee0 qemu: info: GSpice: spice-session.c:2234 display-2:0: Using plain text, port 5930 qemu: info: GSpice: spice-session.c:2165 open host 127.0.0.1:5930 qemu: info: GSpice: spice-session.c:2087 display-2:0: connecting 0x13933ac28... qemu: info: GSpice: spice-session.c:2071 display-2:0: connect ready qemu: 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 = 49215; }; server = { family = ipv4; host = "127.0.0.1"; port = 5930; }; }; event = "SPICE_CONNECTED"; timestamp = { microseconds = 262015; seconds = 1592508040; }; } qemu: info: GSpice: spice-channel.c:1391 display-2:0: Peer version: 2:2 qemu: info: GSpice: spice-channel.c:1947 display-2:0: spice_channel_recv_link_msg: 2 caps qemu: info: GSpice: spice-channel.c:1961 display-2:0: got remote common caps: qemu: info: GSpice: spice-channel.c:1897 0:0xB qemu: info: GSpice: spice-channel.c:1968 display-2:0: got remote channel caps: qemu: info: GSpice: spice-channel.c:1897 0:0x1052 qemu: info: GSpice: spice-channel.c:2926 test cap 0 in 0xB: yes qemu: info: GSpice: spice-channel.c:2926 test cap 1 in 0xB: yes qemu: info: Spice: reds.c:2159:reds_handle_auth_mechanism: Auth method: 1 qemu: info: GSpice: spice-channel.c:2926 test cap 3 in 0xB: yes qemu: info: GSpice: spice-channel.c:2000 display-2:0: use mini header: 1 qemu: info: Spice: reds.c:1642:reds_info_new_channel: channel 2:0, connected successfully, over Non Secure link Debug JSON recieved <- { data = { client = { "channel-id" = 0; "channel-type" = 2; "connection-id" = 16807; family = ipv4; host = "127.0.0.1"; port = 49215; tls = 0; }; server = { auth = none; family = ipv4; host = "127.0.0.1"; port = 5930; }; }; event = "SPICE_INITIALIZED"; timestamp = { microseconds = 297027; seconds = 1592508040; }; } qemu: info: Spice: red-qxl.c:80:red_qxl_set_display_peer: qemu: info: Spice: red-worker.c:719:handle_dev_display_connect: connect new client qemu: info: GSpice: spice-channel.c:1298 display-2:0: channel up, state 3 qemu: info: GSpice: channel-display.c:1069 display-2:0: spice_display_channel_up: cache_size 83886080, glz_window_size 12582912 (bytes) qemu: info: Spice: dcc.c:518:dcc_new: New display (client 0x136cb1570) dcc 0x112e8c860 stream 0x2825d5a80 qemu: info: Spice: display-channel.c:2374:display_channel_update_compression: jpeg disabled qemu: info: Spice: display-channel.c:2375:display_channel_update_compression: zlib-over-glz disabled qemu: info: Spice: image-encoders.c:734:create_glz_dictionary: Lz Window 1 Size=3145728 qemu: info: Spice: dcc.c:551:display_channel_client_wait_for_init: creating encoder with id == 0 qemu: info: GSpice: channel-display.c:1899 surface flags: 1 qemu: info: GSpice: channel-display.c:947 display-2:0: Create primary canvas qemu: info: GSpice: spice-channel.c:2926 test cap 1 in 0x1052: yes qemu: info: GSpice: channel-display.c:1969 display-2:0: received new monitors config from guest: n: 1/1 -[CSDisplayMetal initWithSession:channelID:monitorID:]:298 cs_channel_new:176 qemu: info: GSpice: channel-display.c:1989 display-2:0: monitor id: 0, surface id: 0, +0+0-640x480 qemu: info: GSpice: channel-display.c:559 display-2:0: get primary 0x135504000 -[CSInput initWithSession:channelID:monitorID:]:434 2020-06-18 19:20:40,303 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSDisplayMetal.m:116 0:0 update monitor area 2020-06-18 19:20:40,303 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:63 0:0 mouse mode 1 qemu: info: GSpice: channel-display.c:1123 display-2:0: display_handle_mark qemu: info: GSpice: spice-channel.c:2707 inputs-3:0: Open coroutine starting 0x104199f60 qemu: info: GSpice: spice-channel.c:2544 inputs-3:0: Started background coroutine 0x104197a90 qemu: info: GSpice: spice-session.c:2234 inputs-3:0: Using plain text, port 5930 resizing to (1112.000000, 834.000000) qemu: info: GSpice: spice-channel.c:2707 cursor-4:0: Open coroutine starting 0x104197960 qemu: info: GSpice: spice-channel.c:2544 cursor-4:0: Started background coroutine 0x104195490 qemu: info: GSpice: spice-session.c:2234 cursor-4:0: Using plain text, port 5930 qemu: info: GSpice: spice-session.c:2165 open host 127.0.0.1:5930 qemu: GSpice: spice_main_channel_send_monitor_config: assertion 'c->agent_connected' failed qemu: info: GSpice: spice-session.c:2087 inputs-3:0: connecting 0x13ab3ec28... qemu: info: GSpice: spice-session.c:2165 open host 127.0.0.1:5930 qemu: info: GSpice: spice-session.c:2087 cursor-4:0: connecting 0x13bb3ec28... qemu: info: GSpice: spice-session.c:2071 inputs-3:0: connect ready qemu: 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 = 49216; }; server = { family = ipv4; host = "127.0.0.1"; port = 5930; }; }; event = "SPICE_CONNECTED"; timestamp = { microseconds = 305223; seconds = 1592508040; }; } qemu: info: GSpice: spice-session.c:2071 cursor-4:0: connect ready qemu: info: GSpice: spice-channel.c:1367 cursor-4:0: channel type 4 id 0 num common caps 1 num caps 0 Debug JSON recieved <- { data = { client = { family = ipv4; host = "127.0.0.1"; port = 49217; }; server = { family = ipv4; host = "127.0.0.1"; port = 5930; }; }; event = "SPICE_CONNECTED"; timestamp = { microseconds = 310889; seconds = 1592508040; }; } qemu: info: GSpice: spice-channel.c:1391 inputs-3:0: Peer version: 2:2 qemu: info: GSpice: spice-channel.c:1947 inputs-3:0: spice_channel_recv_link_msg: 2 caps qemu: info: GSpice: spice-channel.c:1961 inputs-3:0: got remote common caps: qemu: info: GSpice: spice-channel.c:1897 0:0xB qemu: info: GSpice: spice-channel.c:1968 inputs-3:0: got remote channel caps: qemu: info: GSpice: spice-channel.c:1897 0:0x1 qemu: info: GSpice: spice-channel.c:2926 test cap 0 in 0xB: yes qemu: info: GSpice: spice-channel.c:2926 test cap 1 in 0xB: yes qemu: info: GSpice: spice-channel.c:2926 test cap 3 in 0xB: yes qemu: info: GSpice: spice-channel.c:2000 inputs-3:0: use mini header: 1 qemu: info: Spice: reds.c:2159:reds_handle_auth_mechanism: Auth method: 1 qemu: info: GSpice: spice-channel.c:1391 cursor-4:0: Peer version: 2:2 qemu: info: GSpice: spice-channel.c:1947 cursor-4:0: spice_channel_recv_link_msg: 1 caps qemu: info: GSpice: spice-channel.c:1961 cursor-4:0: got remote common caps: qemu: info: GSpice: spice-channel.c:1897 0:0xB qemu: info: GSpice: spice-channel.c:1968 cursor-4:0: got remote channel caps: qemu: info: GSpice: spice-channel.c:2926 test cap 0 in 0xB: yes qemu: info: GSpice: spice-channel.c:2926 test cap 1 in 0xB: yes qemu: info: GSpice: spice-channel.c:2926 test cap 3 in 0xB: yes qemu: info: GSpice: spice-channel.c:2000 cursor-4:0: use mini header: 1 qemu: info: Spice: reds.c:1642:reds_info_new_channel: channel 3:0, connected successfully, over Non Secure link qemu: info: Spice: reds.c:2159:reds_handle_auth_mechanism: Auth method: 1 qemu: info: GSpice: channel-base.c:81 main-1:0: spice_channel_handle_notify -- warn!!! #0: keyboard channel is insecure qemu: info: GSpice: spice-channel.c:1298 inputs-3:0: channel up, state 3 qemu: info: Spice: reds.c:1642:reds_info_new_channel: channel 4:0, connected successfully, over Non Secure link qemu: info: Spice: red-worker.c:815:handle_dev_cursor_connect: cursor connect qemu: info: Spice: cursor-channel.c:349:cursor_channel_connect: add cursor channel client qemu: info: GSpice: spice-channel.c:1298 cursor-4:0: channel up, state 3 Debug JSON recieved <- { data = { client = { "channel-id" = 0; "channel-type" = 3; "connection-id" = 16807; family = ipv4; host = "127.0.0.1"; port = 49216; tls = 0; }; server = { auth = none; family = ipv4; host = "127.0.0.1"; port = 5930; }; }; event = "SPICE_INITIALIZED"; timestamp = { microseconds = 334773; seconds = 1592508040; }; } Debug JSON recieved <- { data = { client = { "channel-id" = 0; "channel-type" = 4; "connection-id" = 16807; family = ipv4; host = "127.0.0.1"; port = 49217; tls = 0; }; server = { auth = none; family = ipv4; host = "127.0.0.1"; port = 5930; }; }; event = "SPICE_INITIALIZED"; timestamp = { microseconds = 336308; seconds = 1592508040; }; } qemu: info: GSpice: channel-cursor.c:387 cursor-4:0: set_cursor: flags 1, size 0 qemu: info: Spice: red-channel-client.c:1394:red_channel_client_handle_pong: update roundtrip 0.27(ms) qemu: info: Spice: red-channel-client.c:1394:red_channel_client_handle_pong: update roundtrip 0.24(ms) Current location: 43.73135772030817 -79.41699610956427 qemu: info: Spice: red-worker.c:490:dev_create_primary_surface: trace 2020-06-18 19:20:41,441 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:134 0:0 cs_cursor_reset qemu: info: GSpice: channel-cursor.c:542 cursor-4:0: cursor_handle_reset, init_done: 1 qemu: info: GSpice: channel-display.c:1941 display-2:0: 0: FIXME primary destroy, but is display really disabled? qemu: info: Spice: display-channel.c:173:monitors_config_unref: freeing monitors config qemu: info: Spice: display-channel.c:181:monitors_config_debug: monitors config count:1 max:1 qemu: info: Spice: display-channel.c:185:monitors_config_debug: +0+0 800x600 qemu: info: GSpice: channel-display.c:1899 surface flags: 1 qemu: info: GSpice: channel-display.c:947 display-2:0: Create primary canvas qemu: info: GSpice: channel-cursor.c:387 cursor-4:0: set_cursor: flags 1, size 0 2020-06-18 19:20:41,443 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSDisplayMetal.m:116 0:0 update monitor area qemu: info: GSpice: spice-channel.c:2926 test cap 1 in 0x1052: yes qemu: info: GSpice: channel-display.c:1969 display-2:0: received new monitors config from guest: n: 1/1 qemu: info: GSpice: channel-display.c:1989 display-2:0: monitor id: 0, surface id: 0, +0+0-800x600 2020-06-18 19:20:41,443 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSDisplayMetal.m:116 0:0 update monitor area qemu: info: GSpice: channel-display.c:1123 display-2:0: display_handle_mark Current location: 43.73146703310364 -79.4171358218248 Current location: 43.73142154861932 -79.41708199258581 Current location: 43.731430982747 -79.41709595944998 qemu: info: Spice: reds.c:3256:spice_server_add_interface: SPICE_INTERFACE_TABLET qemu: info: GSpice: channel-main.c:1634 main-1:0: request mouse mode 2 qemu: info: Spice: red-worker.c:905:handle_dev_set_mouse_mode: mouse mode 2 2020-06-18 19:21:04,060 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:63 0:0 mouse mode 2 qemu: info: Spice: reds.c:3327:spice_server_remove_interface: remove SPICE_INTERFACE_TABLET qemu: info: Spice: red-worker.c:905:handle_dev_set_mouse_mode: mouse mode 1 2020-06-18 19:21:04,311 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:63 0:0 mouse mode 1 Current location: 43.73145852099878 -79.41709142015766 qemu: info: Spice: red-channel-client.c:1394:red_channel_client_handle_pong: update roundtrip 0.22(ms) Current location: 43.73144853643529 -79.41711509876764 qemu: info: Spice: red-channel-client.c:1394:red_channel_client_handle_pong: update roundtrip 0.21(ms) Current location: 43.7314643820775 -79.4170922882176 Current location: 43.73136798610365 -79.41704919500319 Current location: 43.73134490299584 -79.41701261301306 Switching mouse mode to server:0 for type:1 2020-06-18 19:21:35,195 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] release: button 0 Debug JSON send -> { execute = "query-mice"; } Debug JSON recieved <- { return = ( { absolute = 0; current = 0; index = 4; name = "QEMU HID Mouse"; }, { absolute = 1; current = 0; index = 3; name = "QEMU HID Tablet"; }, { absolute = 0; current = 1; index = 2; name = "QEMU HID Mouse"; } ); } found index:3 absolute:1 Debug JSON send -> { arguments = { "command-line" = "mouse_set 3"; }; execute = "human-monitor-command"; } Debug JSON recieved <- { return = "info: Spice: reds.c:3256:spice_server_add_interface: SPICE_INTERFACE_TABLET \n"; } qemu: info: GSpice: channel-main.c:1634 main-1:0: request mouse mode 2 2020-06-18 19:21:35,201 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:63 0:0 mouse mode 2 qemu: info: Spice: red-worker.c:905:handle_dev_set_mouse_mode: mouse mode 2 qemu: info: GSpice: channel-main.c:1634 main-1:0: request mouse mode 2 2020-06-18 19:21:35,280 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] release: button 0 Current location: 43.73145649625123 -79.41710640789768 Current location: 43.73146665594334 -79.41711581838322 Switching mouse mode to server:1 for type:0 Debug JSON send -> { execute = "query-mice"; } 2020-06-18 19:21:58,359 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] release: button 0 Debug JSON recieved <- { return = ( { absolute = 0; current = 0; index = 4; name = "QEMU HID Mouse"; }, { absolute = 0; current = 0; index = 2; name = "QEMU HID Mouse"; }, { absolute = 1; current = 1; index = 3; name = "QEMU HID Tablet"; } ); } found index:2 absolute:0 Debug JSON send -> { arguments = { "command-line" = "mouse_set 2"; }; execute = "human-monitor-command"; } Debug JSON recieved <- { return = "info: Spice: reds.c:3327:spice_server_remove_interface: remove SPICE_INTERFACE_TABLET \n"; } qemu: info: Spice: red-worker.c:905:handle_dev_set_mouse_mode: mouse mode 1 qemu: info: GSpice: channel-main.c:1634 main-1:0: request mouse mode 1 2020-06-18 19:21:58,364 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:63 0:0 mouse mode 1 Current location: 43.73146348386425 -79.41711319251702 Switching mouse mode to server:0 for type:1 selecting input device 3 2020-06-18 19:22:15,291 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] release: button 0 Debug JSON send -> { arguments = { "command-line" = "mouse_set 3"; }; execute = "human-monitor-command"; } Debug JSON recieved <- { return = "info: Spice: reds.c:3256:spice_server_add_interface: SPICE_INTERFACE_TABLET \n"; } qemu: info: GSpice: channel-main.c:1634 main-1:0: request mouse mode 2 qemu: info: Spice: red-worker.c:905:handle_dev_set_mouse_mode: mouse mode 2 2020-06-18 19:22:15,300 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:63 0:0 mouse mode 2 2020-06-18 19:22:15,406 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] release: button 0 Current location: 43.7314394334843 -79.41707590584768 2020-06-18 19:22:18,739 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] press: button 1 2020-06-18 19:22:18,852 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] release: button 0 2020-06-18 19:22:20,422 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] press: button 1 2020-06-18 19:22:20,522 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] release: button 0 2020-06-18 19:22:22,128 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] press: button 1 2020-06-18 19:22:22,242 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] release: button 0 2020-06-18 19:22:22,342 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] press: button 1 2020-06-18 19:22:22,429 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] release: button 0 Current location: 43.73143706656883 -79.41707223628306 2020-06-18 19:22:31,058 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] press: button 1 2020-06-18 19:22:31,173 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] release: button 0 2020-06-18 19:22:31,315 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] press: button 1 2020-06-18 19:22:31,374 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] release: button 0 2020-06-18 19:22:33,908 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] press: button 1 2020-06-18 19:22:33,949 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] release: button 0 2020-06-18 19:22:34,080 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] press: button 1 2020-06-18 19:22:34,123 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] release: button 0 qemu: info: Spice: red-channel-client.c:1394:red_channel_client_handle_pong: update roundtrip 0.20(ms) Current location: 43.73143714021384 -79.41707235045889 2020-06-18 19:22:52,185 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] press: button 1 2020-06-18 19:22:52,357 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] release: button 0 2020-06-18 19:22:53,682 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] press: button 1 2020-06-18 19:22:53,768 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] release: button 0 2020-06-18 19:22:53,867 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] press: button 1 2020-06-18 19:22:53,968 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] release: button 0 2020-06-18 19:22:55,517 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] press: button 1 2020-06-18 19:22:55,601 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] release: button 0 2020-06-18 19:22:55,689 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] press: button 1 2020-06-18 19:22:55,761 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] release: button 0 Current location: 43.73143716124802 -79.41707238306932 2020-06-18 19:23:03,310 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] press: button 1 2020-06-18 19:23:03,425 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] release: button 0 2020-06-18 19:23:07,232 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] press: button 1 2020-06-18 19:23:07,332 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] release: button 0 2020-06-18 19:23:09,934 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] press: button 1 2020-06-18 19:23:09,936 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] release: button 0 2020-06-18 19:23:13,067 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] press: button 1 2020-06-18 19:23:13,197 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] release: button 0 Current location: 43.73143716725573 -79.41707239238342 2020-06-18 19:23:20,211 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] press: button 1 2020-06-18 19:23:20,211 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] release: button 0 Current location: 43.73143716897171 -79.41707239504377 2020-06-18 19:23:43,342 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] press: button 1 2020-06-18 19:23:43,415 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] release: button 0 Current location: 43.73143716946195 -79.41707239580384 2020-06-18 19:23:48,037 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] press: button 1 2020-06-18 19:23:48,136 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] release: button 0 Current location: 43.73143716960212 -79.41707239602115 qemu: info: Spice: red-channel-client.c:1394:red_channel_client_handle_pong: update roundtrip 0.16(ms) Current location: 43.7314371696422 -79.41707239608328 Current location: 43.73143716965365 -79.41707239610103 Current location: 43.73143716965702 -79.41707239610626 2020-06-18 19:24:52,932 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] press: button 1 2020-06-18 19:24:52,933 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] release: button 0 2020-06-18 19:24:55,966 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] press: button 1 2020-06-18 19:24:55,968 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] release: button 0 2020-06-18 19:24:59,374 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] press: button 1 2020-06-18 19:24:59,377 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] release: button 0 2020-06-18 19:25:00,372 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] press: button 1 2020-06-18 19:25:00,375 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] release: button 0 Current location: 43.73143716965799 -79.41707239610776 2020-06-18 19:25:03,181 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] press: button 1 2020-06-18 19:25:06,865 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] release: button 0 2020-06-18 19:25:08,363 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] press: button 1 2020-06-18 19:25:15,128 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] release: button 0 Current location: 43.73143716965827 -79.4170723961082 Current location: 43.7314371696584 -79.4170723961084 2020-06-18 19:25:36,508 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] press: button 1 2020-06-18 19:25:36,592 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] release: button 0 Current location: 43.73143716965851 -79.41707239610857 2020-06-18 19:25:49,763 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] press: button 1 2020-06-18 19:25:49,893 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] release: button 0 2020-06-18 19:25:51,756 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] press: button 1 2020-06-18 19:25:51,829 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] release: button 0 Current location: 43.73143716965858 -79.41707239610868 Switching mouse mode to server:1 for type:0 selecting input device 2 Debug JSON send -> { arguments = { "command-line" = "mouse_set 2"; }; execute = "human-monitor-command"; } 2020-06-18 19:26:10,221 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] release: button 0 qemu: info: Spice: red-worker.c:905:handle_dev_set_mouse_mode: mouse mode 1 Debug JSON recieved <- { return = "info: Spice: reds.c:3327:spice_server_remove_interface: remove SPICE_INTERFACE_TABLET \n"; } qemu: info: GSpice: channel-main.c:1634 main-1:0: request mouse mode 1 2020-06-18 19:26:10,227 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:63 0:0 mouse mode 1 qemu: info: Spice: red-channel-client.c:1394:red_channel_client_handle_pong: update roundtrip 0.20(ms) Current location: 43.73143716965863 -79.41707239610874 resizing to (551.000000, 834.000000) qemu: GSpice: spice_main_channel_send_monitor_config: assertion 'c->agent_connected' failed Switching mouse mode to server:0 for type:1 selecting input device 3 2020-06-18 19:26:25,970 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] release: button 0 Debug JSON send -> { arguments = { "command-line" = "mouse_set 3"; }; execute = "human-monitor-command"; } Debug JSON recieved <- { return = "info: Spice: reds.c:3256:spice_server_add_interface: SPICE_INTERFACE_TABLET \n"; } qemu: info: GSpice: channel-main.c:1634 main-1:0: request mouse mode 2 qemu: info: Spice: red-worker.c:905:handle_dev_set_mouse_mode: mouse mode 2 2020-06-18 19:26:25,987 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:63 0:0 mouse mode 2 2020-06-18 19:26:26,103 DEBUG (null)-/Users/runner/runners/2.263.0/work/UTM/UTM/CocoaSpice/CSInput.m:374 0:0 -[CSInput sendMouseButton:pressed:point:] release: button 0 Current location: 43.73143716965864 -79.41707239610876 Saving VM state on low memory warning. Debug JSON send -> { arguments = { "command-line" = "savevm suspend"; }; execute = "human-monitor-command"; } qemu: info: Spice: red-worker.c:602:handle_dev_stop: stop Debug JSON recieved <- { event = STOP; timestamp = { microseconds = 18471; seconds = 1592508400; }; } qemuHasStopped RPC: Error Domain=com.osy86.utm Code=-1 "Timed out waiting for RPC." UserInfo={NSLocalizedDescription=Timed out waiting for RPC.} save callback: (null) error: Error Domain=com.osy86.utm Code=-1 "Timed out waiting for RPC." UserInfo={NSLocalizedDescription=Timed out waiting for RPC.}

Upload VM I will upload later. VM link would be ready once uploaded to Google Drive.

Also btw it’s hard knowing which are bugs related to the app and which are not etc.

osy commented 4 years ago

Saving VM state on low memory warning.

Try disabling that feature in settings and see if it helps. Saving the VM itself uses memory so it might seem to freeze when it’s actually just trying to save the vm.

osy commented 4 years ago

Closing due to inactivity.