Linux子系统无法启动

:pushpin:问题描述

请详细描述您所遇到的问题


:computer:系统与设备信息

  • 硬件与系统配置:Mipad2

    • 处理器:intel atom x5-z8500
    • 显卡:核显
    • RAM(运行内存):2G
    • 存储容量:16G
    • FydeOS版本:openfyde r126
  • 相关系统日志

    • 访问 Chromium 浏览器并输入 /var/log/messages 以获取日志。
    • 日志内容:
2025-05-09T07:19:37.955726Z INFO crash_reporter[12081]: developer build - not testing - always dumping
2025-05-09T07:19:37.956205Z WARNING crash_reporter[12081]: [user] Received crash notification for bash[12080] sig 6, user 1000 group 1000 (handling)
2025-05-09T07:19:37.957884Z INFO crash_reporter[12081]: State of crashed process [12080]: S (sleeping)
2025-05-09T07:19:37.966326Z INFO crash_reporter[12081]: Accessing crash dir '/run/daemon-store/crash/099ae5e8e48e8725c32d257a1d2608f46024627b' via symlinked handle '/proc/self/fd/10'
2025-05-09T07:19:37.969849Z WARNING crash_reporter[12081]: Crash directory /run/daemon-store/crash/099ae5e8e48e8725c32d257a1d2608f46024627b already full with 32 pending reports
2025-05-09T07:19:37.970112Z ERR crash_reporter[12081]: Could not create crash directory: Out of capacity
2025-05-09T07:19:37.970142Z ERR crash_reporter[12081]: Unable to find/create process-specific crash path: Out of capacity
2025-05-09T07:20:21.477817Z NOTICE temp_logger[12176]:  STR0:-273C STR2:-273C INT3400_Thermal:20C PNIT:46C soc_dts0:43C soc_dts1:42C acpitz:0C bq27520-0:32C bq25890-charger-0:37C PL1:14.976W
2025-05-09T07:20:37.306152Z INFO vm_concierge[1812]: Received request: CreateDiskImage
2025-05-09T07:20:37.306413Z WARNING vm_concierge[1812]: Disk allocation type is unspecified (or specified as auto). Whether to create a sparse disk image will be automatically determined using the requested disk size.
2025-05-09T07:20:37.307182Z INFO vm_concierge[1812]: Found existing disk at /run/daemon-store/crosvm/099ae5e8e48e8725c32d257a1d2608f46024627b/dGVybWluYQ==.img
2025-05-09T07:20:37.312278Z INFO vm_concierge[1812]: Received request: StartVm
2025-05-09T07:20:37.312410Z INFO vm_concierge[1812]: VM with requested name is already running
2025-05-09T07:20:37.316738Z INFO vm_cicerone[1860]: Received StartLxd request
2025-05-09T07:20:37.325322Z INFO vm_cicerone[1860]: Received CreateLxdContainer request
2025-05-09T07:21:21.703988Z NOTICE temp_logger[12278]:  STR0:-273C STR2:-273C INT3400_Thermal:20C PNIT:43C soc_dts0:44C soc_dts1:42C acpitz:0C bq27520-0:32C bq25890-charger-0:37C PL1:14.976W
2025-05-09T07:21:49.296409Z ERR iptables[12305]: libminijail[12305]: can't apply initial cleaned capset
2025-05-09T07:21:49.400731Z INFO crash_reporter[12306]: developer build - not testing - always dumping
2025-05-09T07:21:49.401187Z WARNING crash_reporter[12306]: [user] Received crash notification for xtables-legacy-multi[12305] sig 6, user 284 group 284 (handling)
2025-05-09T07:21:49.402817Z INFO crash_reporter[12306]: State of crashed process [12305]: S (sleeping)
2025-05-09T07:21:49.415747Z INFO crash_reporter[12306]: Accessing crash dir '/run/daemon-store/crash/099ae5e8e48e8725c32d257a1d2608f46024627b' via symlinked handle '/proc/self/fd/10'
2025-05-09T07:21:49.416674Z WARNING crash_reporter[12306]: Crash directory /run/daemon-store/crash/099ae5e8e48e8725c32d257a1d2608f46024627b already full with 32 pending reports
2025-05-09T07:21:49.416940Z ERR crash_reporter[12306]: Could not create crash directory: Out of capacity
2025-05-09T07:21:49.416989Z ERR crash_reporter[12306]: Unable to find/create process-specific crash path: Out of capacity
2025-05-09T07:21:49.423357Z ERR patchpaneld[1386]: ERROR patchpaneld: [datapath.cc(1884)] Could not dump iptables mangle
2025-05-09T07:21:49.423405Z ERR patchpaneld[1386]: ERROR patchpaneld: [counters_service.cc(183)] Failed to query IPv4 counters
2025-05-09T07:22:21.927767Z NOTICE temp_logger[12379]:  STR0:-273C STR2:-273C INT3400_Thermal:20C PNIT:43C soc_dts0:43C soc_dts1:42C acpitz:0C bq27520-0:32C bq25890-charger-0:37C PL1:14.976W
2025-05-09T07:22:37.399620Z INFO vm_concierge[1812]: BalloonTrace:[termina,,325,11,797,88,846]
2025-05-09T07:22:44.938921Z INFO vm_concierge[1812]: Received request: CreateDiskImage
2025-05-09T07:22:44.938963Z WARNING vm_concierge[1812]: Disk allocation type is unspecified (or specified as auto). Whether to create a sparse disk image will be automatically determined using the requested disk size.
2025-05-09T07:22:44.939204Z INFO vm_concierge[1812]: Found existing disk at /run/daemon-store/crosvm/099ae5e8e48e8725c32d257a1d2608f46024627b/dGVybWluYQ==.img
2025-05-09T07:22:44.941950Z INFO vm_concierge[1812]: Received request: StartVm
2025-05-09T07:22:44.941993Z INFO vm_concierge[1812]: VM with requested name is already running
2025-05-09T07:22:44.945664Z INFO vm_cicerone[1860]: Received StartLxd request
2025-05-09T07:22:44.953843Z INFO vm_cicerone[1860]: Received CreateLxdContainer request
2025-05-09T07:23:22.154609Z NOTICE temp_logger[12545]:  STR0:-273C STR2:-273C INT3400_Thermal:20C PNIT:45C soc_dts0:45C soc_dts1:43C acpitz:0C bq27520-0:32C bq25890-charger-0:37C PL1:14.976W
2025-05-09T07:23:36.557717Z INFO vm_concierge[1812]: Received request: ListVmDisks
2025-05-09T07:23:36.606654Z INFO vm_concierge[1812]: Received request: ListVmDisks
2025-05-09T07:24:17.614612Z INFO vm_concierge[1812]: BalloonTrace:[termina,,290,-11,881,88,884]
2025-05-09T07:24:20.163162Z INFO vm_concierge[1812]: Received request: StopVm
2025-05-09T07:24:20.165603Z INFO vm_cicerone[1860]: Received NotifyVmStopping request
2025-05-09T07:24:20.832492Z ERR 9s[11887]: error while handling client cid: 32 port: 3260070572: failed to fill whole buffer
2025-05-09T07:24:20.863128Z INFO VM(32)[11888]:  [src/crosvm/sys/linux.rs:3681] vcpu requested shutdown
2025-05-09T07:24:20.875570Z ERR VM(32)[11893]:  [devices/src/virtio/gpu/mod.rs:981] unhandled virtio-gpu worker event hang-up detected: ResourceBridge { index: 0 }
2025-05-09T07:24:20.890325Z ERR VM(32)[11893]:  [devices/src/virtio/gpu/mod.rs:1918] Failed to process resource bridge: Error receiving resource bridge request: tube was disconnected
2025-05-09T07:24:20.890354Z ERR VM(32)[11893]:  [devices/src/virtio/gpu/mod.rs:1919] Removing that resource bridge from the wait context.
2025-05-09T07:24:20.938725Z WARNING VM(32)[11888]:  [vendor/chromeos/metrics/src/request_handler.rs:52] unexpected error receiving agent metrics request: tube was disconnected
2025-05-09T07:24:20.939199Z INFO VM(32)[11888]:  [metrics/src/controller.rs:55] metrics tube closed: 1 out of 1 closed
2025-05-09T07:24:20.939253Z INFO VM(32)[11888]:  [metrics/src/controller.rs:61] metrics run loop exiting: all tubes closed
2025-05-09T07:24:21.051068Z INFO VM(32)[11888]:  [src/main.rs:898] exiting with success
2025-05-09T07:24:21.057100Z INFO vm_cicerone[1860]: Received NotifyVmStopped request
2025-05-09T07:24:21.059725Z INFO vmlog_forwarder[1600]: Received VmStoppedSignal for cid 32
2025-05-09T07:24:21.088860Z ERR iptables-restore[12641]: libminijail[12641]: can't apply initial cleaned capset
2025-05-09T07:24:21.143040Z INFO crash_reporter[12642]: developer build - not testing - always dumping
2025-05-09T07:24:21.157090Z WARNING crash_reporter[12642]: [user] Received crash notification for xtables-legacy-multi[12641] sig 6, user 284 group 284 (handling)
2025-05-09T07:24:21.159206Z INFO crash_reporter[12642]: State of crashed process [12641]: S (sleeping)
2025-05-09T07:24:21.165744Z INFO crash_reporter[12642]: Accessing crash dir '/run/daemon-store/crash/099ae5e8e48e8725c32d257a1d2608f46024627b' via symlinked handle '/proc/self/fd/10'
2025-05-09T07:24:21.167300Z WARNING crash_reporter[12642]: Crash directory /run/daemon-store/crash/099ae5e8e48e8725c32d257a1d2608f46024627b already full with 32 pending reports
2025-05-09T07:24:21.167812Z ERR crash_reporter[12642]: Could not create crash directory: Out of capacity
2025-05-09T07:24:21.167998Z ERR crash_reporter[12642]: Unable to find/create process-specific crash path: Out of capacity
2025-05-09T07:24:21.175875Z ERR patchpaneld[1386]: ERROR patchpaneld: [minijailed_process_runner.cc(645)] /sbin/iptables-restore exited with -1, input: *filter#012-D FORWARD -o vmtap0 -j ACCEPT#012-D FORWARD -i vmtap0 -j ACCEPT#012COMMIT#012#012*mangle#012-D PREROUTING -i vmtap0 -j PREROUTING_vmtap0#012-F PREROUTING_vmtap0#012-X PREROUTING_vmtap0#012COMMIT#012
2025-05-09T07:24:21.181879Z ERR ip6tables-restore[12644]: libminijail[12644]: can't apply initial cleaned capset
2025-05-09T07:24:21.237464Z INFO crash_reporter[12645]: developer build - not testing - always dumping
2025-05-09T07:24:21.237822Z WARNING crash_reporter[12645]: [user] Received crash notification for xtables-legacy-multi[12644] sig 6, user 284 group 284 (handling)
2025-05-09T07:24:21.239231Z INFO crash_reporter[12645]: State of crashed process [12644]: S (sleeping)
2025-05-09T07:24:21.247584Z INFO crash_reporter[12645]: Accessing crash dir '/run/daemon-store/crash/099ae5e8e48e8725c32d257a1d2608f46024627b' via symlinked handle '/proc/self/fd/10'
2025-05-09T07:24:21.248431Z WARNING crash_reporter[12645]: Crash directory /run/daemon-store/crash/099ae5e8e48e8725c32d257a1d2608f46024627b already full with 32 pending reports
2025-05-09T07:24:21.248871Z ERR crash_reporter[12645]: Could not create crash directory: Out of capacity
2025-05-09T07:24:21.249042Z ERR crash_reporter[12645]: Unable to find/create process-specific crash path: Out of capacity
2025-05-09T07:24:21.255063Z ERR patchpaneld[1386]: ERROR patchpaneld: [minijailed_process_runner.cc(645)] /sbin/ip6tables-restore exited with -1, input: *filter#012-D FORWARD -o vmtap0 -j ACCEPT#012-D FORWARD -i vmtap0 -j ACCEPT#012COMMIT#012#012*mangle#012-D PREROUTING -i vmtap0 -j PREROUTING_vmtap0#012-F PREROUTING_vmtap0#012-X PREROUTING_vmtap0#012COMMIT#012
2025-05-09T07:24:21.283583Z INFO seneschal[1615]: Received request to stop server
2025-05-09T07:24:21.284735Z INFO seneschal[1615]: Process 2 killed by signal 15
2025-05-09T07:24:21.285071Z INFO vm_concierge[1812]: Balloon timer no longer needed. Stopping the timer.
2025-05-09T07:24:21.289517Z INFO vm_concierge[1812]: Received request: DestroyDiskImage
2025-05-09T07:24:21.292277Z ERR vm_concierge[1812]: Failed to call method: org.chromium.ShaderCache.Purge: object_path= /org/chromium/ShaderCache: org.freedesktop.DBus.Error.ServiceUnknown: The name org.chromium.ShaderCache was not provided by any .service files
2025-05-09T07:24:21.316648Z INFO dlcservice[1348]: INFO dlcservice: [dlc_base.cc(1065)] Disabling DLC=termina-dlc reserve.
2025-05-09T07:24:21.317116Z INFO dbus-daemon[644]: [system] Activating service name='org.chromium.ImageLoader' requested by ':1.69' (uid=20118 pid=1348 comm="/usr/sbin/dlcservice " label="u:r:cros_dlcservice:s0") (using servicehelper)
2025-05-09T07:24:21.388105Z WARNING imageloader[12651]: Could not read key file /usr/share/misc/oci-container-key-pub.der
2025-05-09T07:24:21.401930Z INFO dbus-daemon[644]: [system] Successfully activated service 'org.chromium.ImageLoader'
2025-05-09T07:24:21.456621Z ERR imageloader[12657]: dm_task_run failed!
2025-05-09T07:24:21.456667Z ERR imageloader[12657]: Device mapper wipe table failed, still continuing to remove the device mapper: Invalid argument (22)
2025-05-09T07:24:21.457398Z ERR kernel: [ 3488.897943] device-mapper: table: 252:4: verity: Device must be readonly (-EINVAL)
2025-05-09T07:24:21.457463Z ERR kernel: [ 3488.897954] device-mapper: ioctl: error adding target to table
2025-05-09T07:24:21.477131Z WARNING imageloader[12657]: ioctl LOOP_CTL_REMOVE failed: Device or resource busy (16)
2025-05-09T07:24:21.478288Z INFO dlcservice[1348]: INFO dlcservice: [dlc_base.cc(1042)] Changing DLC=termina-dlc state to NOT_INSTALLED
2025-05-09T07:24:21.478844Z INFO dlcservice[1348]: INFO dlcservice: [dlc_base.cc(998)] Setting active value for DLC=termina-dlc to false
2025-05-09T07:24:21.502803Z INFO dlcservice[1348]: INFO dlcservice: [dlc_base.cc(935)] Deleted path=/var/cache/dlc/termina-dlc
2025-05-09T07:24:21.505111Z INFO dlcservice[1348]: INFO dlcservice: [dlc_base.cc(935)] Deleted path=/var/lib/dlcservice/dlc/termina-dlc
2025-05-09T07:24:21.508369Z INFO dlcservice[1348]: INFO dlcservice: [dlc_base.cc(1009)] Successfully set active value for DLC=termina-dlc
2025-05-09T07:24:22.415380Z NOTICE temp_logger[12712]:  STR0:-273C STR2:-273C INT3400_Thermal:20C PNIT:51C soc_dts0:48C soc_dts1:51C acpitz:0C bq27520-0:33C bq25890-charger-0:37C PL1:14.976W
2025-05-09T07:24:41.484041Z INFO imageloader[12657]: parent socket has shutdown.
2025-05-09T07:24:44.445482Z INFO dlcservice[1348]: INFO dlcservice: [dlc_base.cc(1065)] Disabling DLC=termina-dlc reserve.
2025-05-09T07:24:45.665349Z INFO dlcservice[1348]: INFO dlcservice: [dlc_base.cc(1042)] Changing DLC=termina-dlc state to INSTALLING
2025-05-09T07:24:54.907584Z INFO dlcservice[1348]: INFO dlcservice: [dlc_base.cc(665)] Factory installing DLC=termina-dlc
2025-05-09T07:24:54.909110Z INFO dbus-daemon[644]: [system] Activating service name='org.chromium.ImageLoader' requested by ':1.69' (uid=20118 pid=1348 comm="/usr/sbin/dlcservice " label="u:r:cros_dlcservice:s0") (using servicehelper)
2025-05-09T07:24:54.970430Z WARNING imageloader[12758]: Could not read key file /usr/share/misc/oci-container-key-pub.der
2025-05-09T07:24:54.981539Z INFO dbus-daemon[644]: [system] Successfully activated service 'org.chromium.ImageLoader'
2025-05-09T07:24:55.013328Z INFO kernel: [ 3522.453829] sdz: detected capacity change from 0 to 409600
2025-05-09T07:24:57.179339Z INFO kernel: [ 3524.620270] device-mapper: verity: sha256 using ahash "sha256-ssse3"
2025-05-09T07:24:57.457346Z WARNING dlcservice[1348]: WARNING dlcservice: [bus.cc(653)] Bus::SendWithReplyAndBlock took 2549ms to process message: type=method_call, path=/org/chromium/ImageLoader, interface=org.chromium.ImageLoaderInterface, member=LoadDlc
2025-05-09T07:24:57.457507Z INFO dlcservice[1348]: INFO dlcservice: [dlc_base.cc(1042)] Changing DLC=termina-dlc state to INSTALLED
2025-05-09T07:24:57.457629Z INFO dlcservice[1348]: INFO dlcservice: [dlc_base.cc(998)] Setting active value for DLC=termina-dlc to true
2025-05-09T07:24:57.458323Z INFO dlcservice[1348]: INFO dlcservice: [metrics.cc(69)] InstallResult metric sent:2
2025-05-09T07:24:57.463404Z INFO dlcservice[1348]: INFO dlcservice: [dlc_base.cc(1009)] Successfully set active value for DLC=termina-dlc
2025-05-09T07:24:57.468564Z INFO vm_concierge[1812]: Received request: CreateDiskImage
2025-05-09T07:24:57.468616Z WARNING vm_concierge[1812]: Disk allocation type is unspecified (or specified as auto). Whether to create a sparse disk image will be automatically determined using the requested disk size.
2025-05-09T07:24:57.468908Z WARNING vm_concierge[1812]: Failed to set directory permissions for /run/daemon-store/pvm/099ae5e8e48e8725c32d257a1d2608f46024627b
2025-05-09T07:24:57.469030Z INFO vm_concierge[1812]: Creating raw disk at: /run/daemon-store/crosvm/099ae5e8e48e8725c32d257a1d2608f46024627b/dGVybWluYQ==.img size 2147483648
2025-05-09T07:24:57.471257Z INFO vm_concierge[1812]: Creating user-chosen-size raw disk image
2025-05-09T07:24:57.471733Z INFO vm_concierge[1812]: Preallocating user-chosen-size raw disk image
2025-05-09T07:24:57.512381Z INFO vm_concierge[1812]: Disk image preallocated
2025-05-09T07:24:57.512680Z INFO vm_concierge[1812]: Received request: ListVmDisks
2025-05-09T07:24:57.516586Z INFO vm_concierge[1812]: Received request: StartVm
2025-05-09T07:24:57.525315Z ERR vm_concierge[1812]: Failed to call method: org.chromium.ChromeFeaturesServiceInterface.IsFeatureEnabled: object_path= /org/chromium/ChromeFeaturesService: org.freedesktop.DBus.Error.InvalidArgs: Chrome can't get state for 'CrOSLateBootVmPerBootShaderCache'; feature_library will decide
2025-05-09T07:24:57.530323Z WARNING vm_concierge[1812]: Failed to set directory permissions for 
2025-05-09T07:24:57.535568Z INFO kernel: [ 3524.975990] udevd[12769]: Using default interface naming scheme 'v249'.
2025-05-09T07:24:57.542361Z ERR iptables-restore[12778]: libminijail[12778]: can't apply initial cleaned capset
2025-05-09T07:24:57.592098Z INFO crash_reporter[12780]: developer build - not testing - always dumping
2025-05-09T07:24:57.592545Z WARNING crash_reporter[12780]: [user] Received crash notification for xtables-legacy-multi[12778] sig 6, user 284 group 284 (handling)
2025-05-09T07:24:57.594305Z INFO crash_reporter[12780]: State of crashed process [12778]: S (sleeping)
2025-05-09T07:24:57.600753Z INFO crash_reporter[12780]: Accessing crash dir '/run/daemon-store/crash/099ae5e8e48e8725c32d257a1d2608f46024627b' via symlinked handle '/proc/self/fd/10'
2025-05-09T07:24:57.601912Z WARNING crash_reporter[12780]: Crash directory /run/daemon-store/crash/099ae5e8e48e8725c32d257a1d2608f46024627b already full with 32 pending reports
2025-05-09T07:24:57.602168Z ERR crash_reporter[12780]: Could not create crash directory: Out of capacity
2025-05-09T07:24:57.602198Z ERR crash_reporter[12780]: Unable to find/create process-specific crash path: Out of capacity
2025-05-09T07:24:57.607676Z ERR patchpaneld[1386]: ERROR patchpaneld: [minijailed_process_runner.cc(645)] /sbin/iptables-restore exited with -1, input: *filter#012-A FORWARD -o vmtap0 -j ACCEPT#012-A FORWARD -i vmtap0 -j ACCEPT#012COMMIT#012#012*mangle#012:PREROUTING_vmtap0 - [0:0]#012-F PREROUTING_vmtap0#012-A PREROUTING -i vmtap0 -j PREROUTING_vmtap0#012-A PREROUTING_vmtap0 -j MARK --set-mark 0x00000001/0x00000001#012-A PREROUTING_vmtap0 -j MARK --set-mark 0x00002100/0x00003f00#012-A PREROUTING_vmtap0 -j CONNMARK --restore-mark --mask 0xffff0000#012-A PREROUTING_vmtap0 -j skip_apply_vpn_mark#012-A PREROUTING_vmtap0 -j apply_vpn_mark#012COMMIT#012
2025-05-09T07:24:57.613726Z ERR ip6tables-restore[12783]: libminijail[12783]: can't apply initial cleaned capset
2025-05-09T07:24:57.667492Z INFO crash_reporter[12784]: developer build - not testing - always dumping
2025-05-09T07:24:57.667852Z WARNING crash_reporter[12784]: [user] Received crash notification for xtables-legacy-multi[12783] sig 6, user 284 group 284 (handling)
2025-05-09T07:24:57.669718Z INFO crash_reporter[12784]: State of crashed process [12783]: S (sleeping)
2025-05-09T07:24:57.676653Z INFO crash_reporter[12784]: Accessing crash dir '/run/daemon-store/crash/099ae5e8e48e8725c32d257a1d2608f46024627b' via symlinked handle '/proc/self/fd/10'
2025-05-09T07:24:57.678702Z WARNING crash_reporter[12784]: Crash directory /run/daemon-store/crash/099ae5e8e48e8725c32d257a1d2608f46024627b already full with 32 pending reports
2025-05-09T07:24:57.678968Z ERR crash_reporter[12784]: Could not create crash directory: Out of capacity
2025-05-09T07:24:57.678998Z ERR crash_reporter[12784]: Unable to find/create process-specific crash path: Out of capacity
2025-05-09T07:24:57.684418Z ERR patchpaneld[1386]: ERROR patchpaneld: [minijailed_process_runner.cc(645)] /sbin/ip6tables-restore exited with -1, input: *filter#012-A FORWARD -o vmtap0 -j ACCEPT#012-A FORWARD -i vmtap0 -j ACCEPT#012COMMIT#012#012*mangle#012:PREROUTING_vmtap0 - [0:0]#012-F PREROUTING_vmtap0#012-A PREROUTING -i vmtap0 -j PREROUTING_vmtap0#012-A PREROUTING_vmtap0 -j MARK --set-mark 0x00002100/0x00003f00#012-A PREROUTING_vmtap0 -j CONNMARK --restore-mark --mask 0xffff0000#012-A PREROUTING_vmtap0 -j skip_apply_vpn_mark#012-A PREROUTING_vmtap0 -j apply_vpn_mark#012COMMIT#012
2025-05-09T07:24:57.685983Z INFO kernel: [ 3525.126522] vmtap0: entered allmulticast mode
2025-05-09T07:24:57.698381Z INFO seneschal[1615]: Received request to start new 9p server
2025-05-09T07:24:57.702425Z INFO seneschal[1615]: Started server on /run/seneschal/scoped_dirZQeVOz
2025-05-09T07:24:57.705567Z INFO vmlog_forwarder[1600]: Received VmStartingUpSignal for 099ae5e8e48e8725c32d257a1d2608f46024627b/termina, cid 33, type TERMINA
2025-05-09T07:24:57.705948Z INFO vmlog_forwarder[1600]: Creating HostCollector watching /run/daemon-store/crosvm/099ae5e8e48e8725c32d257a1d2608f46024627b/log/dGVybWluYQ==.lsock
2025-05-09T07:24:57.708126Z INFO vmlog_forwarder[1600]: Bound socket fd 18 at /run/daemon-store/crosvm/099ae5e8e48e8725c32d257a1d2608f46024627b/log/dGVybWluYQ==.lsock
2025-05-09T07:24:57.710681Z INFO vm_concierge[1812]: Invoking VM: /usr/bin/crosvm --syslog-tag VM(33) run --cpus 4 --mem 1425 --net packed-queue=true,tap-fd=34 --cid 33 --socket /run/vm/vm.9iicLv/crosvm.sock --wayland-sock /tmp/.org.chromium.Chromium.U6RtMk/wayland-0 --serial hardware=serial,earlycon=true,num=1,type=unix,path=/run/daemon-store/crosvm/099ae5e8e48e8725c32d257a1d2608f46024627b/log/dGVybWluYQ==.lsock --serial hardware=virtio-console,console=true,num=1,type=unix,path=/run/daemon-store/crosvm/099ae5e8e48e8725c32d257a1d2608f46024627b/log/dGVybWluYQ==.lsock --serial hardware=debugcon,type=unix,path=/run/daemon-store/crosvm/099ae5e8e48e8725c32d257a1d2608f46024627b/log/dGVybWluYQ==.lsock --no-smt --params printk.devkmsg=on --pmem-device /proc/self/fd/28 --params root=/dev/pmem0 ro --virtio-snd backend=cras,socket_type=unified --block /proc/self/fd/29,ro=true --block /proc/self/fd/31,ro=false,sparse=false --gpu vulkan=false,context-types=:virgl:virgl2,cache-path=/run/daemon-store/crosvm/099ae5e8e48e8725c32d257a1d2608f46024627b/gpucache/DbMqFCrA283TC1JjpPRwZA/dGVybWluYQ/device,cache-size=50M,fixed-blob-mapping=true --battery type=goldfish --shared-dir /usr/share/fonts:fonts:type=fs:cache=always:uidmap=0 655360 5000,5000 600 50,5050 660410 1994950:gidmap=0 655360 1065,1065 20119 1,1066 656426 3934,5000 600 50,5050 660410 1994950:timeout=3600:rewrite-security-xattrs=true:writeback=true:negative_timeout=3600 --vcpu-cgroup-path /sys/fs/cgroup/cpu/termina-vcpus --cpu-cluster 0,1,2,3 /proc/self/fd/27 
2025-05-09T07:24:57.790853Z INFO VM(33)[12788]:  [src/crosvm/sys/linux.rs:1677] crosvm entering multiprocess mode
2025-05-09T07:24:57.792368Z INFO VM(33)[12788]:  [src/crosvm/sys/linux/device_helpers.rs:1215] Bind mounting dir /run/daemon-store/crosvm/099ae5e8e48e8725c32d257a1d2608f46024627b/log
2025-05-09T07:24:57.792553Z INFO VM(33)[12788]:  [src/crosvm/sys/linux/device_helpers.rs:253] Trying to attach block device: /proc/self/fd/29
2025-05-09T07:24:57.792624Z INFO VM(33)[12788]:  [disk/src/disk.rs:213] disk size 78057472, 
2025-05-09T07:24:57.792657Z INFO VM(33)[12788]:  [disk/src/disk.rs:203] Disk image file is hosted on file system type 73717368
2025-05-09T07:24:57.810330Z INFO VM(33)[12788]:  [src/crosvm/sys/linux/device_helpers.rs:253] Trying to attach block device: /proc/self/fd/31
2025-05-09T07:24:57.810391Z INFO VM(33)[12788]:  [disk/src/disk.rs:213] disk size 2147483648, 
2025-05-09T07:24:57.810422Z INFO VM(33)[12788]:  [disk/src/disk.rs:203] Disk image file is hosted on file system type ef53
2025-05-09T07:24:58.222825Z INFO VM(33)[12788]:  [devices/src/sys/linux/acpi.rs:26] Listening on acpi_mc_group of acpi_event family
2025-05-09T07:25:04.038336Z INFO VM(33)[12812]:  [devices/src/usb/xhci/device_slot.rs:173] xhci: stopping all device slots and resetting host hub
2025-05-09T07:25:08.051436Z INFO vm_concierge[1812]: Configuring network for VM 33
2025-05-09T07:25:08.074552Z INFO vm_concierge[1812]: Setting resolv config for VM 33
2025-05-09T07:25:08.119473Z INFO vm_concierge[1812]: Mounting 9P file system from port 16385 on /mnt/shared
2025-05-09T07:25:08.123511Z INFO 9s[12787]: accepted connection from cid: 33 port: 136364191
2025-05-09T07:25:08.134930Z INFO vm_cicerone[1860]: Received NotifyVmStarted request
2025-05-09T07:25:08.136050Z INFO vm_concierge[1812]: Starting Termina-specific services
2025-05-09T07:25:09.228301Z WARNING vm_cicerone[1860]: Could not load the device policy file.
2025-05-09T07:25:09.681119Z INFO vm_concierge[1812]: Started VM with pid 74
2025-05-09T07:25:09.681472Z INFO vm_concierge[1812]: New VM. Starting balloon resize timer.
2025-05-09T07:25:10.697361Z INFO vm_concierge[1812]: BalloonTrace throttled with size window: 100 MIB
2025-05-09T07:25:10.697513Z INFO vm_concierge[1812]: BalloonInit: { "type": "BalanceAvailableBalloonPolicy","vm": "termina","critical_margin": 299285504,"bias": 0 }
2025-05-09T07:25:10.697606Z INFO vm_concierge[1812]: BalloonTrace Format [vm_name, game_mode, balloon_size_MIB, balloon_delta_MIB, host_available_MIB, guest_cached_MIB, guest_free_MIB]
2025-05-09T07:25:10.700260Z INFO vm_concierge[1812]: BalloonTrace:[termina,,0,113,955,42,1254]
2025-05-09T07:25:10.797142Z ERR vm_cicerone[1860]: Tremplin channel not connected after 5 seconds.
2025-05-09T07:25:10.798921Z INFO vm_concierge[1812]: Received request: OnTremplinStartedSignal for 099ae5e8e48e8725c32d257a1d2608f46024627b/termina
2025-05-09T07:25:10.801733Z INFO vm_cicerone[1860]: Received StartLxd request
2025-05-09T07:25:10.801738Z INFO seneschal[1615]: Received request to share path with server
2025-05-09T07:25:11.697310Z INFO vm_concierge[1812]: BalloonTrace:[termina,,113,66,928,55,1120]
2025-05-09T07:25:13.722401Z INFO vm_concierge[1812]: BalloonTrace:[termina,,216,18,910,78,983]
2025-05-09T07:25:17.473357Z INFO imageloader[12764]: parent socket has shutdown.
2025-05-09T07:25:18.890894Z INFO vm_cicerone[1860]: Received CreateLxdContainer request

