Re: Inquiry about tb/usb4 driver

Re: Inquiry about tb/usb4 driver

[mika.westerberg]

Hi,

On Thu, Feb 29, 2024 at 12:18:31PM +0000, mohamed.rayan@siemens.com wrote:
>    Hello,
> 
>     
> 
>    Hope this mail finds you well,

It does but sending HTML has some issues if the receiver such as me uses
text based mail client ;-)

>    I am sending this mail asking you for some help in the usage of tb/usb4
>    driver,
> 
>    I have downloaded this driver for kernel v6.5 to install it with a certain
>    USB4 host controller, Here is the driver link:
>    [1]https://elixir.bootlin.com/linux/v6.5/source/drivers/thunderbol
> 
>     
> 
>    I have found something not clear to me in “switch.c”, and exactly at line
>    #2260: “[2]tb_switch_alloc”, which is responsible for allocating and
>    initialization a switch:
> 
>  1-    This function has a local variable called “upstream_port”
> 
>  2-    A “tb_cfg_get_upstream_port” is first called to get the value of “upstream_port” from Switch config space
> 
>  3-    When I checked “tb_cfg_get_upstream_port” function, I found that it reads first DW (DW#0) of the router configuration space
> 
>  4-    In USB4 standard specifications, the first DW of the router config space is Vendor/Product IDs, not the Upstream Adapter, please check the below snapshot from USB4 standard
> 
>  5-    Later in the code of the “[3]tb_switch_alloc” function, at line#2297, this value of “upstream_port”  is used to overwrite another variable in the struct as follow:
> 
>                  
> 
>   
> 
>   
> 
>   
> 
>  6-    So at the end, “sw->config.upstream_port_number” will get updated with incorrect settings, So I am wondering if this is an expected behavior, Am I missing something?

This is historic to support Thunderbolt 1-3 devices where the upstream
port could change. In USB4 routers it is read-only. Do you see any real
issue with this?

RE: Inquiry about tb/usb4 driver

[mohamed.rayan]

Hello Mike,

Thanks for your reply,

Yes, I see a problem in my case, because When " tb_cfg_get_upstream_port", " upstream_port" variable gets updated with wrong value not the actual "upstream port" corresponding value in the Router configuration space of the USB4 host controller.


Regards,
Mohamed

-----Original Message-----
From: mika.westerberg@linux.intel.com <mika.westerberg@linux.intel.com> 
Sent: Thursday, February 29, 2024 2:31 PM
To: Rayan, Mohamed (DI SW ICS MNA RD HAV4 VER) <mohamed.rayan@siemens.com>
Cc: andreas.noever@gmail.com; michael.jamet@intel.com; YehezkelShB@gmail.com; linux-usb@vger.kernel.org; Samy, Mohamed (DI SW ICS MNA RD HAV4) <mohamed.samy@siemens.com>; El Nahas, Mohamed (DI SW ICS MNA RD HAV4) <mohamed.el_nahas@siemens.com>; Hassan, Ahmed (DI SW ICS MNA RD HAV4 HW) <ahmed_mohammed@siemens.com>
Subject: Re: Inquiry about tb/usb4 driver

Hi,

On Thu, Feb 29, 2024 at 12:18:31PM +0000, mohamed.rayan@siemens.com wrote:
>    Hello,
> 
>     
> 
>    Hope this mail finds you well,

It does but sending HTML has some issues if the receiver such as me uses text based mail client ;-)

