lists.openwall.net   lists  /  announce  owl-users  owl-dev  john-users  john-dev  passwdqc-users  yescrypt  popa3d-users  /  oss-security  kernel-hardening  musl  sabotage  tlsify  passwords  /  crypt-dev  xvendor  /  Bugtraq  Full-Disclosure  linux-kernel  linux-netdev  linux-ext4  linux-hardening  linux-cve-announce  PHC 
Open Source and information security mailing list archives
 
Hash Suite: Windows password security audit tool. GUI, reports in PDF.
[<prev] [next>] [<thread-prev] [thread-next>] [day] [month] [year] [list]
Message-ID: <CAEXpi5StYwujiTaH2_5PE9Hg_cgzAEtBuFxfgVxEJvbqRNv_4A@mail.gmail.com>
Date:   Tue, 3 Oct 2023 21:34:32 -0400
From:   enc0der <enc0der@...il.com>
To:     Stanislaw Gruszka <stf_xl@...pl>
Cc:     Bagas Sanjaya <bagasdotme@...il.com>,
        Linux Regressions <regressions@...ts.linux.dev>,
        Linux Kernel Mailing List <linux-kernel@...r.kernel.org>,
        Linux Wireless <linux-wireless@...r.kernel.org>
Subject: Re: rt8000usb driver issue (maybe interaction with other drivers)

Hello Stanislaw!

On Mon, Oct 2, 2023 at 2:50 PM Stanislaw Gruszka <stf_xl@...pl> wrote:
>
> Is possible that this is rt2800usb or usb host driver issue. But without
> full logs we can not be sure.

Okay, I was able to use dmesg -w before it kernel panic'd to grab some
additional details, first this is when I plug in th USB WiFi adapter
but I have it not automatically connect.  In this state, it will not
kernel panic:

[ 1496.115251] usb 1-3.4: new high-speed USB device number 7 using tegra-xusb
[ 1496.333698] usb 1-3.4: New USB device found, idVendor=148f,
idProduct=5370, bcdDevice= 1.01
[ 1496.333707] usb 1-3.4: New USB device strings: Mfr=1, Product=2,
SerialNumber=3
[ 1496.333712] usb 1-3.4: Product: 802.11 n WLAN
[ 1496.333716] usb 1-3.4: Manufacturer: Ralink
[ 1496.333719] usb 1-3.4: SerialNumber: 1.0
[ 1497.187704] usb 1-3.4: reset high-speed USB device number 7 using tegra-xusb
[ 1497.399765] ieee80211 phy0: rt2x00_set_rt: Info - RT chipset 5390,
rev 0502 detected
[ 1497.574025] ieee80211 phy0: rt2x00_set_rf: Info - RF chipset 5370 detected
[ 1497.575366] ieee80211 phy0: Selected rate control algorithm 'minstrel_ht'
[ 1497.577940] usbcore: registered new interface driver rt2800usb
[ 1497.744748] ieee80211 phy0: rt2x00lib_request_firmware: Info -
Loading firmware file 'rt2870.bin'
[ 1497.747318] ieee80211 phy0: rt2x00lib_request_firmware: Info -
Firmware detected - version: 0.36

Then, I tell it to connect to a local network, and I see a loop of
errors over and over before it eventually panics:

(I just copied in a few of them since many of these repeated over and over:

[ 1541.821783] wlan0: authenticate with 6c:4b:b4:30:9b:04
[ 1542.000817] wlan0: send auth to 6c:4b:b4:30:9b:04 (try 1/3)
[ 1542.002490] wlan0: authenticated
[ 1542.006241] wlan0: associate with 6c:4b:b4:30:9b:04 (try 1/3)
[ 1542.010192] wlan0: RX AssocResp from 6c:4b:b4:30:9b:04 (capab=0x411
status=0 aid=14)
[ 1542.050657] wlan0: associated
[ 1542.075032] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
[ 1542.091614] wlan0: Limiting TX power to 30 (30 - 0) dBm as
advertised by 6c:4b:b4:30:9b:04
[ 1542.242112] BUG: scheduling while atomic: ksoftirqd/3/29/0x00000103
[ 1542.248587] Modules linked in: rt2800usb(E) rt2x00usb(E)
rt2800lib(E) rt2x00lib(E) mac80211(E) cfg80211(E) nvidia_modeset(OE)
fuse(E) lzo_rle(E) lzo_compress(E) zram(E) ramoops(E) reed_solomon(E)
loop(E) snd_soc_tegra186_asrc(E) snd_soc_tegra210_ope(E)
snd_soc_tegra186_arad(E) snd_soc_tegra186_dspk(E)
snd_soc_tegra210_iqc(E) aes_ce_blk(E) crypto_simd(E) cryptd(E)
snd_soc_tegra210_mvc(E) snd_soc_tegra210_afc(E) aes_ce_cipher(E)
snd_soc_tegra210_dmic(E) snd_soc_tegra210_adx(E) ghash_ce(E)
snd_soc_tegra210_amx(E) sha2_ce(E) snd_soc_tegra210_i2s(E)
snd_soc_tegra210_mixer(E) snd_soc_tegra210_admaif(E) sha256_arm64(E)
snd_soc_tegra210_sfc(E) snd_soc_tegra_pcm(E) hid_ite(E) sha1_ce(E)
input_leds(E) spidev(E) snd_soc_tegra210_adsp(E)
snd_soc_tegra_machine_driver(E) snd_soc_spdif_tx(E)
snd_soc_tegra_utils(E) snd_soc_simple_card_utils(E)
snd_hda_codec_hdmi(E) snd_soc_tegra210_ahub(E) nvadsp(E)
userspace_alert(E) snd_hda_tegra(E) tegra_bpmp_thermal(E)
tegra210_adma(E) nv_imx219(E) snd_hda_codec(E)
[ 1542.248665]  snd_hda_core(E) spi_tegra114(E) nvidia(OE)
binfmt_misc(E) ina3221(E) pwm_fan(E) nvgpu(E) nvmap(E) ip_tables(E)
x_tables(E) [last unloaded: mtd]
[ 1542.248686] CPU: 3 PID: 29 Comm: ksoftirqd/3 Tainted: G        W
OE     5.10.120-tegra #1
[ 1542.248687] Hardware name: Unknown NVIDIA Orin Nano Developer
Kit/NVIDIA Orin Nano Developer Kit, BIOS 4.1-33958178 08/01/2023
[ 1542.248690] Call trace:
[ 1542.248702]  dump_backtrace+0x0/0x1d0
[ 1542.248705]  show_stack+0x30/0x40
[ 1542.248712]  dump_stack+0xd8/0x138
[ 1542.248717]  __schedule_bug+0x78/0x90
[ 1542.248722]  __schedule+0x844/0x910
[ 1542.248724]  schedule+0x78/0x110
[ 1542.248727]  schedule_timeout+0x184/0x340
[ 1542.248731]  nvhost_syncpt_wait_timeout+0x450/0x720
[ 1542.248733]  nvhost_syncpt_wait_timeout_ext+0xf4/0x120
[ 1542.248738]  tegra_se_channel_submit_gather.isra.0+0x160/0x440
[ 1542.248740]  tegra_se_ccm_compute_auth+0x2d8/0x650
[ 1542.248743]  tegra_se_aes_ccm_encrypt+0x6c/0x150
[ 1542.248746]  crypto_aead_encrypt+0x38/0x50
[ 1542.248768]  aead_encrypt+0x130/0x180 [mac80211]
[ 1542.248782]  ieee80211_crypto_ccmp_encrypt+0x1f8/0x270 [mac80211]
[ 1542.248793]  ieee80211_txq_schedule_start+0xae4/0xc10 [mac80211]
[ 1542.248803]  ieee80211_proberesp_get+0x3ec/0x830 [mac80211]
[ 1542.248814]  ieee80211_tx_prepare_skb+0x27c/0x2d0 [mac80211]
[ 1542.248824]  ieee80211_xmit+0xa0/0xd0 [mac80211]
[ 1542.248835]  __ieee80211_subif_start_xmit+0x780/0xb10 [mac80211]
[ 1542.248845]  ieee80211_subif_start_xmit+0x5c/0x2f0 [mac80211]
[ 1542.248850]  dev_hard_start_xmit+0x10c/0x330
[ 1542.248855]  sch_direct_xmit+0xf4/0x360
[ 1542.248857]  __qdisc_run+0x140/0x730
[ 1542.248859]  net_tx_action+0x14c/0x380
[ 1542.248862]  __do_softirq+0x140/0x3e8
[ 1542.248865]  run_ksoftirqd+0x50/0x60
[ 1542.248868]  smpboot_thread_fn+0x1c4/0x280
[ 1542.248870]  kthread+0x148/0x170
[ 1542.248872]  ret_from_fork+0x10/0x24
[ 1542.248882] ------------[ cut here ]------------
[ 1542.248887] WARNING: CPU: 3 PID: 29 at kernel/rcu/tree_plugin.h:297
rcu_note_context_switch+0x50/0x540
[ 1542.258457] Modules linked in: rt2800usb(E) rt2x00usb(E)
rt2800lib(E) rt2x00lib(E) mac80211(E) cfg80211(E) nvidia_modeset(OE)
fuse(E) lzo_rle(E) lzo_compress(E) zram(E) ramoops(E) reed_solomon(E)
loop(E) snd_soc_tegra186_asrc(E) snd_soc_tegra210_ope(E)
snd_soc_tegra186_arad(E) snd_soc_tegra186_dspk(E)
snd_soc_tegra210_iqc(E) aes_ce_blk(E) crypto_simd(E) cryptd(E)
snd_soc_tegra210_mvc(E) snd_soc_tegra210_afc(E) aes_ce_cipher(E)
snd_soc_tegra210_dmic(E) snd_soc_tegra210_adx(E) ghash_ce(E)
snd_soc_tegra210_amx(E) sha2_ce(E) snd_soc_tegra210_i2s(E)
snd_soc_tegra210_mixer(E) snd_soc_tegra210_admaif(E) sha256_arm64(E)
snd_soc_tegra210_sfc(E) snd_soc_tegra_pcm(E) hid_ite(E) sha1_ce(E)
input_leds(E) spidev(E) snd_soc_tegra210_adsp(E)
snd_soc_tegra_machine_driver(E) snd_soc_spdif_tx(E)
snd_soc_tegra_utils(E) snd_soc_simple_card_utils(E)
snd_hda_codec_hdmi(E) snd_soc_tegra210_ahub(E) nvadsp(E)
userspace_alert(E) snd_hda_tegra(E) tegra_bpmp_thermal(E)
tegra210_adma(E) nv_imx219(E) snd_hda_codec(E)
[ 1542.258510]  snd_hda_core(E) spi_tegra114(E) nvidia(OE)
binfmt_misc(E) ina3221(E) pwm_fan(E) nvgpu(E) nvmap(E) ip_tables(E)
x_tables(E) [last unloaded: mtd]
[ 1542.258524] CPU: 3 PID: 29 Comm: ksoftirqd/3 Tainted: G        W
OE     5.10.120-tegra #1
[ 1542.258525] Hardware name: Unknown NVIDIA Orin Nano Developer
Kit/NVIDIA Orin Nano Developer Kit, BIOS 4.1-33958178 08/01/2023
[ 1542.258529] pstate: 20c00089 (nzCv daIf +PAN +UAO -TCO BTYPE=--)
[ 1542.258532] pc : rcu_note_context_switch+0x50/0x540
[ 1542.258535] lr : rcu_note_context_switch+0x28/0x540
[ 1542.258536] sp : ffff8000101e3270
[ 1542.258538] x29: ffff8000101e3270 x28: 0000000000000000
[ 1542.258541] x27: ffffb2b1e4fe7000 x26: ffffb2b1e49fbe00
[ 1542.258544] x25: 0000000000000000 x24: ffffb2b1e41c5858
[ 1542.258548] x23: ffff293a2e827e00 x22: ffff2938c0228ec0
[ 1542.258551] x21: 0000000000000000 x20: ffff2938c0228ec0
[ 1542.258554] x19: ffff293a2e828b00 x18: 0000000000000060
[ 1542.258557] x17: 0000000000018021 x16: ffffb2b1e2fe5220
[ 1542.258560] x15: ffff2938c0229430 x14: ffffffffffffffff
[ 1542.258564] x13: ffff8000901e2d75 x12: ffff8000101e2d7e
[ 1542.258567] x11: 0101010101010101 x10: ffffffffff7f7f7f
[ 1542.258570] x9 : 00000000fffffffe x8 : 343278302f303178
[ 1542.258573] x7 : 302b6b726f665f6d x6 : 0000000000000002
[ 1542.258576] x5 : ffff80001001c000 x4 : ffffb2b1e4ff2000
[ 1542.258579] x3 : ffffb2b1e4ff2dc0 x2 : ffffb2b1e3180d70
[ 1542.258582] x1 : ffff8000101e3270 x0 : 0000000000000002
[ 1542.258585] Call trace:
[ 1542.258589]  rcu_note_context_switch+0x50/0x540
[ 1542.258592]  __schedule+0xc0/0x910
[ 1542.258594]  schedule+0x78/0x110
[ 1542.258597]  schedule_timeout+0x184/0x340
[ 1542.258600]  nvhost_syncpt_wait_timeout+0x450/0x720
[ 1542.258602]  nvhost_syncpt_wait_timeout_ext+0xf4/0x120
[ 1542.258605]  tegra_se_channel_submit_gather.isra.0+0x160/0x440
[ 1542.258607]  tegra_se_ccm_compute_auth+0x2d8/0x650
[ 1542.258610]  tegra_se_aes_ccm_encrypt+0x6c/0x150
[ 1542.258612]  crypto_aead_encrypt+0x38/0x50
[ 1542.258625]  aead_encrypt+0x130/0x180 [mac80211]
[ 1542.258636]  ieee80211_crypto_ccmp_encrypt+0x1f8/0x270 [mac80211]
[ 1542.258648]  ieee80211_txq_schedule_start+0xae4/0xc10 [mac80211]
[ 1542.258660]  ieee80211_proberesp_get+0x3ec/0x830 [mac80211]
[ 1542.258672]  ieee80211_tx_prepare_skb+0x27c/0x2d0 [mac80211]
[ 1542.258684]  ieee80211_xmit+0xa0/0xd0 [mac80211]
[ 1542.258695]  __ieee80211_subif_start_xmit+0x780/0xb10 [mac80211]
[ 1542.258707]  ieee80211_subif_start_xmit+0x5c/0x2f0 [mac80211]
[ 1542.258710]  dev_hard_start_xmit+0x10c/0x330
[ 1542.258713]  sch_direct_xmit+0xf4/0x360
[ 1542.258715]  __qdisc_run+0x140/0x730
[ 1542.258718]  net_tx_action+0x14c/0x380
[ 1542.258720]  __do_softirq+0x140/0x3e8
[ 1542.258723]  run_ksoftirqd+0x50/0x60
[ 1542.258726]  smpboot_thread_fn+0x1c4/0x280
[ 1542.258728]  kthread+0x148/0x170
[ 1542.258730]  ret_from_fork+0x10/0x24
[ 1542.258732] ---[ end trace c64fbdc5cc928ac7 ]---
[ 1542.263555] NOHZ tick-stop error: Non-RCU local softirq work is
pending, handler #280!!!
[ 1542.271921] softirq: huh, entered softirq 2 NET_TX 00000000548727ea
with preempt_count 00000100, exited with fffffffe?
[ 1542.275488] BUG: scheduling while atomic: ksoftirqd/5/39/0x00000103
[ 1542.289407] Modules linked in: rt2800usb(E) rt2x00usb(E)
rt2800lib(E) rt2x00lib(E) mac80211(E) cfg80211(E) nvidia_modeset(OE)
fuse(E) lzo_rle(E) lzo_compress(E) zram(E) ramoops(E) reed_solomon(E)
loop(E) snd_soc_tegra186_asrc(E) snd_soc_tegra210_ope(E)
snd_soc_tegra186_arad(E) snd_soc_tegra186_dspk(E)
snd_soc_tegra210_iqc(E) aes_ce_blk(E) crypto_simd(E) cryptd(E)
snd_soc_tegra210_mvc(E) snd_soc_tegra210_afc(E) aes_ce_cipher(E)
snd_soc_tegra210_dmic(E) snd_soc_tegra210_adx(E) ghash_ce(E)
snd_soc_tegra210_amx(E) sha2_ce(E) snd_soc_tegra210_i2s(E)
snd_soc_tegra210_mixer(E) snd_soc_tegra210_admaif(E) sha256_arm64(E)
snd_soc_tegra210_sfc(E) snd_soc_tegra_pcm(E) hid_ite(E) sha1_ce(E)
input_leds(E) spidev(E) snd_soc_tegra210_adsp(E)
snd_soc_tegra_machine_driver(E) snd_soc_spdif_tx(E)
snd_soc_tegra_utils(E) snd_soc_simple_card_utils(E)
snd_hda_codec_hdmi(E) snd_soc_tegra210_ahub(E) nvadsp(E)
userspace_alert(E) snd_hda_tegra(E) tegra_bpmp_thermal(E)
tegra210_adma(E) nv_imx219(E) snd_hda_codec(E)
[ 1542.289527]  snd_hda_core(E) spi_tegra114(E) nvidia(OE)
binfmt_misc(E) ina3221(E) pwm_fan(E) nvgpu(E) nvmap(E) ip_tables(E)
x_tables(E) [last unloaded: mtd]
[ 1542.289559] CPU: 5 PID: 39 Comm: ksoftirqd/5 Tainted: G        W
OE     5.10.120-tegra #1
[ 1542.289563] Hardware name: Unknown NVIDIA Orin Nano Developer
Kit/NVIDIA Orin Nano Developer Kit, BIOS 4.1-33958178 08/01/2023
[ 1542.289566] Call trace:
[ 1542.289578]  dump_backtrace+0x0/0x1d0
[ 1542.289585]  show_stack+0x30/0x40
[ 1542.289594]  dump_stack+0xd8/0x138
[ 1542.289602]  __schedule_bug+0x78/0x90
[ 1542.289609]  __schedule+0x844/0x910
[ 1542.289613]  schedule+0x78/0x110
[ 1542.289619]  schedule_timeout+0x184/0x340
[ 1542.289625]  nvhost_syncpt_wait_timeout+0x450/0x720
[ 1542.289629]  nvhost_syncpt_wait_timeout_ext+0xf4/0x120
[ 1542.289636]  tegra_se_channel_submit_gather.isra.0+0x160/0x440
[ 1542.289641]  tegra_se_ccm_compute_auth+0x2d8/0x650
[ 1542.289646]  tegra_se_aes_ccm_encrypt+0x6c/0x150
[ 1542.289651]  crypto_aead_encrypt+0x38/0x50
[ 1542.289685]  aead_encrypt+0x130/0x180 [mac80211]
[ 1542.289711]  ieee80211_crypto_ccmp_encrypt+0x1f8/0x270 [mac80211]
[ 1542.289735]  ieee80211_txq_schedule_start+0xae4/0xc10 [mac80211]
[ 1542.289757]  ieee80211_proberesp_get+0x3ec/0x830 [mac80211]
[ 1542.289779]  ieee80211_tx_prepare_skb+0x27c/0x2d0 [mac80211]
[ 1542.289801]  ieee80211_xmit+0xa0/0xd0 [mac80211]
[ 1542.289823]  __ieee80211_subif_start_xmit+0x780/0xb10 [mac80211]
[ 1542.289845]  ieee80211_subif_start_xmit+0x5c/0x2f0 [mac80211]
[ 1542.289852]  dev_hard_start_xmit+0x10c/0x330
[ 1542.289858]  sch_direct_xmit+0xf4/0x360
[ 1542.289862]  __qdisc_run+0x140/0x730
[ 1542.289867]  net_tx_action+0x14c/0x380
[ 1542.289871]  __do_softirq+0x140/0x3e8
[ 1542.289876]  run_ksoftirqd+0x50/0x60
[ 1542.289882]  smpboot_thread_fn+0x1c4/0x280
[ 1542.289885]  kthread+0x148/0x170
[ 1542.289890]  ret_from_fork+0x10/0x24
[ 1542.290056] softirq: huh, entered softirq 2 NET_TX 00000000548727ea
with preempt_count 00000100, exited with fffffffe?
[ 1542.310049] BUG: scheduling while atomic: kworker/u12:0/3307/0x00000201
[ 1542.316883] Modules linked in: rt2800usb(E) rt2x00usb(E)
rt2800lib(E) rt2x00lib(E) mac80211(E) cfg80211(E) nvidia_modeset(OE)
fuse(E) lzo_rle(E) lzo_compress(E) zram(E) ramoops(E) reed_solomon(E)
loop(E) snd_soc_tegra186_asrc(E) snd_soc_tegra210_ope(E)
snd_soc_tegra186_arad(E) snd_soc_tegra186_dspk(E)
snd_soc_tegra210_iqc(E) aes_ce_blk(E) crypto_simd(E) cryptd(E)
snd_soc_tegra210_mvc(E) snd_soc_tegra210_afc(E) aes_ce_cipher(E)
snd_soc_tegra210_dmic(E) snd_soc_tegra210_adx(E) ghash_ce(E)
snd_soc_tegra210_amx(E) sha2_ce(E) snd_soc_tegra210_i2s(E)
snd_soc_tegra210_mixer(E) snd_soc_tegra210_admaif(E) sha256_arm64(E)
snd_soc_tegra210_sfc(E) snd_soc_tegra_pcm(E) hid_ite(E) sha1_ce(E)
input_leds(E) spidev(E) snd_soc_tegra210_adsp(E)
snd_soc_tegra_machine_driver(E) snd_soc_spdif_tx(E)
snd_soc_tegra_utils(E) snd_soc_simple_card_utils(E)
snd_hda_codec_hdmi(E) snd_soc_tegra210_ahub(E) nvadsp(E)
userspace_alert(E) snd_hda_tegra(E) tegra_bpmp_thermal(E)
tegra210_adma(E) nv_imx219(E) snd_hda_codec(E)
[ 1542.316959]  snd_hda_core(E) spi_tegra114(E) nvidia(OE)
binfmt_misc(E) ina3221(E) pwm_fan(E) nvgpu(E) nvmap(E) ip_tables(E)
x_tables(E) [last unloaded: mtd]
[ 1542.316981] CPU: 0 PID: 3307 Comm: kworker/u12:0 Tainted: G
W  OE     5.10.120-tegra #1
[ 1542.316983] Hardware name: Unknown NVIDIA Orin Nano Developer
Kit/NVIDIA Orin Nano Developer Kit, BIOS 4.1-33958178 08/01/2023
[ 1542.317008] Workqueue: phy0 ieee80211_ba_session_work [mac80211]
[ 1542.317011] Call trace:
[ 1542.317018]  dump_backtrace+0x0/0x1d0
[ 1542.317022]  show_stack+0x30/0x40
[ 1542.317029]  dump_stack+0xd8/0x138
[ 1542.317033]  __schedule_bug+0x78/0x90
[ 1542.317038]  __schedule+0x844/0x910
[ 1542.317040]  schedule+0x78/0x110
[ 1542.317044]  schedule_timeout+0x184/0x340
[ 1542.317047]  nvhost_syncpt_wait_timeout+0x450/0x720
[ 1542.317050]  nvhost_syncpt_wait_timeout_ext+0xf4/0x120
[ 1542.317054]  tegra_se_channel_submit_gather.isra.0+0x160/0x440
[ 1542.317057]  tegra_se_ccm_compute_auth+0x2d8/0x650
[ 1542.317060]  tegra_se_aes_ccm_encrypt+0x6c/0x150
[ 1542.317063]  crypto_aead_encrypt+0x38/0x50
[ 1542.317080]  aead_encrypt+0x130/0x180 [mac80211]
[ 1542.317094]  ieee80211_crypto_ccmp_encrypt+0x1f8/0x270 [mac80211]
[ 1542.317108]  ieee80211_txq_schedule_start+0xae4/0xc10 [mac80211]
[ 1542.317121]  ieee80211_proberesp_get+0x3ec/0x830 [mac80211]
[ 1542.317135]  ieee80211_tx_prepare_skb+0x27c/0x2d0 [mac80211]
[ 1542.317148]  ieee80211_xmit+0xa0/0xd0 [mac80211]
[ 1542.317161]  __ieee80211_tx_skb_tid_band+0x84/0xb0 [mac80211]
[ 1542.317174]  ieee80211_start_tx_ba_cb_irqsafe+0x300/0x3c0 [mac80211]
[ 1542.317187]  ieee80211_tx_ba_session_handle_start+0xec/0x1b0 [mac80211]
[ 1542.317200]  ieee80211_ba_session_work+0x2a0/0x350 [mac80211]
[ 1542.317204]  process_one_work+0x1c4/0x4a0
[ 1542.317206]  worker_thread+0x54/0x430
[ 1542.317208]  kthread+0x148/0x170
[ 1542.317211]  ret_from_fork+0x10/0x24
[ 1542.317383] BUG: workqueue leaked lock or atomic:
kworker/u12:0/0xfffffe00/3307
                    last function: ieee80211_ba_session_work [mac80211]


The last set of messages:

[ 1575.970833] BUG: scheduling while atomic: NetworkManager/593/0xfffffdff
[ 1575.977680] Modules linked in: rt2800usb(E) rt2x00usb(E)
rt2800lib(E) rt2x00lib(E) mac80211(E) cfg80211(E) nvidia_modeset(OE)
fuse(E) lzo_rle(E) lzo_compress(E) zram(E) ramoops(E) reed_solomon(E)
loop(E) snd_soc_tegra186_asrc(E) snd_soc_tegra210_ope(E)
snd_soc_tegra186_arad(E) snd_soc_tegra186_dspk(E)
snd_soc_tegra210_iqc(E) aes_ce_blk(E) crypto_simd(E) cryptd(E)
snd_soc_tegra210_mvc(E) snd_soc_tegra210_afc(E) aes_ce_cipher(E)
snd_soc_tegra210_dmic(E) snd_soc_tegra210_adx(E) ghash_ce(E)
snd_soc_tegra210_amx(E) sha2_ce(E) snd_soc_tegra210_i2s(E)
snd_soc_tegra210_mixer(E) snd_soc_tegra210_admaif(E) sha256_arm64(E)
snd_soc_tegra210_sfc(E) snd_soc_tegra_pcm(E) hid_ite(E) sha1_ce(E)
input_leds(E) spidev(E) snd_soc_tegra210_adsp(E)
snd_soc_tegra_machine_driver(E) snd_soc_spdif_tx(E)
snd_soc_tegra_utils(E) snd_soc_simple_card_utils(E)
snd_hda_codec_hdmi(E) snd_soc_tegra210_ahub(E) nvadsp(E)
userspace_alert(E) snd_hda_tegra(E) tegra_bpmp_thermal(E)
tegra210_adma(E) nv_imx219(E) snd_hda_codec(E)
[ 1575.977790]  snd_hda_core(E) spi_tegra114(E) nvidia(OE)
binfmt_misc(E) ina3221(E) pwm_fan(E) nvgpu(E) nvmap(E) ip_tables(E)
x_tables(E) [last unloaded: mtd]
[ 1575.977819] CPU: 4 PID: 593 Comm: NetworkManager Tainted: G
W  OE     5.10.120-tegra #1
[ 1575.977822] Hardware name: Unknown NVIDIA Orin Nano Developer
Kit/NVIDIA Orin Nano Developer Kit, BIOS 4.1-33958178 08/01/2023
[ 1575.977825] Call trace:
[ 1575.977834]  dump_backtrace+0x0/0x1d0
[ 1575.977840]  show_stack+0x30/0x40
[ 1575.977846]  dump_stack+0xd8/0x138
[ 1575.977852]  __schedule_bug+0x78/0x90
[ 1575.977857]  __schedule+0x844/0x910
[ 1575.977861]  schedule+0x78/0x110
[ 1575.977867]  schedule_hrtimeout_range_clock+0xa0/0x120
[ 1575.977872]  schedule_hrtimeout_range+0x3c/0x50
[ 1575.977880]  do_sys_poll+0x3d4/0x770
[ 1575.977885]  __arm64_sys_ppoll+0xc0/0x100
[ 1575.977891]  el0_svc_common.constprop.0+0x80/0x1d0
[ 1575.977896]  do_el0_svc+0x38/0xb0
[ 1575.977900]  el0_svc+0x1c/0x30
[ 1575.977904]  el0_sync_handler+0xa8/0xb0
[ 1575.977908]  el0_sync+0x16c/0x180
[ 1587.493670] wlan0: deauthenticating from 6c:4b:b4:30:9b:04 by local
choice (Reason: 3=DEAUTH_LEAVING)

Then at this point the communications were cut (I was using a wired
interface to capture)

>From the serial port, once I tell it to connect to the local network,
this is all that is output before serial stops

[  533.875985] BUG: scheduling while atomic: ksoftirqd/0/12/0x00000103
[  533.882790] WARNING: CPU: 0 PID: 12 at kernel/rcu/tree_plugin.h:297
rcu_note_context_switch+0x50/0x540
[  533.892621] ---[ end trace a78168b0d15c7046 ]---
[  533.897590] softirq: huh, entered softirq 2 NET_TX 00000000cca7c5d3
with preempt_count 00000100, exited with fffffffe?
[  533.941129] BUG: scheduling while atomic: ksoftirqd/2/24/0x00000103
[  533.947928] softirq: huh, entered softirq 2 NET_TX 00000000cca7c5d3
with preempt_count 00000100, exited with fffffffe?
[  533.963887] BUG: scheduling while atomic: kworker/u12:3/722/0x00000201
[  533.971012] BUG: workqueue leaked lock or atomic:
kworker/u12:3/0xfffffe00/722
[  533.971012]      last function: ieee80211_ba_session_work [mac80211]
[  533.985079] BUG: workqueue leaked lock or atomic:
kworker/u12:3/0xfffffe00/722
[  533.985079]      last function: ieee80211_ibss_leave [mac80211]
[  533.998657] BUG: scheduling while atomic: kworker/u12:3/722/0xfffffe01
[  534.983931] BUG: scheduling while atomic: kworker/u12:0/7/0x00000102
[  534.991172] NOHZ tick-stop error: Non-RCU local softirq work is
pending, handler #02!!!
[  535.007609] softirq: huh, entered softirq 6 TASKLET
0000000048396bde with preempt_count 00000101, exited with 00000000?
[  535.018825] BUG: scheduling while atomic: kworker/u12:0/7/0x00000201
[  535.026005] BUG: workqueue leaked lock or atomic: kworker/u12:0/0xfffffe00/7
[  535.026005]      last function: ieee80211_ba_session_work [mac80211]
[  535.040029] BUG: scheduling while atomic: kworker/u12:0/7/0xfffffe01
[  535.056041] BUG: scheduling while atomic: kworker/u12:0/7/0x00000201
[  535.063242] BUG: workqueue leaked lock or atomic: kworker/u12:0/0xfffffe00/7
[  535.063242]      last function: ieee80211_ba_session_work [mac80211]
[  535.077144] BUG: scheduling while atomic: kworker/u12:0/7/0xfffffe01
[  535.084030] NOHZ tick-stop error: Non-RCU local softirq work is
pending, handler #280!!!
[  535.854930] BUG: scheduling while atomic: NetworkManager/625/0x00000203
[  535.862489] NOHZ tick-stop error: Non-RCU local softirq work is
pending, handler #2c0!!!
[  535.870814] NOHZ tick-stop error: Non-RCU local softirq work is
pending, handler #2c0!!!
[  535.887341] WARNING: CPU: 0 PID: 625 at kernel/softirq.c:174
__local_bh_enable_ip+0xac/0xc0
[  535.896074] ---[ end trace a78168b0d15c7047 ]---
[  535.900889] BUG: scheduling while atomic: NetworkManager/625/0xfffffdff
[  535.907957] NOHZ tick-stop error: Non-RCU local softirq work is
pending, handler #2c2!!!
[  535.916279] NOHZ tick-stop error: Non-RCU local softirq work is
pending, handler #2c2!!!
[  536.103830] BUG: scheduling while atomic: kworker/u12:0/7/0x00000102
[  536.110787] softirq: huh, entered softirq 6 TASKLET
0000000048396bde with preempt_count 00000101, exited with 00000000?
[  536.121976] BUG: scheduling while atomic: kworker/u12:0/7/0x00000201
[  536.128931] BUG: workqueue leaked lock or atomic: kworker/u12:0/0xfffffe00/7
[  536.128931]      last function: ieee80211_ba_session_work [mac80211]
[  536.142827] BUG: scheduling while atomic: kworker/u12:0/7/0xfffffe01
[  536.149562] NOHZ tick-stop error: Non-RCU local softirq work is
pending, handler #80!!!
[  536.157772] NOHZ tick-stop error: Non-RCU local softirq work is
pending, handler #80!!!
[  536.187788] BUG: scheduling while atomic: kworker/u12:0/7/0x00000201
[  536.194783] BUG: workqueue leaked lock or atomic: kworker/u12:0/0xfffffe00/7
[  536.194783]      last function: ieee80211_ba_session_work [mac80211]
[  536.208655] BUG: scheduling while atomic: kworker/u12:0/7/0xfffffe01
[  536.215394] NOHZ tick-stop error: Non-RCU local softirq work is
pending, handler #280!!!
[  537.227755] BUG: scheduling while atomic: kworker/u12:3/722/0x00000102
[  537.234965] NOHZ tick-stop error: Non-RCU local softirq work is
pending, handler #282!!!
[  537.251488] softirq: huh, entered softirq 6 TASKLET
0000000048396bde with preempt_count 00000101, exited with 00000000?
[  537.262678] BUG: scheduling while atomic: kworker/u12:3/722/0x00000201
[  537.269960] BUG: workqueue leaked lock or atomic:
kworker/u12:3/0xfffffe00/722
[  537.269960]      last function: ieee80211_ba_session_work [mac80211]
[  537.284025] BUG: workqueue leaked lock or atomic:
kworker/u12:3/0xfffffe00/722
[  537.284025]      last function: ieee80211_ibss_leave [mac80211]
[  537.297583] BUG: scheduling while atomic: kworker/u12:3/722/0xfffffe01
[  537.343746] BUG: scheduling while atomic: kworker/u12:3/722/0x00000201
[  537.351032] BUG: workqueue leaked lock or atomic:
kworker/u12:3/0xfffffe00/722
[  537.351032]      last function: ieee80211_ba_session_work [mac80211]
[  537.365115] BUG: scheduling while atomic: kworker/u12:3/722/0xfffffe01
[  538.375733] BUG: scheduling while atomic: kworker/u12:0/7/0x00000102
[  538.392605] softirq: huh, entered softirq 6 TASKLET
0000000048396bde with preempt_count 00000101, exited with 00000000?
[  538.403822] BUG: scheduling while atomic: kworker/u12:0/7/0x00000201
[  538.410984] BUG: workqueue leaked lock or atomic: kworker/u12:0/0xfffffe00/7
[  538.410984]      last function: ieee80211_ba_session_work [mac80211]
[  538.424985] BUG: workqueue leaked lock or atomic: kworker/u12:0/0xfffffe00/7
[  538.424985]      last function: ieee80211_ba_session_work [mac80211]
[  538.438865] BUG: scheduling while atomic: kworker/u12:0/7/0xfffffe01
[  538.460354] BUG: scheduling while atomic: ksoftirqd/0/12/0x00000101
[  538.467953] softirq: huh, entered softirq 6 TASKLET
0000000048396bde with preempt_count 00000100, exited with 00000000?
[  538.631875] BUG: scheduling while atomic: ksoftirqd/5/39/0x00000103
[  538.639025] softirq: huh, entered softirq 2 NET_TX 00000000cca7c5d3
with preempt_count 00000100, exited with fffffffe?
[  539.508955] BUG: scheduling while atomic: NetworkManager/625/0x00000403
[  539.525507] BUG: scheduling while atomic: NetworkManager/625/0xfffffbff
[  542.849869] BUG: scheduling while atomic: NetworkManager/625/0x00000203
[  542.866840] BUG: scheduling while atomic: NetworkManager/625/0xfffffdff
[  543.508184] BUG: scheduling while atomic: NetworkManager/625/0x00000403
[  543.523724] BUG: scheduling while atomic: NetworkManager/625/0xfffffbff
[  543.582356] BUG: scheduling while atomic: NetworkManager/625/0x00000403
[  543.590206] WARNING: CPU: 2 PID: 625 at net/core/skbuff.c:665
skb_release_head_state+0x10c/0x120
[  543.599396] ---[ end trace a78168b0d15c7048 ]---
[  543.604213] WARNING: CPU: 2 PID: 625 at net/core/skbuff.c:665
skb_release_head_state+0x10c/0x120
[  543.613516] ---[ end trace a78168b0d15c7049 ]---
[  543.618313] WARNING: CPU: 2 PID: 625 at net/core/skbuff.c:665
skb_release_head_state+0x10c/0x120
[  543.627533] ---[ end trace a78168b0d15c704a ]---
[  543.632440] WARNING: CPU: 2 PID: 625 at net/core/skbuff.c:665
skb_release_head_state+0x10c/0x120
[  543.641624] ---[ end trace a78168b0d15c704b ]---
[  543.646395] BUG: scheduling while atomic: NetworkManager/625/0xfffffbff
[  543.653378] BUG: scheduling while atomic: kworker/2:1/44/0x00000505
[  543.660273] ------------[ cut here ]------------
[  543.665037] WARNING: CPU: 2 PID: 44 at kernel/time/timer.c:1420
call_timer_fn+0x1f8/0x200
[  543.673596] ---[ end trace a78168b0d15c704c ]---
[  543.687399] BUG: scheduling while atomic: swapper/2/0/0x00000504
[  543.693876] bad: scheduling from the idle thread!

Then unit reboots.

If I turn on auto-connect, and boot with the device already attached,
I can see the panic, from serial output:

[   23.278662] BUG: scheduling while atomic: NetworkManager/722/0x00000203
[   23.286079] WARNING: CPU: 1 PID: 722 at
kernel/rcu/tree_plugin.h:297 rcu_note_context_switch+0x50/0x540
[   23.296285] ---[ end trace 60819f07c492dc1c ]---
[   23.382446] BUG: scheduling while atomic: NetworkManager/722/0x00000505
[   23.389654] NOHZ tick-stop error: Non-RCU local softirq work is
pending, handler #202!!!
[   23.397965] NOHZ tick-stop error: Non-RCU local softirq work is
pending, handler #202!!!
[   23.406289] WARNING: CPU: 1 PID: 0 at kernel/rcu/tree.c:624
rcu_eqs_enter.isra.0+0x128/0x130
[   23.415092] ---[ end trace 60819f07c492dc1d ]---
[   29.410485] Kernel panic - not syncing: stack-protector: Kernel
stack is corrupted in: __schedule+0x910/0x910
[   29.420717] CPU: 1 PID: 722 Comm: NetworkManager Tainted: G
W  OE     5.10.120-tegra #1
[   29.429584] Hardware name: Unknown NVIDIA Orin Nano Developer
Kit/NVIDIA Orin Nano Developer Kit, BIOS 4.1-33958178 08/01/2023
[   29.441313] Call trace:
[   29.443843]  dump_backtrace+0x0/0x1d0
[   29.447614]  show_stack+0x30/0x40
[   29.451025]  dump_stack+0xd8/0x138
[   29.454519]  panic+0x17c/0x384
[   29.457661]  __stack_chk_fail+0x30/0x40
[   29.461608]  schedule+0x0/0x110
[   29.464837]  schedule+0x78/0x110
[   29.468158]  __arm_lpae_dma_sync+0x1e0/0x200
[   29.472550]  __arm_lpae_dma_sync+0x14c/0x200
[   29.476951]  __arm_lpae_dma_sync+0x14c/0x200
[   29.481342]  __arm_lpae_dma_sync+0x14c/0x200
[   29.485735]  arm_lpae_dma_sync+0x54/0x80
[   29.489771]  arm_smmu_dma_sync+0x40/0x70
[   29.493805]  __iommu_map+0x138/0x250
[   29.497479]  _iommu_map+0x70/0xd0
[   29.500892]  0x80
[   29.502879] SMP: stopping secondary CPUs
[   29.506918] Kernel Offset: 0x2ff010360000 from 0xffff800010000000
[   29.513177] PHYS_OFFSET: 0xffffb7a9c0000000
[   29.517465] CPU features: 0x08040006,4a80aa38
[   29.521933] Memory Limit: none
[   29.536986] ---[ end Kernel panic - not syncing: stack-protector:
Kernel stack is corrupted in: __schedule+0x910/0x910 ]---


> The rt2800 driver wasn't modified for ages. It's rater stable, but
> perhaps there are issues in other involved modules i.e. mac80211.
>
> Regards
> Stanislaw


Thanks!
Rick

Powered by blists - more mailing lists

Powered by Openwall GNU/*/Linux Powered by OpenVZ