这个配置就不要想Linux子系统了,我surface go2用Linux子系统都很吃力

我需要测试功能,毕竟有x7-z8700 16G内存 256存储的魔改版本存在

2025-05-09T07:23:36.557717Z INFO vm_concierge[1812]: Received request: ListVmDisks
2025-05-09T07:23:36.606654Z INFO vm_concierge[1812]: Received request: ListVmDisks
2025-05-09T07:24:17.614612Z INFO vm_concierge[1812]: BalloonTrace:[termina,,290,-11,881,88,884]
2025-05-09T07:24:20.163162Z INFO vm_concierge[1812]: Received request: StopVm
2025-05-09T07:24:20.165603Z INFO vm_cicerone[1860]: Received NotifyVmStopping request
2025-05-09T07:24:20.832492Z ERR 9s[11887]: error while handling client cid: 32 port: 3260070572: failed to fill whole buffer
2025-05-09T07:24:20.863128Z INFO VM(32)[11888]:  [src/crosvm/sys/linux.rs:3681] vcpu requested shutdown
2025-05-09T07:24:20.875570Z ERR VM(32)[11893]:  [devices/src/virtio/gpu/mod.rs:981] unhandled virtio-gpu worker event hang-up detected: ResourceBridge { index: 0 }

是缺失内核模块virtio-gpu吗?