>    I am sending this mail asking you for some help in the usage of tb/usb4
>    driver,
> 
>    I have downloaded this driver for kernel v6.5 to install it with a certain
>    USB4 host controller, Here is the driver link:
>    
> [1]https://eur01.safelinks.protection.outlook.com/?url=https%3A%2F%2Fe
> lixir.bootlin.com%2Flinux%2Fv6.5%2Fsource%2Fdrivers%2Fthunderbol&data=
> 05%7C02%7Cmohamed.rayan%40siemens.com%7C1c2fa047920349b1524608dc392243
> 2f%7C38ae3bcd95794fd4addab42e1495d55a%7C1%7C0%7C638448066550189604%7CU
> nknown%7CTWFpbGZsb3d8eyJWIjoiMC4wLjAwMDAiLCJQIjoiV2luMzIiLCJBTiI6Ik1ha
> WwiLCJXVCI6Mn0%3D%7C0%7C%7C%7C&sdata=d1OOH9C3dVRNlwo%2FEEXyKDvQ2s4xboR
> 1TMiBV2m9MbU%3D&reserved=0
> 
>     
> 
>    I have found something not clear to me in "switch.c", and exactly at line
>    #2260: "[2]tb_switch_alloc", which is responsible for allocating and
>    initialization a switch:
> 
>  1-    This function has a local variable called "upstream_port"
> 
>  2-    A "tb_cfg_get_upstream_port" is first called to get the value 
> of "upstream_port" from Switch config space
> 
>  3-    When I checked "tb_cfg_get_upstream_port" function, I found 
> that it reads first DW (DW#0) of the router configuration space
> 
>  4-    In USB4 standard specifications, the first DW of the router 
> config space is Vendor/Product IDs, not the Upstream Adapter, please 
> check the below snapshot from USB4 standard
> 
>  5-    Later in the code of the "[3]tb_switch_alloc" function, at line#2297, this value of "upstream_port"  is used to overwrite another variable in the struct as follow:
> 
>                  
> 
>   
> 
>   
> 
>   
> 
>  6-    So at the end, "sw->config.upstream_port_number" will get updated with incorrect settings, So I am wondering if this is an expected behavior, Am I missing something?

This is historic to support Thunderbolt 1-3 devices where the upstream port could change. In USB4 routers it is read-only. Do you see any real issue with this?

Re: Inquiry about tb/usb4 driver

[mika.westerberg]

On Thu, Feb 29, 2024 at 12:48:46PM +0000, mohamed.rayan@siemens.com wrote:
> Hello Mike,
> 
> Thanks for your reply,
> 
> Yes, I see a problem in my case, because When " tb_cfg_get_upstream_port", " upstream_port" variable gets updated with wrong value not the actual "upstream port" corresponding value in the Router configuration space of the USB4 host controller.

Can you share full dmesg with thunderbolt.dyndbg=+p in the command line
so we can take a look?

RE: Inquiry about tb/usb4 driver

[mohamed.rayan]

[-- Attachment #1: Type: text/plain, Size: 1508 bytes --]

Hello Mike,

Sorry for my late response,

Kindly find the request log info as attached.

Please note that I have generated this log using the following steps:
    1- echo "module thunderbolt +p" > /sys/kernel/debug/dynamic_debug/control
    2- To get the debug data I have ran: cat /sys/kernel/debug/dynamic_debug/control | grep thunderbolt

@mika.westerberg@linux.intel.com, Please let me know if you have any feedback.

Regards,
Mohamed

-----Original Message-----
From: mika.westerberg@linux.intel.com <mika.westerberg@linux.intel.com> 
Sent: Thursday, February 29, 2024 2:56 PM
To: Rayan, Mohamed (DI SW ICS MNA RD HAV4 VER) <mohamed.rayan@siemens.com>
Cc: andreas.noever@gmail.com; michael.jamet@intel.com; YehezkelShB@gmail.com; linux-usb@vger.kernel.org; Samy, Mohamed (DI SW ICS MNA RD HAV4) <mohamed.samy@siemens.com>; El Nahas, Mohamed (DI SW ICS MNA RD HAV4) <mohamed.el_nahas@siemens.com>; Hassan, Ahmed (DI SW ICS MNA RD HAV4 HW) <ahmed_mohammed@siemens.com>
Subject: Re: Inquiry about tb/usb4 driver

On Thu, Feb 29, 2024 at 12:48:46PM +0000, mohamed.rayan@siemens.com wrote:
> Hello Mike,
> 
> Thanks for your reply,
> 
> Yes, I see a problem in my case, because When " tb_cfg_get_upstream_port", " upstream_port" variable gets updated with wrong value not the actual "upstream port" corresponding value in the Router configuration space of the USB4 host controller.

Can you share full dmesg with thunderbolt.dyndbg=+p in the command line so we can take a look?

[-- Attachment #2: thunderbolt_debug.log --]
[-- Type: application/octet-stream, Size: 28271 bytes --]

/root/modified_tb_driver/acpi.c:85 [thunderbolt]tb_acpi_add_link =_ "created link from %s\n"
/root/modified_tb_driver/acpi.c:228 [thunderbolt]tb_acpi_retimer_set_power =_ "%llx:%u: ACPI: calling _DSM to power %s retimers\n"
/root/modified_tb_driver/clx.c:209 [thunderbolt]tb_switch_clx_init =_ "%llx: CLx: current mode: %s\n"
/root/modified_tb_driver/clx.c:355 [thunderbolt]tb_switch_clx_enable =_ "%llx:%u: CLx: %s %ssupported\n"
/root/modified_tb_driver/clx.c:357 [thunderbolt]tb_switch_clx_enable =_ "%llx:%u: CLx: %s %ssupported\n"
/root/modified_tb_driver/clx.c:382 [thunderbolt]tb_switch_clx_enable =_ "%llx: CLx: %s enabled\n"
/root/modified_tb_driver/clx.c:421 [thunderbolt]tb_switch_clx_disable =_ "%llx: CLx: %s disabled\n"
/root/modified_tb_driver/quirks.c:13 [thunderbolt]quirk_force_power_link =_ "%llx: forcing power to link controller\n"
/root/modified_tb_driver/quirks.c:20 [thunderbolt]quirk_dp_credit_allocation =_ "%llx: quirked DP main: %u\n"
/root/modified_tb_driver/quirks.c:27 [thunderbolt]quirk_clx_disable =_ "%llx: disabling CL states\n"
/root/modified_tb_driver/quirks.c:38 [thunderbolt]quirk_usb3_maximum_bandwidth =_ "%llx:%u: USB3 maximum bandwidth limited to %u Mb/s\n"
/root/modified_tb_driver/quirks.c:117 [thunderbolt]tb_check_quirks =_ "%llx: running %ps\n"
/root/modified_tb_driver/retimer.c:100 [thunderbolt]tb_retimer_nvm_add =_ "NVM upgrade disabled\n"
/root/modified_tb_driver/retimer.c:194 [thunderbolt]tb_retimer_nvm_authenticate_status =_ "%llx:%u: reading NVM authentication status of retimers\n"
/root/modified_tb_driver/retimer.c:216 [thunderbolt]tb_retimer_set_inbound_sbtx =_ "%llx:%u: enabling sideband transactions\n"
/root/modified_tb_driver/retimer.c:234 [thunderbolt]tb_retimer_unset_inbound_sbtx =_ "%llx:%u: disabling sideband transactions\n"
/root/modified_tb_driver/nvm.c:304 [thunderbolt]tb_nvm_alloc =_ "%llx: router NVM format of vendor %#x unknown\n"
/root/modified_tb_driver/nvm.c:321 [thunderbolt]tb_nvm_alloc =_ "retimer NVM format of vendor %#x unknown\n"
/root/modified_tb_driver/usb4_port.c:155 [thunderbolt]offline_store =_ "%llx:%u: %s offline mode\n"
/root/modified_tb_driver/usb4.c:173 [thunderbolt]usb4_switch_check_wakes =_ "%llx: PCIe wake: %s, USB3 wake: %s\n"
/root/modified_tb_driver/usb4.c:192 [thunderbolt]usb4_switch_check_wakes =_ "%llx:%u: USB4 wake: %s, connection wake: %s, disconnection wake: %s\n"
/root/modified_tb_driver/usb4.c:260 [thunderbolt]usb4_switch_setup =_ "%llx: link: %s\n"
/root/modified_tb_driver/usb4.c:265 [thunderbolt]usb4_switch_setup =_ "%llx: TBT3 support: %s, xHCI: %s\n"
/root/modified_tb_driver/usb4.c:778 [thunderbolt]usb4_switch_credits_init =_ "%llx: credit allocation parameters:\n"
/root/modified_tb_driver/usb4.c:788 [thunderbolt]usb4_switch_credits_init =_ "%llx:  USB3: %u\n"
/root/modified_tb_driver/usb4.c:792 [thunderbolt]usb4_switch_credits_init =_ "%llx:  DP AUX: %u\n"
/root/modified_tb_driver/usb4.c:796 [thunderbolt]usb4_switch_credits_init =_ "%llx:  DP main: %u\n"
/root/modified_tb_driver/usb4.c:800 [thunderbolt]usb4_switch_credits_init =_ "%llx:  PCIe: %u\n"
/root/modified_tb_driver/usb4.c:804 [thunderbolt]usb4_switch_credits_init =_ "%llx:  DMA: %u\n"
/root/modified_tb_driver/usb4.c:808 [thunderbolt]usb4_switch_credits_init =_ "%llx:  unknown credit allocation index %#x, skipping\n"
/root/modified_tb_driver/usb4.c:2171 [thunderbolt]usb4_usb3_port_write_allocated_bandwidth =_ "%llx:%u: scaled bandwidth %u/%u, scale %u\n"
/root/modified_tb_driver/tmu.c:364 [thunderbolt]tmu_mode_init =_ "%llx: TMU: supports uni-directional mode\n"
/root/modified_tb_driver/tmu.c:367 [thunderbolt]tmu_mode_init =_ "%llx: TMU: supports enhanced uni-directional mode\n"
/root/modified_tb_driver/tmu.c:433 [thunderbolt]tb_switch_tmu_init =_ "%llx: TMU: current mode: %s\n"
/root/modified_tb_driver/tmu.c:469 [thunderbolt]tb_switch_tmu_post_time =_ "%llx: TMU: local_time[%d]=0x%08x\n"
/root/modified_tb_driver/tmu.c:529 [thunderbolt]tb_switch_tmu_post_time =_ "%llx: TMU: updated local time to %#llx\n"
/root/modified_tb_driver/tmu.c:616 [thunderbolt]tb_switch_tmu_disable =_ "%llx: TMU: disabled\n"
/root/modified_tb_driver/tmu.c:1006 [thunderbolt]tb_switch_tmu_enable =_ "%llx: TMU: mode set to: %s\n"
/root/modified_tb_driver/tmu.c:1056 [thunderbolt]tb_switch_tmu_configure =_ "%llx: TMU: mode change %s -> %s requested\n"
/root/modified_tb_driver/lc.c:313 [thunderbolt]tb_lc_xhci_connect =_ "%llx:%u: xHCI connected\n"
/root/modified_tb_driver/lc.c:327 [thunderbolt]tb_lc_xhci_disconnect =_ "%llx:%u: xHCI disconnected\n"
/root/modified_tb_driver/lc.c:585 [thunderbolt]tb_lc_dp_sink_alloc =_ "%llx:%u: sink %d allocated\n"
/root/modified_tb_driver/lc.c:628 [thunderbolt]tb_lc_dp_sink_dealloc =_ "%llx:%u: sink %d de-allocated\n"
/root/modified_tb_driver/xdomain.c:741 [thunderbolt]tb_xdp_handle_request =_ "%llx: received XDomain properties request\n"
/root/modified_tb_driver/xdomain.c:749 [thunderbolt]tb_xdp_handle_request =_ "%llx: received XDomain properties changed request\n"
/root/modified_tb_driver/xdomain.c:766 [thunderbolt]tb_xdp_handle_request =_ "%llx: received XDomain UUID request\n"
/root/modified_tb_driver/xdomain.c:771 [thunderbolt]tb_xdp_handle_request =_ "%llx: received XDomain link state status request\n"
/root/modified_tb_driver/xdomain.c:784 [thunderbolt]tb_xdp_handle_request =_ "%llx: received XDomain link state change request\n"
/root/modified_tb_driver/xdomain.c:803 [thunderbolt]tb_xdp_handle_request =_ "%llx: unknown XDomain request %#x\n"
/root/modified_tb_driver/xdomain.c:1172 [thunderbolt]tb_xdomain_get_uuid =_ "requesting remote UUID\n"
/root/modified_tb_driver/xdomain.c:1178 [thunderbolt]tb_xdomain_get_uuid =_ "failed to request UUID, retrying\n"
/root/modified_tb_driver/xdomain.c:1181 [thunderbolt]tb_xdomain_get_uuid =_ "failed to read remote UUID\n"
/root/modified_tb_driver/xdomain.c:1185 [thunderbolt]tb_xdomain_get_uuid =_ "got remote UUID %pUb\n"
/root/modified_tb_driver/xdomain.c:1189 [thunderbolt]tb_xdomain_get_uuid =_ "loop back detected\n"
/root/modified_tb_driver/xdomain.c:1191 [thunderbolt]tb_xdomain_get_uuid =_ "intra-domain loop detected\n"
/root/modified_tb_driver/xdomain.c:1203 [thunderbolt]tb_xdomain_get_uuid =_ "remote UUID is different, unplugging\n"
/root/modified_tb_driver/xdomain.c:1224 [thunderbolt]tb_xdomain_get_link_status =_ "sending link state status request to %pUb\n"
/root/modified_tb_driver/xdomain.c:1232 [thunderbolt]tb_xdomain_get_link_status =_ "failed to request remote link status, retrying\n"
/root/modified_tb_driver/xdomain.c:1236 [thunderbolt]tb_xdomain_get_link_status =_ "failed to receive remote link status\n"
/root/modified_tb_driver/xdomain.c:1240 [thunderbolt]tb_xdomain_get_link_status =_ "remote link supports width %#x speed %#x\n"
/root/modified_tb_driver/xdomain.c:1243 [thunderbolt]tb_xdomain_get_link_status =_ "remote adapter is single lane only\n"
/root/modified_tb_driver/xdomain.c:1272 [thunderbolt]tb_xdomain_link_state_change =_ "sending link state change request with width %#x speed %#x\n"
/root/modified_tb_driver/xdomain.c:1279 [thunderbolt]tb_xdomain_link_state_change =_ "failed to change remote link state, retrying\n"
/root/modified_tb_driver/xdomain.c:1287 [thunderbolt]tb_xdomain_link_state_change =_ "received link state change response\n"
/root/modified_tb_driver/xdomain.c:1305 [thunderbolt]tb_xdomain_bond_lanes_uuid_high =_ "link state change request not received yet, retrying\n"
/root/modified_tb_driver/xdomain.c:1309 [thunderbolt]tb_xdomain_bond_lanes_uuid_high =_ "timeout waiting for link change request\n"
/root/modified_tb_driver/xdomain.c:1348 [thunderbolt]tb_xdomain_bond_lanes_uuid_high =_ "lane bonding %s\n"
/root/modified_tb_driver/xdomain.c:1361 [thunderbolt]tb_xdomain_get_properties =_ "requesting remote properties\n"
/root/modified_tb_driver/xdomain.c:1368 [thunderbolt]tb_xdomain_get_properties =_ "failed to request remote properties, retrying\n"
/root/modified_tb_driver/xdomain.c:1489 [thunderbolt]tb_xdomain_queue_bonding =_ "we have higher UUID, other side bonds the lanes\n"
/root/modified_tb_driver/xdomain.c:1492 [thunderbolt]tb_xdomain_queue_bonding =_ "we have lower UUID, bonding lanes\n"
/root/modified_tb_driver/xdomain.c:1533 [thunderbolt]tb_xdomain_state_work =_ "running state %s\n"
/root/modified_tb_driver/xdomain.c:1646 [thunderbolt]tb_xdomain_properties_changed =_ "sending properties changed notification\n"
/root/modified_tb_driver/xdomain.c:1652 [thunderbolt]tb_xdomain_properties_changed =_ "failed to send properties changed notification, retrying\n"
/root/modified_tb_driver/xdomain.c:1934 [thunderbolt]tb_xdomain_alloc =_ "local UUID %pUb\n"
/root/modified_tb_driver/xdomain.c:1936 [thunderbolt]tb_xdomain_alloc =_ "remote UUID %pUb\n"
/root/modified_tb_driver/xdomain.c:2060 [thunderbolt]tb_xdomain_lane_bonding_enable =_ "lane bonding enabled\n"
/root/modified_tb_driver/xdomain.c:2088 [thunderbolt]tb_xdomain_lane_bonding_disable =_ "lane bonding disabled\n"
/root/modified_tb_driver/icm.c:1668 [thunderbolt]icm_icl_rtd3_veto =_ "ICM rtd3 veto=0x%08x\n"
/root/modified_tb_driver/icm.c:1823 [thunderbolt]icm_firmware_start =_ "starting ICM firmware\n"
/root/modified_tb_driver/icm.c:1987 [thunderbolt]icm_driver_ready =_ "USB4 proxy operations supported\n"
/root/modified_tb_driver/icm.c:2132 [thunderbolt]icm_runtime_resume_switch =_ "runtime resuming timed out\n"
/root/modified_tb_driver/icm.c:2200 [thunderbolt]icm_usb4_switch_nvm_auth_complete =_ "NVM_AUTH response for %llx flags %#x status %#x\n"
/root/modified_tb_driver/icm.c:2244 [thunderbolt]icm_usb4_switch_nvm_authenticate =_ "NVM_AUTH request for %llx\n"
/root/modified_tb_driver/icm.c:2339 [thunderbolt]icm_usb4_switch_nvm_authenticate_status =_ "NVM_AUTH found for %llx flags %#x status %#x\n"
/root/modified_tb_driver/icm.c:2550 [thunderbolt]icm_probe =_ "ICM not supported on this controller\n"
/root/modified_tb_driver/icm.c:2555 [thunderbolt]icm_probe =_ "using firmware connection manager\n"
/root/modified_tb_driver/eeprom.c:553 [thunderbolt]tb_drom_bit_bang =_ "%llx: reading DROM (length: %#x)\n"
/root/modified_tb_driver/eeprom.c:630 [thunderbolt]tb_drom_parse =_ "%llx: DROM version: %d\n"
/root/modified_tb_driver/tunnel.c:178 [thunderbolt]tb_pci_set_ext_encapsulation =_ "%llx:%u <-> %llx:%u (%s): extended encapsulation %s\n"
/root/modified_tb_driver/tunnel.c:341 [thunderbolt]tb_tunnel_discover_pci =_ "%llx:%u <-> %llx:%u (%s): discovered\n"
/root/modified_tb_driver/tunnel.c:638 [thunderbolt]tb_dp_xchg_caps =_ "%llx:%u: maximum supported bandwidth %u Mb/s x%u = %u Mb/s\n"
/root/modified_tb_driver/tunnel.c:648 [thunderbolt]tb_dp_xchg_caps =_ "%llx:%u: maximum supported bandwidth %u Mb/s x%u = %u Mb/s\n"
/root/modified_tb_driver/tunnel.c:668 [thunderbolt]tb_dp_xchg_caps =_ "%llx:%u: bandwidth reduced to %u Mb/s x%u = %u Mb/s\n"
/root/modified_tb_driver/tunnel.c:686 [thunderbolt]tb_dp_xchg_caps =_ "%llx:%u: disabling LTTPR\n"
/root/modified_tb_driver/tunnel.c:736 [thunderbolt]tb_dp_bandwidth_alloc_mode_enable =_ "%llx:%u: non-reduced bandwidth %u Mb/s x%u = %u Mb/s\n"
/root/modified_tb_driver/tunnel.c:752 [thunderbolt]tb_dp_bandwidth_alloc_mode_enable =_ "%llx:%u: maximum bandwidth through allocation mode %u Mb/s x%u = %u Mb/s\n"
/root/modified_tb_driver/tunnel.c:760 [thunderbolt]tb_dp_bandwidth_alloc_mode_enable =_ "%llx:%u: granularity %d Mb/s\n"
/root/modified_tb_driver/tunnel.c:780 [thunderbolt]tb_dp_bandwidth_alloc_mode_enable =_ "%llx:%u: estimated bandwidth %d Mb/s\n"
/root/modified_tb_driver/tunnel.c:791 [thunderbolt]tb_dp_bandwidth_alloc_mode_enable =_ "%llx:%u: bandwidth allocation mode enabled\n"
/root/modified_tb_driver/tunnel.c:812 [thunderbolt]tb_dp_init =_ "%llx:%u: bandwidth allocation mode supported\n"
/root/modified_tb_driver/tunnel.c:829 [thunderbolt]tb_dp_deinit =_ "%llx:%u: bandwidth allocation mode disabled\n"
/root/modified_tb_driver/tunnel.c:945 [thunderbolt]tb_dp_bandwidth_mode_consumed_bandwidth =_ "%llx:%u: consumed bandwidth through allocation mode %d Mb/s\n"
/root/modified_tb_driver/tunnel.c:1031 [thunderbolt]tb_dp_alloc_bandwidth =_ "%llx:%u: allocated bandwidth through allocation mode %d Mb/s\n"
/root/modified_tb_driver/tunnel.c:1059 [thunderbolt]tb_dp_read_dprx =_ "%llx:%u: consumed bandwidth through DPRX %d Mb/s\n"
/root/modified_tb_driver/tunnel.c:1098 [thunderbolt]tb_dp_read_cap =_ "%llx:%u: bandwidth from %#x capability %d Mb/s\n"
/root/modified_tb_driver/tunnel.c:1277 [thunderbolt]tb_dp_dump =_ "%llx:%u: maximum supported bandwidth %u Mb/s x%u = %u Mb/s\n"
/root/modified_tb_driver/tunnel.c:1289 [thunderbolt]tb_dp_dump =_ "%llx:%u: maximum supported bandwidth %u Mb/s x%u = %u Mb/s\n"
/root/modified_tb_driver/tunnel.c:1299 [thunderbolt]tb_dp_dump =_ "%llx:%u: reduced bandwidth %u Mb/s x%u = %u Mb/s\n"
/root/modified_tb_driver/tunnel.c:1382 [thunderbolt]tb_tunnel_discover_dp =_ "%llx:%u <-> %llx:%u (%s): discovered\n"
/root/modified_tb_driver/tunnel.c:1496 [thunderbolt]tb_dma_reserve_credits =_ "%llx:%u: reserving %u credits for DMA path\n"
/root/modified_tb_driver/tunnel.c:1577 [thunderbolt]tb_dma_release_credits =_ "%llx:%u: released %u DMA path credits\n"
/root/modified_tb_driver/tunnel.c:1654 [thunderbolt]tb_tunnel_alloc_dma =_ "%llx:%u <-> %llx:%u (%s): not enough buffers for RX path\n"
/root/modified_tb_driver/tunnel.c:1666 [thunderbolt]tb_tunnel_alloc_dma =_ "%llx:%u <-> %llx:%u (%s): not enough buffers for TX path\n"
/root/modified_tb_driver/tunnel.c:1757 [thunderbolt]tb_usb3_init =_ "%llx:%u <-> %llx:%u (%s): allocating initial bandwidth %d/%d Mb/s\n"
/root/modified_tb_driver/tunnel.c:1807 [thunderbolt]tb_usb3_release_unused_bandwidth =_ "%llx:%u <-> %llx:%u (%s): decreased bandwidth allocation to %d/%d Mb/s\n"
/root/modified_tb_driver/tunnel.c:1869 [thunderbolt]tb_usb3_reclaim_available_bandwidth =_ "%llx:%u <-> %llx:%u (%s): increased bandwidth allocation to %d/%d Mb/s\n"
/root/modified_tb_driver/tunnel.c:2009 [thunderbolt]tb_tunnel_discover_usb3 =_ "%llx:%u <-> %llx:%u (%s): currently allocated bandwidth %d/%d Mb/s\n"
/root/modified_tb_driver/tunnel.c:2020 [thunderbolt]tb_tunnel_discover_usb3 =_ "%llx:%u <-> %llx:%u (%s): discovered\n"
/root/modified_tb_driver/tunnel.c:2065 [thunderbolt]tb_tunnel_alloc_usb3 =_ "%llx:%u: required bandwidth for USB3 tunnel %d Mb/s\n"
/root/modified_tb_driver/tunnel.c:2172 [thunderbolt]tb_tunnel_restart =_ "%llx:%u <-> %llx:%u (%s): activating\n"
/root/modified_tb_driver/tunnel.c:2240 [thunderbolt]tb_tunnel_deactivate =_ "%llx:%u <-> %llx:%u (%s): deactivating\n"
/root/modified_tb_driver/tunnel.c:2382 [thunderbolt]tb_tunnel_consumed_bandwidth =_ "%llx:%u <-> %llx:%u (%s): consumed bandwidth %d/%d Mb/s\n"
/root/modified_tb_driver/path.c:20 [thunderbolt]tb_dump_hop =_ "%llx:%u:  In HopID: %d => Out port: %d Out HopID: %d\n"
/root/modified_tb_driver/path.c:22 [thunderbolt]tb_dump_hop =_ "%llx:%u:   Weight: %d Priority: %d Credits: %d Drop: %d\n"
/root/modified_tb_driver/path.c:25 [thunderbolt]tb_dump_hop =_ "%llx:%u:    Counter enabled: %d Counter index: %d\n"
/root/modified_tb_driver/path.c:27 [thunderbolt]tb_dump_hop =_ "%llx:%u:   Flow Control (In/Eg): %d/%d Shared Buffer (In/Eg): %d/%d\n"
/root/modified_tb_driver/path.c:30 [thunderbolt]tb_dump_hop =_ "%llx:%u:   Unknown1: %#x Unknown2: %#x Unknown3: %#x\n"
/root/modified_tb_driver/path.c:191 [thunderbolt]tb_path_discover =_ "discovering %s path starting from %llx:%u\n"
/root/modified_tb_driver/path.c:232 [thunderbolt]tb_path_discover =_ "path discovery complete\n"
/root/modified_tb_driver/path.c:507 [thunderbolt]tb_path_deactivate =_ "deactivating %s path from %llx:%u to %llx:%u\n"
/root/modified_tb_driver/path.c:536 [thunderbolt]tb_path_activate =_ "activating %s path from %llx:%u to %llx:%u\n"
/root/modified_tb_driver/path.c:596 [thunderbolt]tb_path_activate =_ "%llx:%u: Writing hop %d\n"
/root/modified_tb_driver/path.c:607 [thunderbolt]tb_path_activate =_ "path activation complete\n"
/root/modified_tb_driver/cap.c:185 [thunderbolt]tb_switch_next_cap =_ "%llx: unknown capability %#x at %#x\n"
/root/modified_tb_driver/switch.c:387 [thunderbolt]tb_switch_nvm_add =_ "%llx: NVM upgrade disabled\n"
/root/modified_tb_driver/switch.c:447 [thunderbolt]tb_dump_port =_ " Port %d: %x:%x (Revision: %d, TB Version: %d, Type: %s (%#x))\n"
/root/modified_tb_driver/switch.c:452 [thunderbolt]tb_dump_port =_ "  Max hop id (in/out): %d/%d\n"
/root/modified_tb_driver/switch.c:454 [thunderbolt]tb_dump_port =_ "  Max counters: %d\n"
/root/modified_tb_driver/switch.c:455 [thunderbolt]tb_dump_port =_ "  NFC Credits: %#x\n"
/root/modified_tb_driver/switch.c:456 [thunderbolt]tb_dump_port =_ "  Credits (total/control): %u/%u\n"
/root/modified_tb_driver/switch.c:514 [thunderbolt]tb_wait_for_port =_ "%llx:%u: is disabled (state: 0)\n"
/root/modified_tb_driver/switch.c:520 [thunderbolt]tb_wait_for_port =_ "%llx:%u: is unplugged (state: 7), retrying...\n"
/root/modified_tb_driver/switch.c:525 [thunderbolt]tb_wait_for_port =_ "%llx:%u: is unplugged (state: 7)\n"
/root/modified_tb_driver/switch.c:533 [thunderbolt]tb_wait_for_port =_ "%llx:%u: is connected, link is up (state: %d)\n"
/root/modified_tb_driver/switch.c:544 [thunderbolt]tb_wait_for_port =_ "%llx:%u: is connected, link is not up (state: %d), retrying...\n"
/root/modified_tb_driver/switch.c:586 [thunderbolt]tb_port_add_nfc_credits =_ "%llx:%u: adding %d NFC credits to %lu"
/root/modified_tb_driver/switch.c:606 [thunderbolt]tb_port_clear_counter =_ "%llx:%u: clearing counter %d\n"
/root/modified_tb_driver/switch.c:652 [thunderbolt]__tb_port_enable =_ "%llx:%u: lane %s\n"
/root/modified_tb_driver/switch.c:705 [thunderbolt]tb_init_port =_ " Port %d: not implemented\n"
/root/modified_tb_driver/switch.c:1208 [thunderbolt]tb_port_do_update_credits =_ "%llx:%u: total credits changed %u -> %u\n"
/root/modified_tb_driver/switch.c:1515 [thunderbolt]tb_dump_switch =_ " %s Switch: %x:%x (Revision: %d, TB Version: %d)\n"
/root/modified_tb_driver/switch.c:1518 [thunderbolt]tb_dump_switch =_ "  Max Port Number: %d\n"
/root/modified_tb_driver/switch.c:1519 [thunderbolt]tb_dump_switch =_ "  Config:\n"
/root/modified_tb_driver/switch.c:1520 [thunderbolt]tb_dump_switch =_ "   Upstream Port Number: %d Depth: %d Route String: %#llx Enabled: %d, PlugEventsDelay: %dms\n"
/root/modified_tb_driver/switch.c:1525 [thunderbolt]tb_dump_switch =_ "   unknown1: %#x unknown4: %#x\n"
/root/modified_tb_driver/switch.c:1542 [thunderbolt]tb_switch_reset =_ "%llx: resetting switch\n"
/root/modified_tb_driver/switch.c:2341 [thunderbolt]tb_switch_alloc =_ "current switch config:\n"
/root/modified_tb_driver/switch.c:2484 [thunderbolt]tb_switch_configure =_ "%s Switch at %#llx (depth: %d, up port: %d)\n"
/root/modified_tb_driver/switch.c:2722 [thunderbolt]tb_switch_default_link_ports =_ "%llx: linked ports %d <-> %d\n"
/root/modified_tb_driver/switch.c:2837 [thunderbolt]tb_switch_lane_bonding_enable =_ "%llx: lane bonding enabled\n"
/root/modified_tb_driver/switch.c:2877 [thunderbolt]tb_switch_lane_bonding_disable =_ "%llx: lane bonding disabled\n"
/root/modified_tb_driver/switch.c:3013 [thunderbolt]tb_switch_add =_ "%llx: uid: %#llx\n"
/root/modified_tb_driver/switch.c:3023 [thunderbolt]tb_switch_add =_ "%llx:%u: disabled by eeprom\n"
/root/modified_tb_driver/switch.c:3201 [thunderbolt]tb_switch_set_wake =_ "%llx: enabling wakeup: %#x\n"
/root/modified_tb_driver/switch.c:3203 [thunderbolt]tb_switch_set_wake =_ "%llx: disabling wakeup\n"
/root/modified_tb_driver/switch.c:3215 [thunderbolt]tb_switch_resume =_ "%llx: resuming switch\n"
/root/modified_tb_driver/switch.c:3314 [thunderbolt]tb_switch_suspend =_ "%llx: suspending switch\n"
/root/modified_tb_driver/switch.c:3386 [thunderbolt]tb_switch_alloc_dp_resource =_ "%llx: allocated DP resource for port %d\n"
/root/modified_tb_driver/switch.c:3412 [thunderbolt]tb_switch_dealloc_dp_resource =_ "%llx: released DP resource for port %d\n"
/root/modified_tb_driver/switch.c:3683 [thunderbolt]tb_switch_xhci_disconnect =_ "%llx:%u: disconnected xHCI\n"
/root/modified_tb_driver/switch.c:3685 [thunderbolt]tb_switch_xhci_disconnect =_ "%llx:%u: disconnected xHCI\n"
/root/modified_tb_driver/tb.c:77 [thunderbolt]tb_bandwidth_group_attach_port =_ "%llx:%u: attached to bandwidth group %d\n"
/root/modified_tb_driver/tb.c:157 [thunderbolt]tb_detach_bandwidth_group =_ "%llx:%u: detached from bandwidth group %d\n"
/root/modified_tb_driver/tb.c:194 [thunderbolt]tb_add_dp_resources =_ "%llx:%u: DP IN resource available\n"
/root/modified_tb_driver/tb.c:211 [thunderbolt]tb_remove_dp_resources =_ "%llx:%u: DP OUT resource unavailable\n"
/root/modified_tb_driver/tb.c:227 [thunderbolt]tb_discover_dp_resource =_ "%llx:%u: DP %s resource available discovered\n"
/root/modified_tb_driver/tb.c:590 [thunderbolt]tb_available_bandwidth =_ "calculating available bandwidth between %llx:%u <-> %llx:%u\n"
/root/modified_tb_driver/tb.c:658 [thunderbolt]tb_available_bandwidth =_ "%llx:%u: link total bandwidth %d/%d Mb/s\n"
/root/modified_tb_driver/tb.c:739 [thunderbolt]tb_reclaim_usb3_bandwidth =_ "reclaiming unused bandwidth for USB3\n"
/root/modified_tb_driver/tb.c:752 [thunderbolt]tb_reclaim_usb3_bandwidth =_ "available bandwidth for USB3 %d/%d Mb/s\n"
/root/modified_tb_driver/tb.c:769 [thunderbolt]tb_tunnel_usb3 =_ "USB3 tunneling disabled, not creating tunnel\n"
/root/modified_tb_driver/tb.c:820 [thunderbolt]tb_tunnel_usb3 =_ "%llx:%u: available bandwidth for new USB3 tunnel %d/%d Mb/s\n"
/root/modified_tb_driver/tb.c:927 [thunderbolt]tb_scan_port =_ "%llx:%u: DP adapter HPD set, queuing hotplug\n"
/root/modified_tb_driver/tb.c:955 [thunderbolt]tb_scan_port =_ "%llx:%u: port already has a remote\n"
/root/modified_tb_driver/tb.c:1039 [thunderbolt]tb_scan_port =_ "%llx: discovery, not touching CL states\n"
/root/modified_tb_driver/tb.c:1230 [thunderbolt]tb_recalc_estimated_bandwidth_for_group =_ "re-calculating bandwidth estimation for group %u\n"
/root/modified_tb_driver/tb.c:1279 [thunderbolt]tb_recalc_estimated_bandwidth_for_group =_ "%llx:%u: re-calculated estimated bandwidth %u/%u Mb/s\n"
/root/modified_tb_driver/tb.c:1295 [thunderbolt]tb_recalc_estimated_bandwidth_for_group =_ "bandwidth estimation for group %u done\n"
/root/modified_tb_driver/tb.c:1303 [thunderbolt]tb_recalc_estimated_bandwidth =_ "bandwidth consumption changed, re-calculating estimated bandwidth\n"
/root/modified_tb_driver/tb.c:1312 [thunderbolt]tb_recalc_estimated_bandwidth =_ "bandwidth re-calculation done\n"
/root/modified_tb_driver/tb.c:1328 [thunderbolt]tb_find_dp_out =_ "%llx:%u: DP OUT in use\n"
/root/modified_tb_driver/tb.c:1332 [thunderbolt]tb_find_dp_out =_ "%llx:%u: DP OUT available\n"
/root/modified_tb_driver/tb.c:1360 [thunderbolt]tb_tunnel_dp =_ "DP tunneling disabled, not creating tunnel\n"
/root/modified_tb_driver/tb.c:1368 [thunderbolt]tb_tunnel_dp =_ "looking for DP IN <-> DP OUT pairs:\n"
/root/modified_tb_driver/tb.c:1377 [thunderbolt]tb_tunnel_dp =_ "%llx:%u: DP IN in use\n"
/root/modified_tb_driver/tb.c:1381 [thunderbolt]tb_tunnel_dp =_ "%llx:%u: DP IN available\n"
/root/modified_tb_driver/tb.c:1391 [thunderbolt]tb_tunnel_dp =_ "no suitable DP IN adapter available, not tunneling\n"
/root/modified_tb_driver/tb.c:1425 [thunderbolt]tb_tunnel_dp =_ "%llx:%u: no resource available for DP IN, not tunneling\n"
/root/modified_tb_driver/tb.c:1443 [thunderbolt]tb_tunnel_dp =_ "available bandwidth for new DP tunnel %u/%u Mb/s\n"
/root/modified_tb_driver/tb.c:1449 [thunderbolt]tb_tunnel_dp =_ "%llx:%u: could not allocate DP tunnel\n"
/root/modified_tb_driver/tb.c:1492 [thunderbolt]tb_dp_resource_unavailable =_ "%llx:%u: DP IN resource unavailable\n"
/root/modified_tb_driver/tb.c:1496 [thunderbolt]tb_dp_resource_unavailable =_ "%llx:%u: DP OUT resource unavailable\n"
/root/modified_tb_driver/tb.c:1526 [thunderbolt]tb_dp_resource_available =_ "%llx:%u: DP %s resource available\n"
/root/modified_tb_driver/tb.c:1776 [thunderbolt]tb_handle_hotplug =_ "hotplug event for upstream port %llx:%x (unplug: %d)\n"
/root/modified_tb_driver/tb.c:1787 [thunderbolt]tb_handle_hotplug =_ "%llx:%u: switch unplugged\n"
/root/modified_tb_driver/tb.c:1804 [thunderbolt]tb_handle_hotplug =_ "%llx:%u: xdomain unplugged\n"
/root/modified_tb_driver/tb.c:1821 [thunderbolt]tb_handle_hotplug =_ "%llx: xHCI disconnect request\n"
/root/modified_tb_driver/tb.c:1824 [thunderbolt]tb_handle_hotplug =_ "%llx:%u: got unplug event for disconnected port, ignoring\n"
/root/modified_tb_driver/tb.c:1828 [thunderbolt]tb_handle_hotplug =_ "%llx:%u: got plug event for connected port, ignoring\n"
/root/modified_tb_driver/tb.c:1830 [thunderbolt]tb_handle_hotplug =_ "%llx: xHCI connect request\n"
/root/modified_tb_driver/tb.c:1834 [thunderbolt]tb_handle_hotplug =_ "%llx:%u: hotplug: scanning\n"
/root/modified_tb_driver/tb.c:1838 [thunderbolt]tb_handle_hotplug =_ "%llx:%u: hotplug: no switch found\n"
/root/modified_tb_driver/tb.c:1874 [thunderbolt]tb_alloc_dp_bandwidth =_ "%llx:%u: bandwidth allocated currently %d/%d Mb/s\n"
/root/modified_tb_driver/tb.c:1916 [thunderbolt]tb_alloc_dp_bandwidth =_ "%llx:%u: corrected bandwidth request %d/%d Mb/s\n"
/root/modified_tb_driver/tb.c:1921 [thunderbolt]tb_alloc_dp_bandwidth =_ "%llx:%u: bandwidth request too high (%d/%d Mb/s > %d/%d Mb/s)\n"
/root/modified_tb_driver/tb.c:1958 [thunderbolt]tb_alloc_dp_bandwidth =_ "%llx:%u: bandwidth available for allocation %d/%d Mb/s\n"
/root/modified_tb_driver/tb.c:2003 [thunderbolt]tb_handle_dp_bandwidth_request =_ "%llx:%u: handling bandwidth allocation request\n"
/root/modified_tb_driver/tb.c:2013 [thunderbolt]tb_handle_dp_bandwidth_request =_ "%llx:%u: no bandwidth request active\n"
/root/modified_tb_driver/tb.c:2020 [thunderbolt]tb_handle_dp_bandwidth_request =_ "%llx:%u: requested bandwidth %d Mb/s\n"
/root/modified_tb_driver/tb.c:2045 [thunderbolt]tb_handle_dp_bandwidth_request =_ "%llx:%u: bandwidth allocation changed to %d/%d Mb/s\n"
/root/modified_tb_driver/tb.c:2255 [thunderbolt]tb_suspend_noirq =_ "suspending...\n"
/root/modified_tb_driver/tb.c:2259 [thunderbolt]tb_suspend_noirq =_ "suspend finished\n"
/root/modified_tb_driver/tb.c:2302 [thunderbolt]tb_resume_noirq =_ "resuming...\n"
/root/modified_tb_driver/tb.c:2341 [thunderbolt]tb_resume_noirq =_ "tunnels restarted, sleeping for 100ms\n"
/root/modified_tb_driver/tb.c:2346 [thunderbolt]tb_resume_noirq =_ "resume finished\n"
/root/modified_tb_driver/tb.c:2525 [thunderbolt]tb_apple_add_links =_ "created link from %s\n"
/root/modified_tb_driver/tb.c:2561 [thunderbolt]tb_probe =_ "using software connection manager\n"
/root/modified_tb_driver/ctl.c:277 [thunderbolt]tb_cfg_print_error =_ "%llx:%x: invalid config space or offset\n"
/root/modified_tb_driver/ctl.c:670 [thunderbolt]tb_ctl_alloc =_ "control channel created\n"
/root/modified_tb_driver/ctl.c:713 [thunderbolt]tb_ctl_start =_ "control channel starting...\n"
/root/modified_tb_driver/ctl.c:743 [thunderbolt]tb_ctl_stop =_ "control channel stopped\n"
/root/modified_tb_driver/ctl.c:804 [thunderbolt]tb_cfg_ack_notification =_ "acking %s (%#x) notification on %llx\n"
/root/modified_tb_driver/ctl.c:829 [thunderbolt]tb_cfg_ack_plug =_ "acking hot %splug event on %llx:%u\n"
/root/modified_tb_driver/nhi.c:141 [thunderbolt]ring_interrupt_active =_ "%s interrupt at register %#x bit %d (%#x -> %#x)\n"
/root/modified_tb_driver/nhi.c:524 [thunderbolt]nhi_alloc_hop =_ "quirking E2E TX HopID %u -> %u\n"
/root/modified_tb_driver/nhi.c:595 [thunderbolt]tb_ring_alloc =_ "allocating %s ring %d of size %d\n"
/root/modified_tb_driver/nhi.c:704 [thunderbolt]tb_ring_start =_ "starting %s %d\n"
/root/modified_tb_driver/nhi.c:741 [thunderbolt]tb_ring_start =_ "enabling E2E for %s %d with TX HopID %d\n"
/root/modified_tb_driver/nhi.c:745 [thunderbolt]tb_ring_start =_ "enabling E2E for %s %d\n"
/root/modified_tb_driver/nhi.c:779 [thunderbolt]tb_ring_stop =_ "stopping %s %d\n"
/root/modified_tb_driver/nhi.c:848 [thunderbolt]tb_ring_free =_ "freeing %s %d\n"
/root/modified_tb_driver/nhi.c:1147 [thunderbolt]nhi_shutdown =_ "shutdown\n"
/root/modified_tb_driver/nhi.c:1233 [thunderbolt]nhi_check_iommu =_ "IOMMU DMA protection is %s\n"
/root/modified_tb_driver/nhi.c:1248 [thunderbolt]nhi_reset =_ "skipping host router reset\n"
/root/modified_tb_driver/domain.c:456 [thunderbolt]tb_domain_add =_ "security level set to %s\n"

Re: Inquiry about tb/usb4 driver

[mika.westerberg]

Hi,

On Mon, Mar 11, 2024 at 11:11:45AM +0000, mohamed.rayan@siemens.com wrote:
> Hello Mike,
> 
> Sorry for my late response,
> 
> Kindly find the request log info as attached.
> 
> Please note that I have generated this log using the following steps:
>     1- echo "module thunderbolt +p" > /sys/kernel/debug/dynamic_debug/control
>     2- To get the debug data I have ran: cat /sys/kernel/debug/dynamic_debug/control | grep thunderbolt

You need to run "dmesg" to get the debug data. Please do 1) and then
repro and send the output of "dmesg" to me.

Thanks!

RE: Inquiry about tb/usb4 driver

[mohamed.rayan]

[-- Attachment #1: Type: text/plain, Size: 1331 bytes --]

Hi Mike,

I have enabled the dmesg as per your instructions below,

Kindly check the log as attached and let me know if you need anything else.

Regards,
Mohamed

-----Original Message-----
From: mika.westerberg@linux.intel.com <mika.westerberg@linux.intel.com> 
Sent: Monday, March 11, 2024 1:56 PM
To: Rayan, Mohamed (DI SW ICS MNA RD HAV4 VER) <mohamed.rayan@siemens.com>
Cc: andreas.noever@gmail.com; michael.jamet@intel.com; YehezkelShB@gmail.com; linux-usb@vger.kernel.org; Samy, Mohamed (DI SW ICS MNA RD HAV4) <mohamed.samy@siemens.com>; El Nahas, Mohamed (DI SW ICS MNA RD HAV4) <mohamed.el_nahas@siemens.com>; Hassan, Ahmed (DI SW ICS MNA RD HAV4 HW) <ahmed_mohammed@siemens.com>
Subject: Re: Inquiry about tb/usb4 driver

Hi,

On Mon, Mar 11, 2024 at 11:11:45AM +0000, mohamed.rayan@siemens.com wrote:
> Hello Mike,
> 
> Sorry for my late response,
> 
> Kindly find the request log info as attached.
> 
> Please note that I have generated this log using the following steps:
>     1- echo "module thunderbolt +p" > /sys/kernel/debug/dynamic_debug/control
>     2- To get the debug data I have ran: cat 
> /sys/kernel/debug/dynamic_debug/control | grep thunderbolt

You need to run "dmesg" to get the debug data. Please do 1) and then repro and send the output of "dmesg" to me.

Thanks!

[-- Attachment #2: dmesg_tb.log --]
[-- Type: application/octet-stream, Size: 79981 bytes --]

[    0.000000] Linux version 6.5.0-10-generic (buildd@lcy02-amd64-118) (x86_64-linux-gnu-gcc-13 (Ubuntu 13.2.0-4ubuntu3) 13.2.0, GNU ld (GNU Binutils for Ubuntu) 2.41) #10-Ubuntu SMP PREEMPT_DYNAMIC Fri Oct 13 13:49:38 UTC 2023 (Ubuntu 6.5.0-10.10-generic 6.5.3)
[    0.000000] Command line: BOOT_IMAGE=/boot/vmlinuz-6.5.0-10-generic root=UUID=12ebc2bd-f8d9-4f14-a810-1a4f3163c572 ro quiet splash vt.handoff=7
[    0.000000] KERNEL supported cpus:
[    0.000000]   Intel GenuineIntel
[    0.000000]   AMD AuthenticAMD
[    0.000000]   Hygon HygonGenuine
[    0.000000]   Centaur CentaurHauls
[    0.000000]   zhaoxin   Shanghai  
[    0.000000] BIOS-provided physical RAM map:
[    0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
[    0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
[    0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000007ffd9fff] usable
[    0.000000] BIOS-e820: [mem 0x000000007ffda000-0x000000007fffffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
[    0.000000] BIOS-e820: [mem 0x0000000100000000-0x000000027fffffff] usable
[    0.000000] NX (Execute Disable) protection: active
[    0.000000] SMBIOS 2.8 present.
[    0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.14.0-0-g155821a-20210629_105355-sharpie 04/01/2014
[    0.000000] Hypervisor detected: KVM
[    0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
[    0.000001] kvm-clock: using sched offset of 4341469753 cycles
[    0.000003] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
[    0.000009] tsc: Detected 2399.996 MHz processor
[    0.000881] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
[    0.000884] e820: remove [mem 0x000a0000-0x000fffff] usable
[    0.000890] last_pfn = 0x280000 max_arch_pfn = 0x400000000
[    0.000922] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs
[    0.000924] x86/PAT: PAT not supported by the CPU.
[    0.000927] x86/PAT: Configuration [0-7]: WB  WT  UC- UC  WB  WT  UC- UC  
[    0.000967] last_pfn = 0x7ffda max_arch_pfn = 0x400000000
[    0.010741] found SMP MP-table at [mem 0x000f5b70-0x000f5b7f]
[    0.011410] RAMDISK: [mem 0x31395000-0x349c1fff]
[    0.011768] ACPI: Early table checksum verification disabled
[    0.011780] ACPI: RSDP 0x00000000000F5B30 000014 (v00 BOCHS )
[    0.011785] ACPI: RSDT 0x000000007FFE1FD7 000038 (v01 BOCHS  BXPC     00000001 BXPC 00000001)
[    0.011796] ACPI: FACP 0x000000007FFE1DB7 0000F4 (v03 BOCHS  BXPC     00000001 BXPC 00000001)
[    0.011804] ACPI: DSDT 0x000000007FFDFDC0 001FF7 (v01 BOCHS  BXPC     00000001 BXPC 00000001)
[    0.011808] ACPI: FACS 0x000000007FFDFD80 000040
[    0.011812] ACPI: APIC 0x000000007FFE1EAB 000090 (v01 BOCHS  BXPC     00000001 BXPC 00000001)
[    0.011816] ACPI: HPET 0x000000007FFE1F3B 000038 (v01 BOCHS  BXPC     00000001 BXPC 00000001)
[    0.011821] ACPI: MCFG 0x000000007FFE1F73 00003C (v01 BOCHS  BXPC     00000001 BXPC 00000001)
[    0.011825] ACPI: WAET 0x000000007FFE1FAF 000028 (v01 BOCHS  BXPC     00000001 BXPC 00000001)
[    0.011828] ACPI: Reserving FACP table memory at [mem 0x7ffe1db7-0x7ffe1eaa]
[    0.011830] ACPI: Reserving DSDT table memory at [mem 0x7ffdfdc0-0x7ffe1db6]
[    0.011830] ACPI: Reserving FACS table memory at [mem 0x7ffdfd80-0x7ffdfdbf]
[    0.011831] ACPI: Reserving APIC table memory at [mem 0x7ffe1eab-0x7ffe1f3a]
[    0.011832] ACPI: Reserving HPET table memory at [mem 0x7ffe1f3b-0x7ffe1f72]
[    0.011833] ACPI: Reserving MCFG table memory at [mem 0x7ffe1f73-0x7ffe1fae]
[    0.011834] ACPI: Reserving WAET table memory at [mem 0x7ffe1faf-0x7ffe1fd6]
[    0.015757] No NUMA configuration found
[    0.015759] Faking a node at [mem 0x0000000000000000-0x000000027fffffff]
[    0.015772] NODE_DATA(0) allocated [mem 0x27ffd0000-0x27fffafff]
[    0.015945] Zone ranges:
[    0.015946]   DMA      [mem 0x0000000000001000-0x0000000000ffffff]
[    0.015948]   DMA32    [mem 0x0000000001000000-0x00000000ffffffff]
[    0.015950]   Normal   [mem 0x0000000100000000-0x000000027fffffff]
[    0.015951]   Device   empty
[    0.015952] Movable zone start for each node
[    0.015955] Early memory node ranges
[    0.015955]   node   0: [mem 0x0000000000001000-0x000000000009efff]
[    0.015957]   node   0: [mem 0x0000000000100000-0x000000007ffd9fff]
[    0.015958]   node   0: [mem 0x0000000100000000-0x000000027fffffff]
[    0.015962] Initmem setup node 0 [mem 0x0000000000001000-0x000000027fffffff]
[    0.016360] On node 0, zone DMA: 1 pages in unavailable ranges
[    0.016406] On node 0, zone DMA: 97 pages in unavailable ranges
[    0.049562] On node 0, zone Normal: 38 pages in unavailable ranges
[    0.078090] ACPI: PM-Timer IO Port: 0x608
[    0.078108] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
[    0.078166] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
[    0.078171] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
[    0.078173] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
[    0.078174] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
[    0.078179] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
[    0.078180] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
[    0.078186] ACPI: Using ACPI (MADT) for SMP configuration information
[    0.078188] ACPI: HPET id: 0x8086a201 base: 0xfed00000
[    0.078195] smpboot: Allowing 4 CPUs, 0 hotplug CPUs
[    0.078226] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]
[    0.078229] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x0009ffff]
[    0.078230] PM: hibernation: Registered nosave memory: [mem 0x000a0000-0x000effff]
[    0.078231] PM: hibernation: Registered nosave memory: [mem 0x000f0000-0x000fffff]
[    0.078233] PM: hibernation: Registered nosave memory: [mem 0x7ffda000-0x7fffffff]
[    0.078234] PM: hibernation: Registered nosave memory: [mem 0x80000000-0xafffffff]
[    0.078235] PM: hibernation: Registered nosave memory: [mem 0xb0000000-0xbfffffff]
[    0.078236] PM: hibernation: Registered nosave memory: [mem 0xc0000000-0xfed1bfff]
[    0.078237] PM: hibernation: Registered nosave memory: [mem 0xfed1c000-0xfed1ffff]
[    0.078238] PM: hibernation: Registered nosave memory: [mem 0xfed20000-0xfeffbfff]
[    0.078238] PM: hibernation: Registered nosave memory: [mem 0xfeffc000-0xfeffffff]
[    0.078239] PM: hibernation: Registered nosave memory: [mem 0xff000000-0xfffbffff]
[    0.078240] PM: hibernation: Registered nosave memory: [mem 0xfffc0000-0xffffffff]
[    0.078242] [mem 0xc0000000-0xfed1bfff] available for PCI devices
[    0.078243] Booting paravirtualized kernel on KVM
[    0.078248] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645519600211568 ns
[    0.078260] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1
[    0.078909] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288
[    0.078914] pcpu-alloc: s221184 r8192 d28672 u524288 alloc=1*2097152
[    0.078917] pcpu-alloc: [0] 0 1 2 3 
[    0.078941] kvm-guest: PV spinlocks disabled, no host support
[    0.078942] Kernel command line: BOOT_IMAGE=/boot/vmlinuz-6.5.0-10-generic root=UUID=12ebc2bd-f8d9-4f14-a810-1a4f3163c572 ro quiet splash vt.handoff=7
[    0.079035] Unknown kernel command line parameters "splash BOOT_IMAGE=/boot/vmlinuz-6.5.0-10-generic", will be passed to user space.
[    0.081139] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, linear)
[    0.082143] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)
[    0.082262] Fallback order for Node 0: 0 
[    0.082266] Built 1 zonelists, mobility grouping on.  Total pages: 2064090
[    0.082268] Policy zone: Normal
[    0.082279] mem auto-init: stack:all(zero), heap alloc:on, heap free:off
[    0.082304] software IO TLB: area num 4.
[    0.121080] Memory: 8059244K/8388064K available (20480K kernel code, 4268K rwdata, 13520K rodata, 4788K init, 17396K bss, 328560K reserved, 0K cma-reserved)
[    0.127769] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[    0.127861] Kernel/User page tables isolation: enabled
[    0.127939] ftrace: allocating 55224 entries in 216 pages
[    0.141517] ftrace: allocated 216 pages with 4 groups
[    0.142533] Dynamic Preempt: voluntary
[    0.142987] rcu: Preemptible hierarchical RCU implementation.
[    0.142988] rcu: 	RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4.
[    0.142989] 	Trampoline variant of Tasks RCU enabled.
[    0.142990] 	Rude variant of Tasks RCU enabled.
[    0.142990] 	Tracing variant of Tasks RCU enabled.
[    0.142991] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
[    0.142992] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4
[    0.146329] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16
[    0.146556] rcu: srcu_init: Setting srcu_struct sizes based on contention.
[    0.146629] Console: colour dummy device 80x25
[    0.146632] printk: console [tty0] enabled
[    0.146816] ACPI: Core revision 20230331
[    0.147112] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns
[    0.147287] APIC: Switch to symmetric I/O mode setup
[    0.147621] x2apic enabled
[    0.147956] Switched APIC routing to physical x2apic.
[    0.149431] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
[    0.149463] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229833f6470, max_idle_ns: 440795327230 ns
[    0.149468] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=9599984)
[    0.149601] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
[    0.149603] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
[    0.149605] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization
[    0.149607] Spectre V2 : Mitigation: Retpolines
[    0.149608] Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch
[    0.149609] Spectre V2 : Spectre v2 / SpectreRSB : Filling RSB on VMEXIT
[    0.149610] Speculative Store Bypass: Vulnerable
[    0.149613] MDS: Vulnerable: Clear CPU buffers attempted, no microcode
[    0.149614] MMIO Stale Data: Unknown: No mitigations
[    0.149616] x86/fpu: x87 FPU will use FXSAVE
[    0.173757] Freeing SMP alternatives memory: 44K
[    0.173760] pid_max: default: 32768 minimum: 301
[    0.174302] LSM: initializing lsm=lockdown,capability,landlock,yama,apparmor,integrity
[    0.174492] landlock: Up and running.
[    0.174493] Yama: becoming mindful.
[    0.174556] AppArmor: AppArmor initialized
[    0.174790] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, linear)
[    0.174801] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, linear)
[    0.283459] smpboot: CPU0: Intel QEMU Virtual CPU version 2.5+ (family: 0x6, model: 0x6, stepping: 0x3)
[    0.283745] RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1.
[    0.283763] RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1.
[    0.283778] RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1.
[    0.283791] Performance Events: PMU not available due to virtualization, using software events only.
[    0.283849] signal: max sigframe size: 1440
[    0.283879] rcu: Hierarchical SRCU implementation.
[    0.283880] rcu: 	Max phase no-delay instances is 1000.
[    0.284205] NMI watchdog: Perf NMI watchdog permanently disabled
[    0.284270] smp: Bringing up secondary CPUs ...
[    0.284397] smpboot: x86: Booting SMP configuration:
[    0.284398] .... node  #0, CPUs:      #1 #2 #3
[    0.002902] smpboot: CPU 1 Converting physical 0 to logical die 1
[    0.002902] smpboot: CPU 2 Converting physical 0 to logical die 2
[    0.002902] smpboot: CPU 3 Converting physical 0 to logical die 3
[    0.293538] smp: Brought up 1 node, 4 CPUs
[    0.293542] smpboot: Max logical packages: 4
[    0.293544] smpboot: Total of 4 processors activated (19199.96 BogoMIPS)
[    0.294219] devtmpfs: initialized
[    0.294219] x86/mm: Memory block size: 128MB
[    0.298117] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[    0.298117] futex hash table entries: 1024 (order: 4, 65536 bytes, linear)
[    0.298117] pinctrl core: initialized pinctrl subsystem
[    0.298117] PM: RTC time: 15:57:02, date: 2024-03-11
[    0.299255] NET: Registered PF_NETLINK/PF_ROUTE protocol family
[    0.299971] DMA: preallocated 1024 KiB GFP_KERNEL pool for atomic allocations
[    0.300513] DMA: preallocated 1024 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
[    0.300700] DMA: preallocated 1024 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
[    0.300709] audit: initializing netlink subsys (disabled)
[    0.301510] audit: type=2000 audit(1710165423.663:1): state=initialized audit_enabled=0 res=1
[    0.301660] thermal_sys: Registered thermal governor 'fair_share'
[    0.301662] thermal_sys: Registered thermal governor 'bang_bang'
[    0.301664] thermal_sys: Registered thermal governor 'step_wise'
[    0.301664] thermal_sys: Registered thermal governor 'user_space'
[    0.301665] thermal_sys: Registered thermal governor 'power_allocator'
[    0.301676] EISA bus registered
[    0.301685] cpuidle: using governor ladder
[    0.301689] cpuidle: using governor menu
[    0.301821] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
[    0.302151] PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xb0000000-0xbfffffff] (base 0xb0000000)
[    0.302156] PCI: MMCONFIG at [mem 0xb0000000-0xbfffffff] reserved as E820 entry
[    0.302165] PCI: Using configuration type 1 for base access
[    0.302365] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.
[    0.339605] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
[    0.339605] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page
[    0.339605] ACPI: Added _OSI(Module Device)
[    0.339605] ACPI: Added _OSI(Processor Device)
[    0.339605] ACPI: Added _OSI(3.0 _SCP Extensions)
[    0.339605] ACPI: Added _OSI(Processor Aggregator Device)
[    0.342410] ACPI: 1 ACPI AML tables successfully acquired and loaded
[    0.343552] ACPI: Interpreter enabled
[    0.343552] ACPI: PM: (supports S0 S3 S4 S5)
[    0.343552] ACPI: Using IOAPIC for interrupt routing
[    0.343552] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[    0.343552] PCI: Using E820 reservations for host bridge windows
[    0.343552] ACPI: Enabled 1 GPEs in block 00 to 3F
[    0.346625] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[    0.346632] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI EDR HPX-Type3]
[    0.346684] acpi PNP0A08:00: _OSC: platform does not support [LTR DPC]
[    0.346758] acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug SHPCHotplug PME AER PCIeCapability]
[    0.346774] acpi PNP0A08:00: host bridge window [mem 0x280000000-0x1027fffffff window] ([0x10000000000-0x1027fffffff] ignored, not CPU addressable)
[    0.348380] PCI host bridge to bus 0000:00
[    0.348383] pci_bus 0000:00: root bus resource [io  0x0000-0x0cf7 window]
[    0.348386] pci_bus 0000:00: root bus resource [io  0x0d00-0xffff window]
[    0.348388] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
[    0.348389] pci_bus 0000:00: root bus resource [mem 0x80000000-0xafffffff window]
[    0.348391] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]
[    0.348392] pci_bus 0000:00: root bus resource [mem 0x280000000-0xffffffffff window]
[    0.348394] pci_bus 0000:00: root bus resource [bus 00-ff]
[    0.348472] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000
[    0.349062] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000
[    0.350234] pci 0000:00:01.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref]
[    0.353521] pci 0000:00:01.0: reg 0x18: [mem 0xfea70000-0xfea70fff]
[    0.358894] pci 0000:00:01.0: reg 0x30: [mem 0xfea60000-0xfea6ffff pref]
[    0.358997] pci 0000:00:01.0: BAR 0: assigned to efifb
[    0.359031] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
[    0.359418] pci 0000:00:02.0: [8086:100e] type 00 class 0x020000
[    0.360741] pci 0000:00:02.0: reg 0x10: [mem 0xfea40000-0xfea5ffff]
[    0.362034] pci 0000:00:02.0: reg 0x14: [io  0xc000-0xc03f]
[    0.367025] pci 0000:00:02.0: reg 0x30: [mem 0xfea00000-0xfea3ffff pref]
[    0.371927] pci 0000:00:04.0: [14ab:1000] type 01 class 0x060400
[    0.439598] pci 0000:00:04.0: PME# supported from D3hot D3cold
[    0.455623] pci 0000:00:05.0: [14ab:1000] type 01 class 0x060400
[    0.515634] pci 0000:00:05.0: PME# supported from D3hot D3cold
[    0.535158] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300
[    0.538800] pci 0000:00:1d.0: reg 0x20: [io  0xc080-0xc09f]
[    0.540415] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300
[    0.543726] pci 0000:00:1d.1: reg 0x20: [io  0xc0a0-0xc0bf]
[    0.545245] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300
[    0.548512] pci 0000:00:1d.2: reg 0x20: [io  0xc0c0-0xc0df]
[    0.549802] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320
[    0.550403] pci 0000:00:1d.7: reg 0x10: [mem 0xfea71000-0xfea71fff]
[    0.553959] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100
[    0.554748] pci 0000:00:1f.0: quirk: [io  0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO
[    0.555171] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601
[    0.559989] pci 0000:00:1f.2: reg 0x20: [io  0xc0e0-0xc0ff]
[    0.560719] pci 0000:00:1f.2: reg 0x24: [mem 0xfea72000-0xfea72fff]
[    0.562000] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500
[    0.564574] pci 0000:00:1f.3: reg 0x20: [io  0x0700-0x073f]
[    0.580255] pci 0000:01:00.0: [14ab:124a] type 00 class 0x0c0340
[    0.585062] pci 0000:01:00.0: reg 0x10: [mem 0xfe800000-0xfe83ffff]
[    0.628351] pci 0000:00:04.0: PCI bridge to [bus 01]
[    0.630558] pci 0000:00:04.0:   bridge window [mem 0xfe800000-0xfe9fffff]
[    0.640695] pci 0000:00:05.0: PCI bridge to [bus 02]
[    0.650546] ACPI: PCI: Interrupt link LNKA configured for IRQ 10
[    0.650751] ACPI: PCI: Interrupt link LNKB configured for IRQ 10
[    0.650913] ACPI: PCI: Interrupt link LNKC configured for IRQ 11
[    0.651085] ACPI: PCI: Interrupt link LNKD configured for IRQ 11
[    0.651241] ACPI: PCI: Interrupt link LNKE configured for IRQ 10
[    0.651398] ACPI: PCI: Interrupt link LNKF configured for IRQ 10
[    0.651578] ACPI: PCI: Interrupt link LNKG configured for IRQ 11
[    0.651745] ACPI: PCI: Interrupt link LNKH configured for IRQ 11
[    0.651806] ACPI: PCI: Interrupt link GSIA configured for IRQ 16
[    0.651823] ACPI: PCI: Interrupt link GSIB configured for IRQ 17
[    0.651846] ACPI: PCI: Interrupt link GSIC configured for IRQ 18
[    0.651862] ACPI: PCI: Interrupt link GSID configured for IRQ 19
[    0.651878] ACPI: PCI: Interrupt link GSIE configured for IRQ 20
[    0.651893] ACPI: PCI: Interrupt link GSIF configured for IRQ 21
[    0.651909] ACPI: PCI: Interrupt link GSIG configured for IRQ 22
[    0.651925] ACPI: PCI: Interrupt link GSIH configured for IRQ 23
[    0.652792] iommu: Default domain type: Translated
[    0.652792] iommu: DMA domain TLB invalidation policy: lazy mode
[    0.652792] SCSI subsystem initialized
[    0.653500] libata version 3.00 loaded.
[    0.653602] ACPI: bus type USB registered
[    0.653633] usbcore: registered new interface driver usbfs
[    0.653649] usbcore: registered new interface driver hub
[    0.653657] usbcore: registered new device driver usb
[    0.653703] pps_core: LinuxPPS API ver. 1 registered
[    0.653705] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[    0.653714] PTP clock support registered
[    0.653742] EDAC MC: Ver: 3.0.0
[    0.657989] NetLabel: Initializing
[    0.657992] NetLabel:  domain hash size = 128
[    0.657993] NetLabel:  protocols = UNLABELED CIPSOv4 CALIPSO
[    0.658033] NetLabel:  unlabeled traffic allowed by default
[    0.658072] mctp: management component transport protocol core
[    0.658072] NET: Registered PF_MCTP protocol family
[    0.658072] PCI: Using ACPI for IRQ routing
[    0.822124] PCI: pci_cache_line_size set to 64 bytes
[    0.825601] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff]
[    0.825609] e820: reserve RAM buffer [mem 0x7ffda000-0x7fffffff]
[    0.825660] pci 0000:00:01.0: vgaarb: setting as boot VGA device
[    0.825660] pci 0000:00:01.0: vgaarb: bridge control possible
[    0.825660] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none
[    0.825660] vgaarb: loaded
[    0.826781] hpet: 3 channels of 0 reserved for per-cpu timers
[    0.826805] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
[    0.826809] hpet0: 3 comparators, 64-bit 100.000000 MHz counter
[    0.831654] clocksource: Switched to clocksource kvm-clock
[    0.844892] VFS: Disk quotas dquot_6.6.0
[    0.844935] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[    0.845168] AppArmor: AppArmor Filesystem Enabled
[    0.845205] pnp: PnP ACPI init
[    0.845450] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved
[    0.845823] pnp: PnP ACPI: found 6 devices
[    0.853608] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
[    0.853815] NET: Registered PF_INET protocol family
[    0.853917] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, linear)
[    0.856125] tcp_listen_portaddr_hash hash table entries: 4096 (order: 4, 65536 bytes, linear)
[    0.856147] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
[    0.856185] TCP established hash table entries: 65536 (order: 7, 524288 bytes, linear)
[    0.856691] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, linear)
[    0.856919] TCP: Hash tables configured (established 65536 bind 65536)
[    0.857049] MPTCP token hash table entries: 8192 (order: 5, 196608 bytes, linear)
[    0.857094] UDP hash table entries: 4096 (order: 5, 131072 bytes, linear)
[    0.857114] UDP-Lite hash table entries: 4096 (order: 5, 131072 bytes, linear)
[    0.857236] NET: Registered PF_UNIX/PF_LOCAL protocol family
[    0.857250] NET: Registered PF_XDP protocol family
[    0.857269] pci 0000:00:04.0: PCI bridge to [bus 01]
[    0.871866] pci 0000:00:04.0:   bridge window [mem 0xfe800000-0xfe9fffff]
[    0.895682] pci 0000:00:05.0: PCI bridge to [bus 02]
[    0.933745] pci_bus 0000:00: resource 4 [io  0x0000-0x0cf7 window]
[    0.933750] pci_bus 0000:00: resource 5 [io  0x0d00-0xffff window]
[    0.933751] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]
[    0.933753] pci_bus 0000:00: resource 7 [mem 0x80000000-0xafffffff window]
[    0.933755] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]
[    0.933757] pci_bus 0000:00: resource 9 [mem 0x280000000-0xffffffffff window]
[    0.933759] pci_bus 0000:01: resource 1 [mem 0xfe800000-0xfe9fffff]
[    0.935712] ACPI: \_SB_.GSIA: Enabled at IRQ 16
[    0.936604] ACPI: \_SB_.GSIB: Enabled at IRQ 17
[    0.937567] ACPI: \_SB_.GSIC: Enabled at IRQ 18
[    0.938285] ACPI: \_SB_.GSID: Enabled at IRQ 19
[    0.939366] PCI: CLS 64 bytes, default 64
[    0.939418] PCI-DMA: Using software bounce buffering for IO (SWIOTLB)
[    0.939440] software IO TLB: mapped [mem 0x000000007bfda000-0x000000007ffda000] (64MB)
[    0.939525] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229833f6470, max_idle_ns: 440795327230 ns
[    0.939555] Trying to unpack rootfs image as initramfs...
[    0.939915] Initialise system trusted keyrings
[    0.939945] Key type blacklist registered
[    0.940072] workingset: timestamp_bits=36 max_order=21 bucket_order=0
[    0.940093] zbud: loaded
[    0.941867] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[    0.942582] fuse: init (API version 7.38)
[    0.943010] integrity: Platform Keyring initialized
[    0.943015] integrity: Machine keyring initialized
[    0.951721] Key type asymmetric registered
[    0.951729] Asymmetric key parser 'x509' registered
[    0.951766] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 243)
[    0.951891] io scheduler mq-deadline registered
[    0.953374] ACPI: \_SB_.GSIE: Enabled at IRQ 20
[    0.969959] pcieport 0000:00:04.0: PME: Signaling with IRQ 24
[    0.987714] ACPI: \_SB_.GSIF: Enabled at IRQ 21
[    1.004504] pcieport 0000:00:05.0: PME: Signaling with IRQ 25
[    1.016522] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4
[    1.016621] efifb: probing for efifb
[    1.016639] efifb: No BGRT, not showing boot graphics
[    1.016640] efifb: framebuffer at 0xfd000000, using 1408k, total 1408k
[    1.016641] efifb: mode is 800x600x24, linelength=2400, pages=1
[    1.016643] efifb: scrolling: redraw
[    1.016644] efifb: Truecolor: size=0:8:8:8, shift=0:16:8:0
[    1.016760] fbcon: Deferring console take-over
[    1.016762] fb0: EFI VGA frame buffer device
[    1.016855] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0
[    1.017232] ACPI: button: Power Button [PWRF]
[    1.017690] Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled
[    1.042326] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
[    1.045543] Linux agpgart interface v0.103
[    1.054896] Freeing initrd memory: 55476K
[    1.057974] loop: module loaded
[    1.058340] tun: Universal TUN/TAP device driver, 1.6
[    1.058437] PPP generic driver version 2.4.2
[    1.059889] ehci-pci 0000:00:1d.7: EHCI Host Controller
[    1.059906] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1
[    1.060171] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfea71000
[    1.074981] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00
[    1.075080] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.05
[    1.075083] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    1.075085] usb usb1: Product: EHCI Host Controller
[    1.075087] usb usb1: Manufacturer: Linux 6.5.0-10-generic ehci_hcd
[    1.075088] usb usb1: SerialNumber: 0000:00:1d.7
[    1.075299] hub 1-0:1.0: USB hub found
[    1.075312] hub 1-0:1.0: 6 ports detected
[    1.075639] uhci_hcd 0000:00:1d.0: UHCI Host Controller
[    1.075647] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2
[    1.075676] uhci_hcd 0000:00:1d.0: detected 2 ports
[    1.075797] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c080
[    1.075932] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.05
[    1.075937] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    1.075940] usb usb2: Product: UHCI Host Controller
[    1.075942] usb usb2: Manufacturer: Linux 6.5.0-10-generic uhci_hcd
[    1.075955] usb usb2: SerialNumber: 0000:00:1d.0
[    1.076178] hub 2-0:1.0: USB hub found
[    1.076183] hub 2-0:1.0: 2 ports detected
[    1.076952] uhci_hcd 0000:00:1d.1: UHCI Host Controller
[    1.076969] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3
[    1.076987] uhci_hcd 0000:00:1d.1: detected 2 ports
[    1.077102] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c0a0
[    1.077181] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.05
[    1.077184] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    1.077186] usb usb3: Product: UHCI Host Controller
[    1.077187] usb usb3: Manufacturer: Linux 6.5.0-10-generic uhci_hcd
[    1.077188] usb usb3: SerialNumber: 0000:00:1d.1
[    1.077337] hub 3-0:1.0: USB hub found
[    1.077343] hub 3-0:1.0: 2 ports detected
[    1.078056] uhci_hcd 0000:00:1d.2: UHCI Host Controller
[    1.078062] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4
[    1.078080] uhci_hcd 0000:00:1d.2: detected 2 ports
[    1.078191] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c0c0
[    1.078284] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.05
[    1.078287] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    1.078289] usb usb4: Product: UHCI Host Controller
[    1.078290] usb usb4: Manufacturer: Linux 6.5.0-10-generic uhci_hcd
[    1.078291] usb usb4: SerialNumber: 0000:00:1d.2
[    1.078465] hub 4-0:1.0: USB hub found
[    1.078471] hub 4-0:1.0: 2 ports detected
[    1.078652] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
[    1.079631] serio: i8042 KBD port at 0x60,0x64 irq 1
[    1.079638] serio: i8042 AUX port at 0x60,0x64 irq 12
[    1.079838] mousedev: PS/2 mouse device common for all mice
[    1.080042] rtc_cmos 00:04: RTC can wake from S4
[    1.080613] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1
[    1.081091] rtc_cmos 00:04: registered as rtc0
[    1.081189] rtc_cmos 00:04: setting system clock to 2024-03-11T15:57:03 UTC (1710172623)
[    1.081257] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs
[    1.081267] i2c_dev: i2c /dev entries driver
[    1.081289] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.
[    1.081327] device-mapper: uevent: version 1.0.3
[    1.081444] device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com
[    1.081470] platform eisa.0: Probing EISA bus 0
[    1.081472] platform eisa.0: EISA: Cannot allocate resource for mainboard
[    1.081487] platform eisa.0: Cannot allocate resource for EISA slot 1
[    1.081488] platform eisa.0: Cannot allocate resource for EISA slot 2
[    1.081490] platform eisa.0: Cannot allocate resource for EISA slot 3
[    1.081491] platform eisa.0: Cannot allocate resource for EISA slot 4
[    1.081492] platform eisa.0: Cannot allocate resource for EISA slot 5
[    1.081493] platform eisa.0: Cannot allocate resource for EISA slot 6
[    1.081506] platform eisa.0: Cannot allocate resource for EISA slot 7
[    1.081507] platform eisa.0: Cannot allocate resource for EISA slot 8
[    1.081508] platform eisa.0: EISA: Detected 0 cards
[    1.081511] intel_pstate: CPU model not supported
[    1.081644] ledtrig-cpu: registered to indicate activity on CPUs
[    1.081717] drop_monitor: Initializing network drop monitor service
[    1.096034] NET: Registered PF_INET6 protocol family
[    1.106238] Segment Routing with IPv6
[    1.106260] In-situ OAM (IOAM) with IPv6
[    1.106308] NET: Registered PF_PACKET protocol family
[    1.106401] Key type dns_resolver registered
[    1.106952] IPI shorthand broadcast: enabled
[    1.108311] sched_clock: Marking stable (1108004633, -1097384)->(1185785020, -78877771)
[    1.108562] registered taskstats version 1
[    1.108923] Loading compiled-in X.509 certificates
[    1.109657] Loaded X.509 cert 'Build time autogenerated kernel key: d958bf91db860e84e483a11e67904e1cf15a98a5'
[    1.110292] Loaded X.509 cert 'Canonical Ltd. Live Patch Signing: 14df34d1a87cf37625abec039ef2bf521249b969'
[    1.110844] Loaded X.509 cert 'Canonical Ltd. Kernel Module Signing: 88f752e560a1e0737e31163a466ad7b70a850c19'
[    1.110846] blacklist: Loading compiled-in revocation X.509 certificates
[    1.110872] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing: 61482aa2830d0ab2ad5af10b7250da9033ddcef0'
[    1.110886] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2017): 242ade75ac4a15e50d50c84b0d45ff3eae707a03'
[    1.110932] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (ESM 2018): 365188c1d374d6b07c3c8f240f8ef722433d6a8b'
[    1.110951] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2019): c0746fd6c5da3ae827864651ad66ae47fe24b3e8'
[    1.110966] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v1): a8d54bbb3825cfb94fa13c9f8a594a195c107b8d'
[    1.110983] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v2): 4cf046892d6fd3c9a5b03f98d845f90851dc6a8c'
[    1.111023] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v3): 100437bb6de6e469b581e61cd66bce3ef4ed53af'
[    1.111043] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (Ubuntu Core 2019): c1d57b8f6b743f23ee41f4f7ee292f06eecadfb9'
[    1.112965] Key type .fscrypt registered
[    1.112967] Key type fscrypt-provisioning registered
[    1.117038] Key type encrypted registered
[    1.117043] AppArmor: AppArmor sha1 policy hashing enabled
[    1.117058] ima: No TPM chip found, activating TPM-bypass!
[    1.117066] Loading compiled-in module X.509 certificates
[    1.117620] Loaded X.509 cert 'Build time autogenerated kernel key: d958bf91db860e84e483a11e67904e1cf15a98a5'
[    1.117623] ima: Allocated hash algorithm: sha1
[    1.117630] ima: No architecture policies found
[    1.117650] evm: Initialising EVM extended attributes:
[    1.117651] evm: security.selinux
[    1.117652] evm: security.SMACK64
[    1.117653] evm: security.SMACK64EXEC
[    1.117653] evm: security.SMACK64TRANSMUTE
[    1.117654] evm: security.SMACK64MMAP
[    1.117655] evm: security.apparmor
[    1.117656] evm: security.ima
[    1.117656] evm: security.capability
[    1.117657] evm: HMAC attrs: 0x1
[    1.117982] PM:   Magic number: 0:840:992
[    1.118048] memory memory35: hash matches
[    1.121877] RAS: Correctable Errors collector initialized.
[    1.121952] clk: Disabling unused clocks
[    1.123968] Freeing unused decrypted memory: 2036K
[    1.125646] Freeing unused kernel image (initmem) memory: 4788K
[    1.178974] Write protecting the kernel read-only data: 34816k
[    1.179545] Freeing unused kernel image (rodata/data gap) memory: 816K
[    1.225894] x86/mm: Checked W+X mappings: passed, no W+X pages found.
[    1.225905] x86/mm: Checking user space page tables
[    1.271982] x86/mm: Checked W+X mappings: passed, no W+X pages found.
[    1.271996] Run /init as init process
[    1.271999]   with arguments:
[    1.272001]     /init
[    1.272002]     splash
[    1.272003]   with environment:
[    1.272004]     HOME=/
[    1.272004]     TERM=linux
[    1.272005]     BOOT_IMAGE=/boot/vmlinuz-6.5.0-10-generic
[    1.424899] e1000: Intel(R) PRO/1000 Network Driver
[    1.424908] e1000: Copyright (c) 1999-2006 Intel Corporation.
[    1.425275] ACPI: \_SB_.GSIG: Enabled at IRQ 22
[    1.450285] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4
[    1.450824] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3
[    1.458803] ahci 0000:00:1f.2: version 3.0
[    1.473976] ahci 0000:00:1f.2: AHCI 0001.0000 32 slots 6 ports 1.5 Gbps 0x3f impl SATA mode
[    1.473982] ahci 0000:00:1f.2: flags: 64bit ncq only 
[    1.480498] scsi host0: ahci
[    1.481062] scsi host1: ahci
[    1.482251] scsi host2: ahci
[    1.483504] scsi host3: ahci
[    1.483714] scsi host4: ahci
[    1.484267] scsi host5: ahci
[    1.484337] ata1: SATA max UDMA/133 abar m4096@0xfea72000 port 0xfea72100 irq 26
[    1.484348] ata2: SATA max UDMA/133 abar m4096@0xfea72000 port 0xfea72180 irq 26
[    1.484357] ata3: SATA max UDMA/133 abar m4096@0xfea72000 port 0xfea72200 irq 26
[    1.484365] ata4: SATA max UDMA/133 abar m4096@0xfea72000 port 0xfea72280 irq 26
[    1.484373] ata5: SATA max UDMA/133 abar m4096@0xfea72000 port 0xfea72300 irq 26
[    1.484381] ata6: SATA max UDMA/133 abar m4096@0xfea72000 port 0xfea72380 irq 26
[    1.797662] ata6: SATA link down (SStatus 0 SControl 300)
[    1.797871] ata2: SATA link down (SStatus 0 SControl 300)
[    1.798119] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[    1.798262] ata1.00: ATA-7: QEMU HARDDISK, 2.5+, max UDMA/100
[    1.798268] ata1.00: 20971520 sectors, multi 16: LBA48 NCQ (depth 32)
[    1.798271] ata1.00: applying bridge limits
[    1.798629] ata5: SATA link down (SStatus 0 SControl 300)
[    1.798820] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[    1.799038] ata4: SATA link down (SStatus 0 SControl 300)
[    1.799103] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100
[    1.799106] ata3.00: applying bridge limits
[    1.799322] ata1.00: configured for UDMA/100
[    1.799432] ata3.00: configured for UDMA/100
[    1.799645] scsi 0:0:0:0: Direct-Access     ATA      QEMU HARDDISK    2.5+ PQ: 0 ANSI: 5
[    1.799982] sd 0:0:0:0: Attached scsi generic sg0 type 0
[    1.800063] sd 0:0:0:0: [sda] 20971520 512-byte logical blocks: (10.7 GB/10.0 GiB)
[    1.800078] sd 0:0:0:0: [sda] Write Protect is off
[    1.800080] sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00
[    1.800094] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[    1.800112] sd 0:0:0:0: [sda] Preferred minimum I/O size 512 bytes
[    1.800254] scsi 2:0:0:0: CD-ROM            QEMU     QEMU DVD-ROM     2.5+ PQ: 0 ANSI: 5
[    1.801072] e1000 0000:00:02.0 eth0: (PCI:33MHz:32-bit) 52:54:00:12:34:56
[    1.801084] e1000 0000:00:02.0 eth0: Intel(R) PRO/1000 Network Connection
[    1.802444] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray
[    1.802448] cdrom: Uniform CD-ROM driver Revision: 3.20
[    1.802903] sr 2:0:0:0: [sr0] Hmm, seems the drive doesn't support multisession CD's
[    1.805124] sr 2:0:0:0: Attached scsi CD-ROM sr0
[    1.805211] sr 2:0:0:0: Attached scsi generic sg1 type 5
[    1.806844]  sda: sda1 sda2
[    1.806986] sd 0:0:0:0: [sda] Attached SCSI disk
[    1.811956] e1000 0000:00:02.0 enp0s2: renamed from eth0
[    1.925995] fbcon: Taking over console
[    1.926089] Console: switching to colour frame buffer device 100x37
[    2.106345] EXT4-fs (sda2): mounted filesystem 12ebc2bd-f8d9-4f14-a810-1a4f3163c572 ro with ordered data mode. Quota mode: none.
[    2.466827] systemd[1]: Inserted module 'autofs4'
[    2.522669] systemd[1]: systemd 253.5-1ubuntu6 running in system mode (+PAM +AUDIT +SELINUX +APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified)
[    2.522676] systemd[1]: Detected virtualization kvm.
[    2.522688] systemd[1]: Detected architecture x86-64.
[    2.526247] systemd[1]: Hostname set to <qemu-ubuntu23.1>.
[    2.548530] systemd[1]: memfd_create() called without MFD_EXEC or MFD_NOEXEC_SEAL set
[    2.961110] systemd[1]: Queued start job for default target graphical.target.
[    2.984395] systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe.
[    2.984899] systemd[1]: Created slice user.slice - User and Session Slice.
[    2.984999] systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch.
[    2.985352] systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point.
[    2.985441] systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes.
[    2.985551] systemd[1]: Reached target remote-fs.target - Remote File Systems.
[    2.985599] systemd[1]: Reached target slices.target - Slice Units.
[    2.985622] systemd[1]: Reached target snapd.mounts-pre.target - Mounting snaps.
[    2.985661] systemd[1]: Reached target swap.target - Swaps.
[    2.985702] systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes.
[    2.985977] systemd[1]: Listening on syslog.socket - Syslog Socket.
[    2.986161] systemd[1]: Listening on systemd-fsckd.socket - fsck to fsckd communication Socket.
[    2.986259] systemd[1]: Listening on systemd-initctl.socket - initctl Compatibility Named Pipe.
[    2.986468] systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log).
[    2.986672] systemd[1]: Listening on systemd-journald.socket - Journal Socket.
[    2.987070] systemd[1]: Listening on systemd-oomd.socket - Userspace Out-Of-Memory (OOM) Killer Socket.
[    2.987470] systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket.
[    2.987665] systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket.
[    2.989120] systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System...
[    2.990931] systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System...
[    2.992750] systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System...
[    2.994476] systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System...
[    2.996972] systemd[1]: Starting systemd-journald.service - Journal Service...
[    2.999182] systemd[1]: Starting keyboard-setup.service - Set the console keyboard layout...
[    3.001826] systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes...
[    3.003603] systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs...
[    3.005314] systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod...
[    3.007082] systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm...
[    3.009191] systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore...
[    3.010784] systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse...
[    3.012396] systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop...
[    3.012693] systemd[1]: systemd-fsck-root.service - File System Check on Root Device was skipped because of an unmet condition check (ConditionPathExists=!/run/initramfs/fsck-root).
[    3.025228] systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules...
[    3.025338] systemd[1]: systemd-pcrmachine.service - TPM2 PCR Machine ID Measurement was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/StubPcrKernelImage-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f).
[    3.026986] systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems...
[    3.029356] systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices...
[    3.029879] systemd-journald[230]: Collecting audit messages is disabled.
[    3.032851] systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System.
[    3.033065] systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System.
[    3.033198] systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System.
[    3.033337] systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System.
[    3.033762] systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes.
[    3.034233] systemd[1]: modprobe@configfs.service: Deactivated successfully.
[    3.034458] systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs.
[    3.035221] systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
[    3.035455] systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod.
[    3.035927] systemd[1]: modprobe@efi_pstore.service: Deactivated successfully.
[    3.036117] systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore.
[    3.036685] systemd[1]: modprobe@fuse.service: Deactivated successfully.
[    3.036876] systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse.
[    3.037335] systemd[1]: modprobe@loop.service: Deactivated successfully.
[    3.037587] systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop.
[    3.039833] systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System...
[    3.041442] systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System...
[    3.042014] systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met.
[    3.043773] systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System.
[    3.047199] systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System.
[    3.057279] lp: driver loaded but no devices found
[    3.059305] EXT4-fs (sda2): re-mounted 12ebc2bd-f8d9-4f14-a810-1a4f3163c572 r/w. Quota mode: none.
[    3.061398] systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems.
[    3.061701] systemd[1]: systemd-firstboot.service - First Boot Wizard was skipped because of an unmet condition check (ConditionFirstBoot=yes).
[    3.061758] systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore).
[    3.087679] ppdev: user-space parallel port driver
[    3.089362] ACPI: bus type drm_connector registered
[    3.091954] parport_pc 00:02: reported by Plug and Play ACPI
[    3.092235] parport0: PC-style at 0x378, irq 7 [PCSPP,TRISTATE]
[    3.111268] systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed...
[    3.113316] systemd[1]: Starting systemd-sysusers.service - Create System Users...
[    3.113698] systemd[1]: Started systemd-journald.service - Journal Service.
[    3.130306] systemd-journald[230]: Received client request to flush runtime journal.
[    3.135402] systemd-journald[230]: File /var/log/journal/829c8d1395b34062965db6b8f41c4bf3/system.journal corrupted or uncleanly shut down, renaming and replacing.
[    3.191149] lp0: using parport0 (interrupt-driven).
[    3.709556] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized
[    3.842716] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt
[    3.861627] i2c i2c-0: 1/1 memory slots populated (from DMI)
[    3.861643] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD
[    3.885257] Console: switching to colour dummy device 80x25
[    3.885290] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console
[    3.885397] [drm] Found bochs VGA, ID 0xb0c0.
[    3.885400] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfea70000.
[    3.888328] [drm] Found EDID data blob.
[    3.888574] [drm] Initialized bochs-drm 1.0.0 20130925 for 0000:00:01.0 on minor 0
[    3.890822] fbcon: bochs-drmdrmfb (fb0) is primary device
[    3.896104] Console: switching to colour frame buffer device 128x48
[    3.899251] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device
[    3.914988] random: crng init done
[    4.102778] loop0: detected capacity change from 0 to 8
[    4.109961] loop1: detected capacity change from 0 to 151784
[    4.112318] loop2: detected capacity change from 0 to 151352
[    4.118175] loop3: detected capacity change from 0 to 492560
[    4.121425] loop4: detected capacity change from 0 to 536760
[    4.124988] loop5: detected capacity change from 0 to 22944
[    4.129807] loop6: detected capacity change from 0 to 1017816
[    4.130693] loop7: detected capacity change from 0 to 15096
[    4.147124] loop8: detected capacity change from 0 to 187776
[    4.154050] loop9: detected capacity change from 0 to 21536
[    4.160023] loop11: detected capacity change from 0 to 82800
[    4.162362] loop10: detected capacity change from 0 to 83672
[    4.166283] loop12: detected capacity change from 0 to 904
[    4.311906] workqueue: blk_mq_run_work_fn hogged CPU for >10000us 4 times, consider switching to WQ_UNBOUND
[    4.325755] audit: type=1400 audit(1710172626.740:2): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/opt/brave.com/brave/brave" pid=412 comm="apparmor_parser"
[    4.325814] audit: type=1400 audit(1710172626.740:3): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/bin/toybox" pid=409 comm="apparmor_parser"
[    4.329830] audit: type=1400 audit(1710172626.744:4): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/opt/google/chrome/chrome" pid=413 comm="apparmor_parser"
[    4.330374] audit: type=1400 audit(1710172626.744:5): apparmor="STATUS" operation="profile_load" profile="unconfined" name="lsb_release" pid=410 comm="apparmor_parser"
[    4.331281] audit: type=1400 audit(1710172626.748:6): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/opt/microsoft/msedge/msedge" pid=414 comm="apparmor_parser"
[    4.331918] audit: type=1400 audit(1710172626.748:7): apparmor="STATUS" operation="profile_load" profile="unconfined" name="nvidia_modprobe" pid=411 comm="apparmor_parser"
[    4.331926] audit: type=1400 audit(1710172626.748:8): apparmor="STATUS" operation="profile_load" profile="unconfined" name="nvidia_modprobe//kmod" pid=411 comm="apparmor_parser"
[    4.334170] audit: type=1400 audit(1710172626.748:9): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/bin/buildah" pid=417 comm="apparmor_parser"
[    4.336038] audit: type=1400 audit(1710172626.752:10): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/bin/busybox" pid=418 comm="apparmor_parser"
[    5.337654] kauditd_printk_skb: 98 callbacks suppressed
[    5.337658] audit: type=1400 audit(1710172627.752:109): apparmor="STATUS" operation="profile_replace" info="same as current profile, skipping" profile="unconfined" name="rsyslogd" pid=557 comm="apparmor_parser"
[    6.482951] workqueue: wait_rcu_exp_gp hogged CPU for >10000us 4 times, consider switching to WQ_UNBOUND
[    6.486665] workqueue: blk_mq_run_work_fn hogged CPU for >10000us 8 times, consider switching to WQ_UNBOUND
[    7.177243] loop13: detected capacity change from 0 to 8
[    7.339000] e1000: enp0s2 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: RX
[    7.655641] audit: type=1400 audit(1710172630.072:110): apparmor="DENIED" operation="capable" class="cap" profile="/usr/sbin/cupsd" pid=711 comm="cupsd" capability=12  capname="net_admin"
[    8.327693] systemd-journald[230]: File /var/log/journal/829c8d1395b34062965db6b8f41c4bf3/user-1000.journal corrupted or uncleanly shut down, renaming and replacing.
[    8.847167] audit: type=1400 audit(1710172631.264:111): apparmor="DENIED" operation="capable" class="cap" profile="/snap/snapd/20671/usr/lib/snapd/snap-confine" pid=795 comm="snap-confine" capability=12  capname="net_admin"
[    8.847242] audit: type=1400 audit(1710172631.264:112): apparmor="DENIED" operation="capable" class="cap" profile="/snap/snapd/20671/usr/lib/snapd/snap-confine" pid=795 comm="snap-confine" capability=38  capname="perfmon"
[   13.134589] rfkill: input handler disabled
[   13.447244] audit: type=1400 audit(1710172635.864:113): apparmor="DENIED" operation="capable" class="cap" profile="/snap/snapd/20671/usr/lib/snapd/snap-confine" pid=1423 comm="snap-confine" capability=12  capname="net_admin"
[   13.447281] audit: type=1400 audit(1710172635.864:114): apparmor="DENIED" operation="capable" class="cap" profile="/snap/snapd/20671/usr/lib/snapd/snap-confine" pid=1423 comm="snap-confine" capability=38  capname="perfmon"
[   16.641910] workqueue: blk_mq_run_work_fn hogged CPU for >10000us 16 times, consider switching to WQ_UNBOUND
[   30.660877] psmouse serio1: VMMouse at isa0060/serio1/input0 lost sync at byte 1
[   30.661017] psmouse serio1: VMMouse at isa0060/serio1/input0 - driver resynced.
[   30.789462] psmouse serio1: VMMouse at isa0060/serio1/input0 lost sync at byte 1
[   30.789635] psmouse serio1: VMMouse at isa0060/serio1/input0 - driver resynced.
[   30.853769] psmouse serio1: VMMouse at isa0060/serio1/input0 lost sync at byte 1
[   30.853909] psmouse serio1: VMMouse at isa0060/serio1/input0 - driver resynced.
[   30.921737] psmouse serio1: VMMouse at isa0060/serio1/input0 lost sync at byte 1
[   30.921834] psmouse serio1: VMMouse at isa0060/serio1/input0 - driver resynced.
[   30.993662] psmouse serio1: VMMouse at isa0060/serio1/input0 lost sync at byte 1
[   30.993759] psmouse serio1: VMMouse at isa0060/serio1/input0 - driver resynced.
[   31.128580] psmouse serio1: VMMouse at isa0060/serio1/input0 lost sync at byte 1
[   31.190765] psmouse serio1: VMMouse at isa0060/serio1/input0 - driver resynced.
[   31.290075] psmouse serio1: VMMouse at isa0060/serio1/input0 lost sync at byte 1
[   31.352790] psmouse serio1: VMMouse at isa0060/serio1/input0 - driver resynced.
[   31.673395] psmouse serio1: VMMouse at isa0060/serio1/input0 lost sync at byte 1
[   31.673530] psmouse serio1: VMMouse at isa0060/serio1/input0 - driver resynced.
[   31.749115] psmouse serio1: VMMouse at isa0060/serio1/input0 lost sync at byte 1
[   31.749238] psmouse serio1: VMMouse at isa0060/serio1/input0 - driver resynced.
[   31.749249] workqueue: e1000_watchdog [e1000] hogged CPU for >10000us 4 times, consider switching to WQ_UNBOUND
[   31.815588] psmouse serio1: VMMouse at isa0060/serio1/input0 lost sync at byte 1
[   31.815683] psmouse serio1: VMMouse at isa0060/serio1/input0 - driver resynced.
[   31.874089] psmouse serio1: VMMouse at isa0060/serio1/input0 lost sync at byte 1
[   31.874235] psmouse serio1: VMMouse at isa0060/serio1/input0 - driver resynced.
[   31.939242] psmouse serio1: VMMouse at isa0060/serio1/input0 lost sync at byte 1
[   31.939376] psmouse serio1: VMMouse at isa0060/serio1/input0 - driver resynced.
[   32.001141] psmouse serio1: VMMouse at isa0060/serio1/input0 lost sync at byte 1
[   32.001275] psmouse serio1: VMMouse at isa0060/serio1/input0 - driver resynced.
[   32.071024] psmouse serio1: VMMouse at isa0060/serio1/input0 lost sync at byte 1
[   32.071158] psmouse serio1: VMMouse at isa0060/serio1/input0 - driver resynced.
[   32.132799] psmouse serio1: VMMouse at isa0060/serio1/input0 lost sync at byte 1
[   32.132908] psmouse serio1: VMMouse at isa0060/serio1/input0 - driver resynced.
[   32.202569] psmouse serio1: VMMouse at isa0060/serio1/input0 lost sync at byte 1
[   32.202690] psmouse serio1: VMMouse at isa0060/serio1/input0 - driver resynced.
[   32.266631] psmouse serio1: VMMouse at isa0060/serio1/input0 lost sync at byte 1
[   32.266764] psmouse serio1: VMMouse at isa0060/serio1/input0 - driver resynced.
[   32.334801] psmouse serio1: VMMouse at isa0060/serio1/input0 lost sync at byte 1
[   32.334923] psmouse serio1: VMMouse at isa0060/serio1/input0 - driver resynced.
[   32.393409] psmouse serio1: VMMouse at isa0060/serio1/input0 lost sync at byte 1
[   32.393563] psmouse serio1: VMMouse at isa0060/serio1/input0 - driver resynced.
[   32.459055] psmouse serio1: VMMouse at isa0060/serio1/input0 lost sync at byte 1
[   32.459198] psmouse serio1: VMMouse at isa0060/serio1/input0 - driver resynced.
[   33.016821] psmouse serio1: VMMouse at isa0060/serio1/input0 lost sync at byte 1
[   33.016926] psmouse serio1: VMMouse at isa0060/serio1/input0 - driver resynced.
[   33.209333] psmouse serio1: VMMouse at isa0060/serio1/input0 lost sync at byte 1
[   33.209471] psmouse serio1: VMMouse at isa0060/serio1/input0 - driver resynced.
[   33.272816] psmouse serio1: VMMouse at isa0060/serio1/input0 lost sync at byte 1
[   33.272930] psmouse serio1: VMMouse at isa0060/serio1/input0 - driver resynced.
[   33.304667] psmouse serio1: VMMouse at isa0060/serio1/input0 lost sync at byte 1
[   33.304811] psmouse serio1: VMMouse at isa0060/serio1/input0 - driver resynced.
[   33.437296] psmouse serio1: VMMouse at isa0060/serio1/input0 lost sync at byte 1
[   33.437433] psmouse serio1: VMMouse at isa0060/serio1/input0 - driver resynced.
[   33.501234] psmouse serio1: VMMouse at isa0060/serio1/input0 lost sync at byte 1
[   33.501484] psmouse serio1: VMMouse at isa0060/serio1/input0 - driver resynced.
[   33.691563] psmouse serio1: VMMouse at isa0060/serio1/input0 lost sync at byte 1
[   33.691726] psmouse serio1: VMMouse at isa0060/serio1/input0 - driver resynced.
[   48.036992] workqueue: e1000_watchdog [e1000] hogged CPU for >10000us 8 times, consider switching to WQ_UNBOUND
[  127.625252] workqueue: blk_mq_run_work_fn hogged CPU for >10000us 32 times, consider switching to WQ_UNBOUND
[  140.795627] psmouse serio1: VMMouse at isa0060/serio1/input0 lost sync at byte 1
[  140.795735] psmouse serio1: VMMouse at isa0060/serio1/input0 - driver resynced.
[  140.855848] psmouse serio1: VMMouse at isa0060/serio1/input0 lost sync at byte 1
[  140.855947] psmouse serio1: VMMouse at isa0060/serio1/input0 - driver resynced.
[  141.042090] psmouse serio1: VMMouse at isa0060/serio1/input0 lost sync at byte 1
[  141.042181] psmouse serio1: VMMouse at isa0060/serio1/input0 - driver resynced.
[  141.109361] workqueue: e1000_watchdog [e1000] hogged CPU for >10000us 16 times, consider switching to WQ_UNBOUND
[  141.142040] psmouse serio1: VMMouse at isa0060/serio1/input0 lost sync at byte 1
[  141.142150] psmouse serio1: VMMouse at isa0060/serio1/input0 - driver resynced.
[  141.277550] psmouse serio1: VMMouse at isa0060/serio1/input0 lost sync at byte 1
[  141.277658] psmouse serio1: VMMouse at isa0060/serio1/input0 - driver resynced.
[  156.919971] thunderbolt: loading out-of-tree module taints kernel.
[  156.919991] thunderbolt: module verification failed: signature and/or required key missing - tainting kernel
[  156.932195] ACPI: bus type thunderbolt registered
[  156.987694] TBT debug : ==> Start to enable MSI interrupt <===========
[  156.996266] TBT debug : ==> pci_alloc_irq_vectors is done <===========
[  156.996269] TBT debug : ==> pci_irq_vector is done <===========
[  156.999075] TBT debug : ==> MSI interrupt enable is done <===========
[  157.000127] TBT debug : tb_probe, Siemens debug 0
[  157.000148] TBT debug : tb_probe, Siemens debug 1
[  157.000149] TBT debug : tb_probe, Siemens debug 2
[  157.000150] TBT debug : ==> NHI initialized, starting thunderbolt
[  157.000151] TBT debug : =====> start adding the tb domain
[  157.003234] TBT debug : ==>  in tb_start 
[  157.003240] TBT debug : ==>  in tb_switch_alloc: route=0x0 
[  157.036265] TBT debug : ==>  in tb_switch_alloc, (Before)sw->config.upstream_port_number = 6 
[  157.036283] TBT debug : ==>  in tb_switch_alloc, (After)sw->config.upstream_port_number = 0 
[  157.036284] TBT debug : ==>  in tb_switch_alloc, sw->config.max_port_number = 6 
[  157.036286] TBT debug : ==>  in tb_switch_alloc, creating: 7 adapters/ports 
[  157.036288] TBT debug : ==>  in tb_switch_alloc, port#0, type:0x0 
[  157.036290] TBT debug : ==>  in tb_switch_alloc, port#1, type:0x0 
[  157.036291] TBT debug : ==>  in tb_switch_alloc, port#2, type:0x0 
[  157.036292] TBT debug : ==>  in tb_switch_alloc, port#3, type:0x0 
[  157.036293] TBT debug : ==>  in tb_switch_alloc, port#4, type:0x0 
[  157.036294] TBT debug : ==>  in tb_switch_alloc, port#5, type:0x0 
[  157.036295] TBT debug : ==>  in tb_switch_alloc, port#6, type:0x0 
[  157.402584] TBT debug : ==>  Device is authorized sucessfully 
[  157.402591] TBT debug : ==>  tb_switch_alloc completed 
[  157.402592] TBT debug : ==>  in tb_switch_configure
[  157.402593] TBT debug : ==>  It is a USB4 router ...
[  157.402594] TBT debug : ==>  configuring router usb4 version 2
[  157.405653] TBT debug : ==>  USB4 Router is enumerated sucessfully ...
[  157.405658] TBT debug : ==>  in tb_switch_add 
[  157.495218] TBT debug : ==>  in tb_drom_read 
[  157.500835] TBT debug : ==>  in tb_drom_read, uid: 0x4000010004d60000
[  157.500838] TBT debug : ==>  in usb4_copy_drom
[  157.845837] TBT debug : ==>  usb4_copy_drom, ret: 0
[  157.845855] thunderbolt 0000:01:00.0: 0: DROM data CRC32 mismatch (expected: 0xe480a26c, got: 0xb6acc4eb), continuing
[  157.845860] thunderbolt 0-0: ignoring unnecessary extra entries in DROM
[  157.845863] thunderbolt 0000:01:00.0: 0: DROM buffer overrun
[  157.845864] thunderbolt 0000:01:00.0: 0: parsing DROM failed
[  157.845878] TBT debug : ==>  tb_switch_add -end of tb_drom_read: ret -5 
[  157.845879] thunderbolt 0-0: reading DROM failed: -5, uid: 0x4000010004d60000
[  157.845881] TBT debug : ==>  tb_switch_add - go to tb_init_port # 0 
[  157.845882] TBT debug : ==>  tb_switch_add - go to tb_init_port # 1 
[  157.852582] TBT debug : ==>  tb_init_port: Read first 8 DWs of Adapter: 1 and it is type is: 0x1
[  157.852586] TBT debug : ==>  tb_init_port find TB_PORT_CAP_PHY  of port 0, which is the switch itself
[  157.852587] TBT debug : tb_port_find_cap,  tb_port_enable_tmu: 0
[  157.852589] TBT debug : ==> in __tb_port_find_cap 
[  157.857592] TBT debug : offset: 9, header.basic.cap: 3, cap: 1 
[  157.963189] TBT debug : offset: 19, header.basic.cap: 1, cap: 1 
[  157.963194] TBT debug : tb_port_find_cap, offset found successfully: 19 
[  157.963195] TBT debug : tb_port_find_cap,  __tb_port_find_cap: 19
[  157.963197] TBT debug : ==>  tb_port_find_cap TB_PORT_CAP_PHY, cap=19 
[  157.963197] TBT debug : tb_port_find_cap,  tb_port_enable_tmu: 0
[  157.963198] TBT debug : ==> in __tb_port_find_cap 
[  157.974198] TBT debug : offset: 9, header.basic.cap: 3, cap: 6 
[  158.079231] TBT debug : offset: 19, header.basic.cap: 1, cap: 6 
[  158.195601] TBT debug : offset: 22, header.basic.cap: 6, cap: 6 
[  158.195606] TBT debug : tb_port_find_cap, offset found successfully: 22 
[  158.195607] TBT debug : tb_port_find_cap,  __tb_port_find_cap: 22
[  158.195609] TBT debug : ==>  tb_port_find_cap TB_PORT_CAP_USB4, cap=22 
[  158.203679] TBT debug : ==>  tb_init_port completed sucessfully
[  158.203681] TBT debug : ==>  tb_switch_add - go to tb_init_port # 2 
[  158.209907] TBT debug : ==>  tb_init_port: Read first 8 DWs of Adapter: 2 and it is type is: 0x1
[  158.209911] TBT debug : ==>  tb_init_port find TB_PORT_CAP_PHY  of port 0, which is the switch itself
[  158.209912] TBT debug : tb_port_find_cap,  tb_port_enable_tmu: 0
[  158.209913] TBT debug : ==> in __tb_port_find_cap 
[  158.214317] TBT debug : offset: 9, header.basic.cap: 3, cap: 1 
[  158.291457] TBT debug : offset: 19, header.basic.cap: 1, cap: 1 
[  158.291475] TBT debug : tb_port_find_cap, offset found successfully: 19 
[  158.291477] TBT debug : tb_port_find_cap,  __tb_port_find_cap: 19
[  158.291478] TBT debug : ==>  tb_port_find_cap TB_PORT_CAP_PHY, cap=19 
[  158.291479] TBT debug : tb_port_find_cap,  tb_port_enable_tmu: 0
[  158.291481] TBT debug : ==> in __tb_port_find_cap 
[  158.302157] TBT debug : offset: 9, header.basic.cap: 3, cap: 6 
[  158.391267] TBT debug : offset: 19, header.basic.cap: 1, cap: 6 
[  158.475705] TBT debug : offset: 0, header.basic.cap: 0, cap: 6 
[  158.475710] TBT debug : ==> end of __tb_port_find_cap, -2
[  158.475712] TBT debug : tb_port_find_cap,  __tb_port_find_cap: -2
[  158.475713] TBT debug : ==>  tb_port_find_cap TB_PORT_CAP_USB4, cap=-2 
[  158.475714] TBT debug : ==>  tb_init_port completed sucessfully
[  158.475715] TBT debug : ==>  tb_switch_add - go to tb_init_port # 3 
[  158.480823] TBT debug : ==>  tb_init_port: Read first 8 DWs of Adapter: 3 and it is type is: 0x200101
[  158.480827] TBT debug : ==>  tb_init_port find TB_PORT_CAP_ADAP of other ports
[  158.480828] TBT debug : tb_port_find_cap,  tb_port_enable_tmu: 0
[  158.480829] TBT debug : ==> in __tb_port_find_cap 
[  158.485799] TBT debug : offset: 9, header.basic.cap: 4, cap: 4 
[  158.485802] TBT debug : tb_port_find_cap, offset found successfully: 9 
[  158.485803] TBT debug : tb_port_find_cap,  __tb_port_find_cap: 9
[  158.485804] TBT debug : ==> cap = 0x9
[  158.485805] TBT debug : ==>  tb_init_port completed sucessfully
[  158.485806] TBT debug : ==>  tb_switch_add - go to tb_init_port # 4 
[  158.490885] TBT debug : ==>  tb_init_port: Read first 8 DWs of Adapter: 4 and it is type is: 0x100101
[  158.490888] TBT debug : ==>  tb_init_port find TB_PORT_CAP_ADAP of other ports
[  158.490889] TBT debug : tb_port_find_cap,  tb_port_enable_tmu: 0
[  158.490890] TBT debug : ==> in __tb_port_find_cap 
[  158.496790] TBT debug : offset: 9, header.basic.cap: 4, cap: 4 
[  158.496793] TBT debug : tb_port_find_cap, offset found successfully: 9 
[  158.496794] TBT debug : tb_port_find_cap,  __tb_port_find_cap: 9
[  158.496795] TBT debug : ==> cap = 0x9
[  158.496796] TBT debug : ==>  tb_init_port completed sucessfully
[  158.496797] TBT debug : ==>  tb_switch_add - go to tb_init_port # 5 
[  158.502508] TBT debug : ==>  tb_init_port: Read first 8 DWs of Adapter: 5 and it is type is: 0xe0101
[  158.502515] TBT debug : ==>  tb_init_port find TB_PORT_CAP_ADAP of other ports
[  158.502517] TBT debug : tb_port_find_cap,  tb_port_enable_tmu: 0
[  158.502520] TBT debug : ==> in __tb_port_find_cap 
[  158.564995] TBT debug : offset: 9, header.basic.cap: 4, cap: 4 
[  158.564999] TBT debug : tb_port_find_cap, offset found successfully: 9 
[  158.565000] TBT debug : tb_port_find_cap,  __tb_port_find_cap: 9
[  158.565001] TBT debug : ==> cap = 0x9
[  158.565003] TBT debug : ==>  tb_init_port completed sucessfully
[  158.565004] TBT debug : ==>  tb_switch_add - go to tb_init_port # 6 
[  158.571299] TBT debug : ==>  tb_init_port: Read first 8 DWs of Adapter: 6 and it is type is: 0x2
[  158.571302] TBT debug : ==>  tb_init_port find TB_PORT_CAP_ADAP of other ports
[  158.571303] TBT debug : tb_port_find_cap,  tb_port_enable_tmu: 0
[  158.571305] TBT debug : ==> in __tb_port_find_cap 
[  158.576976] TBT debug : offset: 0, header.basic.cap: 0, cap: 4 
[  158.576979] TBT debug : ==> end of __tb_port_find_cap, -2
[  158.576980] TBT debug : tb_port_find_cap,  __tb_port_find_cap: -2
[  158.576981] TBT debug : ==> cap = 0x0
[  158.576982] TBT debug : ==>  tb_init_port completed sucessfully
[  158.576983] TBT debug : ==>  tb_switch_add - all ports are initialized successfully
[  158.576993] TBT debug : ==>  tb_switch_add - tb_switch_update_link_attributes: ret=0 
[  158.576996] TBT debug : ==>  tb_switch_add - tb_switch_clx_init: ret=0 
[  158.582349] TBT debug : tb_port_find_cap,  tb_port_enable_tmu: 0
[  158.582363] TBT debug : ==> in __tb_port_find_cap 
[  158.650386] TBT debug : offset: 9, header.basic.cap: 3, cap: 3 
[  158.650403] TBT debug : tb_port_find_cap, offset found successfully: 9 
[  158.650404] TBT debug : tb_port_find_cap,  __tb_port_find_cap: 9
[  158.650406] TBT debug : tb_port_find_cap,  tb_port_enable_tmu: 0
[  158.650407] TBT debug : ==> in __tb_port_find_cap 
[  158.664158] TBT debug : offset: 9, header.basic.cap: 3, cap: 3 
[  158.664162] TBT debug : tb_port_find_cap, offset found successfully: 9 
[  158.664174] TBT debug : tb_port_find_cap,  __tb_port_find_cap: 9
[  158.664175] TBT debug : tb_port_find_cap,  tb_port_enable_tmu: 0
[  158.664176] TBT debug : ==> in __tb_port_find_cap 
[  158.716353] TBT debug : offset: 9, header.basic.cap: 4, cap: 3 
[  158.829227] TBT debug : offset: 0, header.basic.cap: 0, cap: 3 
[  158.829244] TBT debug : ==> end of __tb_port_find_cap, -2
[  158.829245] TBT debug : tb_port_find_cap,  __tb_port_find_cap: -2
[  158.829247] TBT debug : tb_port_find_cap,  tb_port_enable_tmu: 0
[  158.829248] TBT debug : ==> in __tb_port_find_cap 
[  158.834083] TBT debug : offset: 9, header.basic.cap: 4, cap: 3 
[  158.843905] TBT debug : offset: 0, header.basic.cap: 0, cap: 3 
[  158.843908] TBT debug : ==> end of __tb_port_find_cap, -2
[  158.843909] TBT debug : tb_port_find_cap,  __tb_port_find_cap: -2
[  158.843910] TBT debug : tb_port_find_cap,  tb_port_enable_tmu: 0
[  158.843911] TBT debug : ==> in __tb_port_find_cap 
[  158.849489] TBT debug : offset: 9, header.basic.cap: 4, cap: 3 
[  158.867273] TBT debug : offset: 0, header.basic.cap: 0, cap: 3 
[  158.867277] TBT debug : ==> end of __tb_port_find_cap, -2
[  158.867290] TBT debug : tb_port_find_cap,  __tb_port_find_cap: -2
[  158.867291] TBT debug : tb_port_find_cap,  tb_port_enable_tmu: 0
[  158.867292] TBT debug : ==> in __tb_port_find_cap 
[  158.873005] TBT debug : offset: 0, header.basic.cap: 0, cap: 3 
[  158.873008] TBT debug : ==> end of __tb_port_find_cap, -2
[  158.873009] TBT debug : tb_port_find_cap,  __tb_port_find_cap: -2
[  158.886172] TBT debug : ==>  tb_switch_add - tb_switch_tmu_init: ret=0 
[  158.939427] TBT debug : ==>  tb_switch_add - tb_switch_port_hotplug_enable:0 
[  159.226070] TBT debug : ==>  tb_switch_add - device_add:0 
[  159.226075] TBT debug : ==>  tb_switch_add - tb_route 
[  159.226075] TBT debug : ==>  tb_switch_add - usb4_switch_add_ports 
[  159.226077] TBT debug : ==>  usb4_port_device_add adding .... 
[  159.226084] TBT debug : ==>  usb4_port_device_add: name: usb4_port1 
[  159.226100] TBT debug : ==>  usb4_port_device_add: After device register: 0 
[  159.226105] TBT debug : ==>  usb4_port_device_add: tb_is_upstream_port(port): 0 
[  159.226111] TBT debug : ==>  tb_switch_add - usb4_switch_add_ports done 
[  159.257804] TBT debug : ==>  tb_switch_add - tb_switch_nvm_add done 
[  159.257891] TBT debug : ==>  call pm_request_autosuspend 
[  159.257930] TBT debug : ==>  tb_switch_add - completed successfully 
[  159.396860] TBT debug : ==>  in tb_scan_switch 
[  159.396864] TBT debug : ==>  in tb_scan_port, port->config.type = 0x1 
[  159.396866] TBT debug : ==>  tb_scan_port - check port is usb4 
[  159.408728] TBT debug : ==>  tb_scan_port - tb_retimer_scan 
[  163.241608] workqueue: ring_work [thunderbolt] hogged CPU for >10000us 4 times, consider switching to WQ_UNBOUND
[  167.500727] TBT debug : ==>  tb_scan_port - tb_switch_alloc 
[  167.500733] TBT debug : ==>  in tb_switch_alloc: route=0x1 
[  167.640649] TBT debug : ==>  in tb_switch_alloc, (Before)sw->config.upstream_port_number = 1 
[  167.640654] TBT debug : ==>  in tb_switch_alloc, (After)sw->config.upstream_port_number = 0 
[  167.640655] TBT debug : ==>  in tb_switch_alloc, sw->config.max_port_number = 5 
[  167.640656] TBT debug : ==>  in tb_switch_alloc, creating: 6 adapters/ports 
[  167.640658] TBT debug : ==>  in tb_switch_alloc, port#0, type:0x0 
[  167.640659] TBT debug : ==>  in tb_switch_alloc, port#1, type:0x0 
[  167.640660] TBT debug : ==>  in tb_switch_alloc, port#2, type:0x0 
[  167.640661] TBT debug : ==>  in tb_switch_alloc, port#3, type:0x0 
[  167.640662] TBT debug : ==>  in tb_switch_alloc, port#4, type:0x0 
[  167.640663] TBT debug : ==>  in tb_switch_alloc, port#5, type:0x0 
[  167.952268] TBT debug : ==>  tb_switch_alloc completed 
[  167.952273] TBT debug : ==>  tb_scan_port -go to  tb_switch_configure
[  167.952274] TBT debug : ==>  in tb_switch_configure
[  167.952275] TBT debug : ==>  It is a USB4 router ...
[  167.952276] TBT debug : ==>  configuring router usb4 version 2
[  167.966629] TBT debug : ==>  in usb4_switch_setup
[  167.976740] TBT debug : ==>  tbt3=0, xhci=0 
[  167.982228] TBT debug : ==>  xhci set to false 
[  167.982231] TBT debug : ==>  write the following val: 0x3800000 to ROUTER_CS_5
[  167.995721] TBT debug : ==>  USB4 Router is enumerated sucessfully ...
[  167.995724] TBT debug : ==>  tb_scan_port -end of  tb_switch_configure
[  167.995725] TBT debug : ==>  tb_scan_port - starting tb_switch_add (2) 
[  167.995726] TBT debug : ==>  in tb_switch_add 
[  168.247804] TBT debug : ==>  in tb_drom_read 
[  168.254688] TBT debug : ==>  in usb4_copy_drom
[  168.672817] TBT debug : ==>  usb4_copy_drom, ret: 0
[  168.672825] thunderbolt 0000:01:00.0: 1: DROM data CRC32 mismatch (expected: 0xe480a26c, got: 0xb6acc4eb), continuing
[  168.672830] thunderbolt 0000:01:00.0: 1: DROM buffer overrun
[  168.672832] thunderbolt 0000:01:00.0: 1: parsing DROM failed
[  168.672833] TBT debug : ==>  tb_switch_add -end of tb_drom_read: ret -5 
[  168.672835] thunderbolt 0-1: reading DROM failed: -5, uid: 0x4000010104d60000
[  168.672837] TBT debug : ==>  tb_switch_add - go to tb_init_port # 0 
[  168.672838] TBT debug : ==>  tb_switch_add - go to tb_init_port # 1 
[  168.677378] TBT debug : ==>  tb_init_port: Read first 8 DWs of Adapter: 1 and it is type is: 0x1
[  168.677392] TBT debug : ==>  tb_init_port find TB_PORT_CAP_PHY  of port 0, which is the switch itself
[  168.677394] TBT debug : tb_port_find_cap,  tb_port_enable_tmu: 0
[  168.677395] TBT debug : ==> in __tb_port_find_cap 
[  168.687563] TBT debug : offset: 9, header.basic.cap: 3, cap: 1 
[  168.704852] TBT debug : offset: 19, header.basic.cap: 1, cap: 1 
[  168.704856] TBT debug : tb_port_find_cap, offset found successfully: 19 
[  168.704857] TBT debug : tb_port_find_cap,  __tb_port_find_cap: 19
[  168.704858] TBT debug : ==>  tb_port_find_cap TB_PORT_CAP_PHY, cap=19 
[  168.704859] TBT debug : tb_port_find_cap,  tb_port_enable_tmu: 0
[  168.704860] TBT debug : ==> in __tb_port_find_cap 
[  168.784113] TBT debug : offset: 9, header.basic.cap: 3, cap: 6 
[  168.801315] TBT debug : offset: 19, header.basic.cap: 1, cap: 6 
[  168.880495] TBT debug : offset: 22, header.basic.cap: 6, cap: 6 
[  168.880501] TBT debug : tb_port_find_cap, offset found successfully: 22 
[  168.880502] TBT debug : tb_port_find_cap,  __tb_port_find_cap: 22
[  168.880503] TBT debug : ==>  tb_port_find_cap TB_PORT_CAP_USB4, cap=22 
[  168.885526] TBT debug : ==>  tb_init_port completed sucessfully
[  168.885528] TBT debug : ==>  tb_switch_add - go to tb_init_port # 2 
[  168.961406] TBT debug : ==>  tb_init_port: Read first 8 DWs of Adapter: 2 and it is type is: 0x1
[  168.961413] TBT debug : ==>  tb_init_port find TB_PORT_CAP_PHY  of port 0, which is the switch itself
[  168.961415] TBT debug : tb_port_find_cap,  tb_port_enable_tmu: 0
[  168.961417] TBT debug : ==> in __tb_port_find_cap 
[  168.976780] TBT debug : offset: 9, header.basic.cap: 3, cap: 1 
[  169.020201] TBT debug : offset: 19, header.basic.cap: 1, cap: 1 
[  169.020208] TBT debug : tb_port_find_cap, offset found successfully: 19 
[  169.020210] TBT debug : tb_port_find_cap,  __tb_port_find_cap: 19
[  169.020212] TBT debug : ==>  tb_port_find_cap TB_PORT_CAP_PHY, cap=19 
[  169.020213] TBT debug : tb_port_find_cap,  tb_port_enable_tmu: 0
[  169.020215] TBT debug : ==> in __tb_port_find_cap 
[  169.026353] TBT debug : offset: 9, header.basic.cap: 3, cap: 6 
[  169.043718] TBT debug : offset: 19, header.basic.cap: 1, cap: 6 
[  169.129137] TBT debug : offset: 0, header.basic.cap: 0, cap: 6 
[  169.129143] TBT debug : ==> end of __tb_port_find_cap, -2
[  169.129144] TBT debug : tb_port_find_cap,  __tb_port_find_cap: -2
[  169.129145] TBT debug : ==>  tb_port_find_cap TB_PORT_CAP_USB4, cap=-2 
[  169.129146] TBT debug : ==>  tb_init_port completed sucessfully
[  169.129147] TBT debug : ==>  tb_switch_add - go to tb_init_port # 3 
[  169.134169] TBT debug : ==>  tb_init_port: Read first 8 DWs of Adapter: 3 and it is type is: 0x200102
[  169.134172] TBT debug : ==>  tb_init_port find TB_PORT_CAP_ADAP of other ports
[  169.134173] TBT debug : tb_port_find_cap,  tb_port_enable_tmu: 0
[  169.134174] TBT debug : ==> in __tb_port_find_cap 
[  169.138599] TBT debug : offset: 9, header.basic.cap: 4, cap: 4 
[  169.138602] TBT debug : tb_port_find_cap, offset found successfully: 9 
[  169.138603] TBT debug : tb_port_find_cap,  __tb_port_find_cap: 9
[  169.138604] TBT debug : ==> cap = 0x9
[  169.138605] TBT debug : ==>  tb_init_port completed sucessfully
[  169.138606] TBT debug : ==>  tb_switch_add - go to tb_init_port # 4 
[  169.272692] TBT debug : ==>  tb_init_port: Read first 8 DWs of Adapter: 4 and it is type is: 0x100102
[  169.272706] TBT debug : ==>  tb_init_port find TB_PORT_CAP_ADAP of other ports
[  169.272709] TBT debug : tb_port_find_cap,  tb_port_enable_tmu: 0
[  169.272711] TBT debug : ==> in __tb_port_find_cap 
[  169.283700] TBT debug : offset: 9, header.basic.cap: 4, cap: 4 
[  169.283704] TBT debug : tb_port_find_cap, offset found successfully: 9 
[  169.283706] TBT debug : tb_port_find_cap,  __tb_port_find_cap: 9
[  169.283707] TBT debug : ==> cap = 0x9
[  169.283708] TBT debug : ==>  tb_init_port completed sucessfully
[  169.283709] TBT debug : ==>  tb_switch_add - go to tb_init_port # 5 
[  169.290119] TBT debug : ==>  tb_init_port: Read first 8 DWs of Adapter: 5 and it is type is: 0xe0102
[  169.290136] TBT debug : ==>  tb_init_port find TB_PORT_CAP_ADAP of other ports
[  169.290138] TBT debug : tb_port_find_cap,  tb_port_enable_tmu: 0
[  169.290140] TBT debug : ==> in __tb_port_find_cap 
[  169.294572] TBT debug : offset: 9, header.basic.cap: 4, cap: 4 
[  169.294575] TBT debug : tb_port_find_cap, offset found successfully: 9 
[  169.294576] TBT debug : tb_port_find_cap,  __tb_port_find_cap: 9
[  169.294577] TBT debug : ==> cap = 0x9
[  169.294578] TBT debug : ==>  tb_init_port completed sucessfully
[  169.294579] TBT debug : ==>  tb_switch_add - all ports are initialized successfully
[  169.294581] TBT debug : ==>  After tb_port_get_link_speed, sw->config.upstream_port_number: 0 
[  169.294582] TBT debug : ==>  After tb_port_get_link_speed, up->config.type: 0, up->cap_phy: 0 
[  169.294583] TBT debug : ==>  in tb_port_get_link_speed 
[  169.294584] TBT debug : ==>  After tb_port_get_link_speed, ret: -22 
[  169.294585] TBT debug : ==>  tb_switch_add - tb_switch_update_link_attributes: ret=-22 
[  169.294597] TBT debug : ==>  tb_scan_port - out_rpm_put - port->usb4 
[  169.294604] TBT debug : ==>  in tb_scan_port, port->config.type = 0x1 
[  169.294605] TBT debug : ==>  tb_scan_port - dual_link_port && link_nr 
[  169.294606] TBT debug : ==>  in tb_scan_port, port->config.type = 0x200101 
[  169.294607] TBT debug : ==>  tb_scan_port - config.type != TB_TYPE_PORT
[  169.294608] TBT debug : ==>  in tb_scan_port, port->config.type = 0x100101 
[  169.294609] TBT debug : ==>  tb_scan_port - config.type != TB_TYPE_PORT
[  169.294610] TBT debug : ==>  in tb_scan_port, port->config.type = 0xe0101 
[  169.294611] TBT debug : ==>  tb_scan_port - config.type != TB_TYPE_PORT
[  169.294611] TBT debug : ==>  in tb_scan_port, port->config.type = 0x2 
[  169.294612] TBT debug : ==>  tb_scan_port - config.type != TB_TYPE_PORT
[  169.294613] TBT debug : ==>  end of tb_scan_switch 
[  169.294614] TBT debug : ==>  to call tb_discover_tunnels  
[  169.294615] TBT debug : ==> print_debug : in tb_discover_tunnels   
[  169.294618] TBT debug : ==> tb_switch_discover_tunnels:  TB_TYPE_USB3_DOWN   
[  169.313354] TBT debug : ==>  end of usb3 discover  
[  169.313358] TBT debug : ==> tb_switch_discover_tunnels:  TB_TYPE_PCIE_DOWN   
[  169.313360] TBT debug : ==> in tb_tunnel_discover_pci
[  169.318537] TBT debug : ==> route 0x0
[  169.318541] TBT debug : ==> port->port = 0x4
[  169.318542] TBT debug : ==> port->cap_adap = 0x9
[  169.318544] TBT debug : ==> ADP_PCIE_CS_0 = 0
[  169.318546] TBT debug : ==> tb_pci_port_is_enabled, data=0xe0400
[  169.318548] TBT debug : ==> tb_pci_port_is_enabled is down, return null
[  169.318549] TBT debug : ==> tb_switch_discover_tunnels:  TB_TYPE_DP_HDMI_IN   
[  169.323004] TBT debug : ==>  end of tb_switch_discover_tunnels   
[  169.323007] TBT debug : ==>  to call tb_create_usb3_tunnels  
[  169.323009] TBT debug : ==> in tb_create_usb3_tunnels
[  169.323011] TBT debug : ==>  tb_create_usb3_tunnels completed ...
[  169.431989] TBT debug : =====> End of tb domain add: res:0 
[  169.432028] TBT debug : ==> end of nhi_probe
[  172.657098] psmouse serio1: VMMouse at isa0060/serio1/input0 lost sync at byte 1
[  172.657257] psmouse serio1: VMMouse at isa0060/serio1/input0 - driver resynced.
[  172.784599] psmouse serio1: VMMouse at isa0060/serio1/input0 lost sync at byte 1
[  172.846061] psmouse serio1: VMMouse at isa0060/serio1/input0 - driver resynced.
[  174.179330] psmouse serio1: VMMouse at isa0060/serio1/input0 lost sync at byte 1
[  174.179570] psmouse serio1: VMMouse at isa0060/serio1/input0 - driver resynced.
[  174.252052] psmouse serio1: VMMouse at isa0060/serio1/input0 lost sync at byte 1
[  174.252225] psmouse serio1: VMMouse at isa0060/serio1/input0 - driver resynced.
[  174.341542] psmouse serio1: VMMouse at isa0060/serio1/input0 lost sync at byte 1
[  174.341719] psmouse serio1: VMMouse at isa0060/serio1/input0 - driver resynced.
[  175.060061] psmouse serio1: VMMouse at isa0060/serio1/input0 lost sync at byte 1
[  175.060159] psmouse serio1: VMMouse at isa0060/serio1/input0 - driver resynced.
[  175.117657] psmouse serio1: VMMouse at isa0060/serio1/input0 lost sync at byte 1
[  175.117814] psmouse serio1: VMMouse at isa0060/serio1/input0 - driver resynced.

Re: Inquiry about tb/usb4 driver

[mika.westerberg]

Hi,

On Mon, Mar 11, 2024 at 02:03:38PM +0000, mohamed.rayan@siemens.com wrote:
> Hi Mike,
> 
> I have enabled the dmesg as per your instructions below,
> 
> Kindly check the log as attached and let me know if you need anything else.

Checked now, thanks! Found this:

[  156.919971] thunderbolt: loading out-of-tree module taints kernel.                     
[  156.919991] thunderbolt: module verification failed: signature and/or required key miss
ing - tainting kernel                                                                     
[  156.932195] ACPI: bus type thunderbolt registered                                      
[  156.987694] TBT debug : ==> Start to enable MSI interrupt <===========                 
[  156.996266] TBT debug : ==> pci_alloc_irq_vectors is done <=========

This is something that is not part of the mainline kernel. First of all
Thunderbolt driver has been in the mainline for a long time so it
definitely is not out-of-tree module. The debugging also does not exists
on any of the trees I'm working on.

In other words, I cannot help you here.

If you provide me the same output on a mainline kernel with no
modifications I can take a look, sure.