你得看下代码里这个 “Received request: StopVm” 是什么原因

这是现在版本的日志,内核补上cgroup相关模块。
xtables-legacy-multi老是崩溃

2025-05-10T01:15:36.618568Z ERR iptables-restore[7284]: libminijail[7284]: can't apply initial cleaned capset
2025-05-10T01:15:36.672772Z WARNING crash_reporter[7286]: [user] Received crash notification for xtables-legacy-multi[7284] sig 6, user 284 group 284 (handling)
2025-05-10T01:15:36.674388Z INFO crash_reporter[7286]: State of crashed process [7284]: S (sleeping)
2025-05-10T01:15:36.687900Z ERR patchpaneld[1369]: ERROR patchpaneld: [minijailed_process_runner.cc(645)] /sbin/iptables-restore exited with -1, input: *filter#012-A FORWARD -o vmtap0 -j ACCEPT#012-A FORWARD -i vmtap0 -j ACCEPT#012COMMIT#012#012*mangle#012:PREROUTING_vmtap0 - [0:0]#012-F PREROUTING_vmtap0#012-A PREROUTING -i vmtap0 -j PREROUTING_vmtap0#012-A PREROUTING_vmtap0 -j MARK --set-mark 0x00000001/0x00000001#012-A PREROUTING_vmtap0 -j MARK --set-mark 0x00002100/0x00003f00#012-A PREROUTING_vmtap0 -j CONNMARK --restore-mark --mask 0xffff0000#012-A PREROUTING_vmtap0 -j skip_apply_vpn_mark#012-A PREROUTING_vmtap0 -j apply_vpn_mark#012COMMIT#012
2025-05-10T01:15:36.693234Z ERR ip6tables-restore[7293]: libminijail[7293]: can't apply initial cleaned capset
2025-05-10T01:15:36.755015Z INFO crash_reporter[7294]: developer build - not testing - always dumping
2025-05-10T01:15:36.755349Z WARNING crash_reporter[7294]: [user] Received crash notification for xtables-legacy-multi[7293] sig 6, user 284 group 284 (handling)
2025-05-10T01:15:36.756998Z INFO crash_reporter[7294]: State of crashed process [7293]: S (sleeping)

完整日志:

2025-05-10T01:15:08.974380Z INFO dlcservice[1372]: INFO dlcservice: [dlc_base.cc(1065)] Disabling DLC=termina-dlc reserve.
2025-05-10T01:15:08.974461Z WARNING dlcservice[1372]: WARNING dlcservice: [dlc_base.cc(969)] Trying to uninstall not installed DLC=termina-dlc
2025-05-10T01:15:08.975522Z INFO dbus-daemon[643]: [system] Activating service name='org.chromium.ImageLoader' requested by ':1.71' (uid=20118 pid=1372 comm="/usr/sbin/dlcservice " label="u:r:cros_dlcservice:s0") (using servicehelper)
2025-05-10T01:15:09.038115Z WARNING imageloader[7209]: Could not read key file /usr/share/misc/oci-container-key-pub.der
2025-05-10T01:15:09.048391Z INFO dbus-daemon[643]: [system] Successfully activated service 'org.chromium.ImageLoader'
2025-05-10T01:15:09.081095Z INFO dlcservice[1372]: INFO dlcservice: [dlc_base.cc(1042)] Changing DLC=termina-dlc state to NOT_INSTALLED
2025-05-10T01:15:09.081197Z INFO dlcservice[1372]: INFO dlcservice: [dlc_base.cc(998)] Setting active value for DLC=termina-dlc to false
2025-05-10T01:15:09.109760Z INFO dlcservice[1372]: INFO dlcservice: [dlc_base.cc(935)] Deleted path=/var/cache/dlc/termina-dlc
2025-05-10T01:15:09.110555Z INFO dlcservice[1372]: INFO dlcservice: [dlc_base.cc(935)] Deleted path=/var/lib/dlcservice/dlc/termina-dlc
2025-05-10T01:15:09.115768Z INFO dlcservice[1372]: INFO dlcservice: [dlc_base.cc(1009)] Successfully set active value for DLC=termina-dlc
2025-05-10T01:15:21.242400Z INFO dlcservice[1372]: INFO dlcservice: [dlc_base.cc(1065)] Disabling DLC=termina-dlc reserve.
2025-05-10T01:15:28.289104Z INFO dlcservice[1372]: INFO dlcservice: [dlc_base.cc(1042)] Changing DLC=termina-dlc state to INSTALLING
2025-05-10T01:15:29.083480Z INFO imageloader[7215]: parent socket has shutdown.
2025-05-10T01:15:34.904793Z INFO dlcservice[1372]: INFO dlcservice: [dlc_base.cc(665)] Factory installing DLC=termina-dlc
2025-05-10T01:15:34.906813Z INFO dbus-daemon[643]: [system] Activating service name='org.chromium.ImageLoader' requested by ':1.71' (uid=20118 pid=1372 comm="/usr/sbin/dlcservice " label="u:r:cros_dlcservice:s0") (using servicehelper)
2025-05-10T01:15:34.993125Z WARNING imageloader[7260]: Could not read key file /usr/share/misc/oci-container-key-pub.der
2025-05-10T01:15:35.004961Z INFO dbus-daemon[643]: [system] Successfully activated service 'org.chromium.ImageLoader'
2025-05-10T01:15:35.036183Z INFO kernel: [  614.263925] sdz: detected capacity change from 0 to 409600
2025-05-10T01:15:36.252644Z INFO kernel: [  615.480967] device-mapper: verity: sha256 using ahash "sha256-ssse3"
2025-05-10T01:15:36.491611Z WARNING dlcservice[1372]: WARNING dlcservice: [bus.cc(653)] Bus::SendWithReplyAndBlock took 1586ms to process message: type=method_call, path=/org/chromium/ImageLoader, interface=org.chromium.ImageLoaderInterface, member=LoadDlc
2025-05-10T01:15:36.491734Z INFO dlcservice[1372]: INFO dlcservice: [dlc_base.cc(1042)] Changing DLC=termina-dlc state to INSTALLED
2025-05-10T01:15:36.491786Z INFO dlcservice[1372]: INFO dlcservice: [dlc_base.cc(998)] Setting active value for DLC=termina-dlc to true
2025-05-10T01:15:36.492113Z INFO dlcservice[1372]: INFO dlcservice: [metrics.cc(69)] InstallResult metric sent:2
2025-05-10T01:15:36.498653Z INFO dlcservice[1372]: INFO dlcservice: [dlc_base.cc(1009)] Successfully set active value for DLC=termina-dlc
2025-05-10T01:15:36.503665Z INFO vm_concierge[1824]: Received request: CreateDiskImage
2025-05-10T01:15:36.503802Z WARNING vm_concierge[1824]: Disk allocation type is unspecified (or specified as auto). Whether to create a sparse disk image will be automatically determined using the requested disk size.
2025-05-10T01:15:36.504205Z WARNING vm_concierge[1824]: Failed to set directory permissions for /run/daemon-store/pvm/099ae5e8e48e8725c32d257a1d2608f46024627b
2025-05-10T01:15:36.505483Z INFO vm_concierge[1824]: Creating raw disk at: /run/daemon-store/crosvm/099ae5e8e48e8725c32d257a1d2608f46024627b/dGVybWluYQ==.img size 2147483648
2025-05-10T01:15:36.507913Z INFO vm_concierge[1824]: Creating user-chosen-size raw disk image
2025-05-10T01:15:36.508417Z INFO vm_concierge[1824]: Preallocating user-chosen-size raw disk image
2025-05-10T01:15:36.551117Z INFO vm_concierge[1824]: Disk image preallocated
2025-05-10T01:15:36.551762Z INFO vm_concierge[1824]: Received request: ListVmDisks
2025-05-10T01:15:36.554643Z INFO vm_concierge[1824]: Received request: ListVmDisks
2025-05-10T01:15:36.556407Z INFO vm_concierge[1824]: Received request: StartVm
2025-05-10T01:15:36.564989Z ERR vm_concierge[1824]: Failed to call method: org.chromium.ChromeFeaturesServiceInterface.IsFeatureEnabled: object_path= /org/chromium/ChromeFeaturesService: org.freedesktop.DBus.Error.InvalidArgs: Chrome can't get state for 'CrOSLateBootVmPerBootShaderCache'; feature_library will decide
2025-05-10T01:15:36.572350Z WARNING vm_concierge[1824]: Failed to set directory permissions for 
2025-05-10T01:15:36.606669Z INFO kernel: [  615.833989] tun: Universal TUN/TAP device driver, 1.6
2025-05-10T01:15:36.613653Z INFO kernel: [  615.841729] udevd[7281]: Using default interface naming scheme 'v249'.
2025-05-10T01:15:36.618568Z ERR iptables-restore[7284]: libminijail[7284]: can't apply initial cleaned capset
2025-05-10T01:15:36.671235Z INFO crash_reporter[7286]: developer build - not testing - always dumping
2025-05-10T01:15:36.672772Z WARNING crash_reporter[7286]: [user] Received crash notification for xtables-legacy-multi[7284] sig 6, user 284 group 284 (handling)
2025-05-10T01:15:36.674388Z INFO crash_reporter[7286]: State of crashed process [7284]: S (sleeping)
2025-05-10T01:15:36.680518Z INFO crash_reporter[7286]: Accessing crash dir '/run/daemon-store/crash/099ae5e8e48e8725c32d257a1d2608f46024627b' via symlinked handle '/proc/self/fd/10'
2025-05-10T01:15:36.681284Z WARNING crash_reporter[7286]: Crash directory /run/daemon-store/crash/099ae5e8e48e8725c32d257a1d2608f46024627b already full with 32 pending reports
2025-05-10T01:15:36.681541Z ERR crash_reporter[7286]: Could not create crash directory: Out of capacity
2025-05-10T01:15:36.681568Z ERR crash_reporter[7286]: Unable to find/create process-specific crash path: Out of capacity
2025-05-10T01:15:36.687900Z ERR patchpaneld[1369]: ERROR patchpaneld: [minijailed_process_runner.cc(645)] /sbin/iptables-restore exited with -1, input: *filter#012-A FORWARD -o vmtap0 -j ACCEPT#012-A FORWARD -i vmtap0 -j ACCEPT#012COMMIT#012#012*mangle#012:PREROUTING_vmtap0 - [0:0]#012-F PREROUTING_vmtap0#012-A PREROUTING -i vmtap0 -j PREROUTING_vmtap0#012-A PREROUTING_vmtap0 -j MARK --set-mark 0x00000001/0x00000001#012-A PREROUTING_vmtap0 -j MARK --set-mark 0x00002100/0x00003f00#012-A PREROUTING_vmtap0 -j CONNMARK --restore-mark --mask 0xffff0000#012-A PREROUTING_vmtap0 -j skip_apply_vpn_mark#012-A PREROUTING_vmtap0 -j apply_vpn_mark#012COMMIT#012
2025-05-10T01:15:36.693234Z ERR ip6tables-restore[7293]: libminijail[7293]: can't apply initial cleaned capset
2025-05-10T01:15:36.755015Z INFO crash_reporter[7294]: developer build - not testing - always dumping
2025-05-10T01:15:36.755349Z WARNING crash_reporter[7294]: [user] Received crash notification for xtables-legacy-multi[7293] sig 6, user 284 group 284 (handling)
2025-05-10T01:15:36.756998Z INFO crash_reporter[7294]: State of crashed process [7293]: S (sleeping)
2025-05-10T01:15:36.764755Z INFO crash_reporter[7294]: Accessing crash dir '/run/daemon-store/crash/099ae5e8e48e8725c32d257a1d2608f46024627b' via symlinked handle '/proc/self/fd/10'
2025-05-10T01:15:36.765513Z WARNING crash_reporter[7294]: Crash directory /run/daemon-store/crash/099ae5e8e48e8725c32d257a1d2608f46024627b already full with 32 pending reports
2025-05-10T01:15:36.765815Z ERR crash_reporter[7294]: Could not create crash directory: Out of capacity
2025-05-10T01:15:36.765886Z ERR crash_reporter[7294]: Unable to find/create process-specific crash path: Out of capacity
2025-05-10T01:15:36.772170Z ERR patchpaneld[1369]: ERROR patchpaneld: [minijailed_process_runner.cc(645)] /sbin/ip6tables-restore exited with -1, input: *filter#012-A FORWARD -o vmtap0 -j ACCEPT#012-A FORWARD -i vmtap0 -j ACCEPT#012COMMIT#012#012*mangle#012:PREROUTING_vmtap0 - [0:0]#012-F PREROUTING_vmtap0#012-A PREROUTING -i vmtap0 -j PREROUTING_vmtap0#012-A PREROUTING_vmtap0 -j MARK --set-mark 0x00002100/0x00003f00#012-A PREROUTING_vmtap0 -j CONNMARK --restore-mark --mask 0xffff0000#012-A PREROUTING_vmtap0 -j skip_apply_vpn_mark#012-A PREROUTING_vmtap0 -j apply_vpn_mark#012COMMIT#012
2025-05-10T01:15:36.773659Z INFO kernel: [  616.002104] brcmfmac 0000:01:00.0 wlan0: entered allmulticast mode
2025-05-10T01:15:36.773710Z INFO kernel: [  616.002225] vmtap0: entered allmulticast mode
2025-05-10T01:15:36.797425Z INFO seneschal[1637]: Received request to start new 9p server
2025-05-10T01:15:36.804433Z INFO seneschal[1637]: Started server on /run/seneschal/scoped_dirN04E42
2025-05-10T01:15:36.812060Z INFO vmlog_forwarder[1586]: Received VmStartingUpSignal for 099ae5e8e48e8725c32d257a1d2608f46024627b/termina, cid 32, type TERMINA
2025-05-10T01:15:36.813102Z INFO vmlog_forwarder[1586]: Creating HostCollector watching /run/daemon-store/crosvm/099ae5e8e48e8725c32d257a1d2608f46024627b/log/dGVybWluYQ==.lsock
2025-05-10T01:15:36.820529Z INFO vmlog_forwarder[1586]: Bound socket fd 18 at /run/daemon-store/crosvm/099ae5e8e48e8725c32d257a1d2608f46024627b/log/dGVybWluYQ==.lsock
2025-05-10T01:15:36.823911Z INFO vm_concierge[1824]: Invoking VM: /usr/bin/crosvm --syslog-tag VM(32) run --cpus 4 --mem 1425 --net packed-queue=true,tap-fd=34 --cid 32 --socket /run/vm/vm.ZiPq7r/crosvm.sock --wayland-sock /tmp/.org.chromium.Chromium.uK8QQ7/wayland-0 --serial hardware=serial,earlycon=true,num=1,type=unix,path=/run/daemon-store/crosvm/099ae5e8e48e8725c32d257a1d2608f46024627b/log/dGVybWluYQ==.lsock --serial hardware=virtio-console,console=true,num=1,type=unix,path=/run/daemon-store/crosvm/099ae5e8e48e8725c32d257a1d2608f46024627b/log/dGVybWluYQ==.lsock --serial hardware=debugcon,type=unix,path=/run/daemon-store/crosvm/099ae5e8e48e8725c32d257a1d2608f46024627b/log/dGVybWluYQ==.lsock --no-smt --params printk.devkmsg=on --pmem-device /proc/self/fd/28 --params root=/dev/pmem0 ro --virtio-snd backend=cras,socket_type=unified --block /proc/self/fd/29,ro=true --block /proc/self/fd/31,ro=false,sparse=false --gpu vulkan=false,context-types=:virgl:virgl2,cache-path=/run/daemon-store/crosvm/099ae5e8e48e8725c32d257a1d2608f46024627b/gpucache/DbMqFCrA283TC1JjpPRwZA/dGVybWluYQ/device,cache-size=50M,fixed-blob-mapping=true --battery type=goldfish --shared-dir /usr/share/fonts:fonts:type=fs:cache=always:uidmap=0 655360 5000,5000 600 50,5050 660410 1994950:gidmap=0 655360 1065,1065 20119 1,1066 656426 3934,5000 600 50,5050 660410 1994950:timeout=3600:rewrite-security-xattrs=true:writeback=true:negative_timeout=3600 --vcpu-cgroup-path /sys/fs/cgroup/cpu/termina-vcpus --cpu-cluster 0,1,2,3 /proc/self/fd/27 
2025-05-10T01:15:37.061070Z INFO VM(32)[7298]:  [src/crosvm/sys/linux.rs:1677] crosvm entering multiprocess mode
2025-05-10T01:15:37.072513Z INFO VM(32)[7298]:  [src/crosvm/sys/linux/device_helpers.rs:1215] Bind mounting dir /run/daemon-store/crosvm/099ae5e8e48e8725c32d257a1d2608f46024627b/log
2025-05-10T01:15:37.072994Z INFO VM(32)[7298]:  [src/crosvm/sys/linux/device_helpers.rs:253] Trying to attach block device: /proc/self/fd/29
2025-05-10T01:15:37.076364Z INFO VM(32)[7298]:  [disk/src/disk.rs:213] disk size 78057472, 
2025-05-10T01:15:37.076457Z INFO VM(32)[7298]:  [disk/src/disk.rs:203] Disk image file is hosted on file system type 73717368
2025-05-10T01:15:37.079146Z INFO VM(32)[7298]:  [src/crosvm/sys/linux/device_helpers.rs:253] Trying to attach block device: /proc/self/fd/31
2025-05-10T01:15:37.079303Z INFO VM(32)[7298]:  [disk/src/disk.rs:213] disk size 2147483648, 
2025-05-10T01:15:37.079385Z INFO VM(32)[7298]:  [disk/src/disk.rs:203] Disk image file is hosted on file system type ef53
2025-05-10T01:15:37.602649Z INFO VM(32)[7298]:  [devices/src/sys/linux/acpi.rs:26] Listening on acpi_mc_group of acpi_event family
2025-05-10T01:15:43.258945Z WARNING cras_server[1358]: pcm_avail returned frames larger than buf_size: cht-bsw-rt5659: :0,0: 205152 > 204768
2025-05-10T01:15:43.259482Z INFO cras_server[1358]: AudioFRA:11 context:{"type":"underrun"}
2025-05-10T01:15:43.607610Z NOTICE temp_logger[7430]:  STR0:-273C STR2:-273C INT3400_Thermal:20C acpitz:0C PNIT:69C soc_dts0:52C soc_dts1:52C bq27520-0:35C bq25890-charger-0:37C PL1:14.976W
2025-05-10T01:15:44.313107Z INFO VM(32)[7322]:  [devices/src/usb/xhci/device_slot.rs:173] xhci: stopping all device slots and resetting host hub
2025-05-10T01:15:46.986623Z INFO vm_concierge[1824]: Configuring network for VM 32
2025-05-10T01:15:47.006723Z INFO vm_concierge[1824]: Setting resolv config for VM 32
2025-05-10T01:15:47.028896Z INFO vm_concierge[1824]: Mounting 9P file system from port 16384 on /mnt/shared
2025-05-10T01:15:47.031879Z INFO 9s[7297]: accepted connection from cid: 32 port: 336661403
2025-05-10T01:15:47.045890Z INFO vm_cicerone[1876]: Received NotifyVmStarted request
2025-05-10T01:15:47.049402Z INFO vm_concierge[1824]: Starting Termina-specific services
2025-05-10T01:15:48.009664Z WARNING vm_cicerone[1876]: Could not load the device policy file.
2025-05-10T01:15:48.328319Z INFO vm_concierge[1824]: Started VM with pid 18
2025-05-10T01:15:48.330652Z INFO vm_concierge[1824]: New VM. Starting balloon resize timer.
2025-05-10T01:15:49.186456Z ERR vm_cicerone[1876]: Tremplin channel not connected after 5 seconds.
2025-05-10T01:15:49.191725Z INFO vm_concierge[1824]: Received request: OnTremplinStartedSignal for 099ae5e8e48e8725c32d257a1d2608f46024627b/termina
2025-05-10T01:15:49.200749Z INFO vm_cicerone[1876]: Received StartLxd request
2025-05-10T01:15:49.202313Z INFO seneschal[1637]: Received request to share path with server
2025-05-10T01:15:49.348030Z INFO vm_concierge[1824]: BalloonTrace throttled with size window: 100 MIB
2025-05-10T01:15:49.348081Z INFO vm_concierge[1824]: BalloonInit: { "type": "BalanceAvailableBalloonPolicy","vm": "termina","critical_margin": 299284480,"bias": 0 }
2025-05-10T01:15:49.348109Z INFO vm_concierge[1824]: BalloonTrace Format [vm_name, game_mode, balloon_size_MIB, balloon_delta_MIB, host_available_MIB, guest_cached_MIB, guest_free_MIB]
2025-05-10T01:15:49.359774Z INFO vm_concierge[1824]: BalloonTrace:[termina,,0,86,1008,45,1249]
2025-05-10T01:15:51.346312Z INFO vm_concierge[1824]: BalloonTrace:[termina,,132,26,986,69,1086]
2025-05-10T01:15:56.489652Z INFO vm_cicerone[1876]: Received CreateLxdContainer request
2025-05-10T01:15:56.492874Z INFO imageloader[7266]: parent socket has shutdown.