Diskuse:TurtleBot

Problém s nahozením Wi-Fi

Obávám se, že jde o problém, který nedokážu jednoduchým způsobem ošetřit. Pokusím se objasnit proč. Toto je výstup zachycený na stroji turtle08, jak vypadá když vše dojede OK:

Inicializace zařízení

Jako první natáhne jádro ethernetový ovladač

[    1.632740] e1000e: Intel(R) PRO/1000 Network Driver
[    1.633207] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
[    1.634136] e1000e 0000:00:1f.6: Interrupt Throttling Rate (ints/sec) set to dynamic conservative mode
..
[    1.709842] e1000e 0000:00:1f.6 0000:00:1f.6 (uninitialized): registered PHC clock

Následně se začnou natahovat certifikáty k Wi-Fi

[    1.727168] cfg80211: Loading compiled-in X.509 certificates for regulatory database
[    1.727759] Loaded X.509 cert 'benh@debian.org: 577e021cb980e0e820821ba7b54b4961b8b4fadf'
[    1.728343] Loaded X.509 cert 'romain.perier@gmail.com: 3abbc6ec146e09d1b6016ab9d6cf71dd233f0328'
[    1.729727] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
[    1.730132] platform regulatory.0: firmware: failed to load regulatory.db (-2)
[    1.730933] firmware_class: See https://wiki.debian.org/Firmware for information about missing firmware
[    1.733114] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2
[    1.734259] cfg80211: failed to load regulatory.db

..a pak jádro natáhne i firmware

[    1.768851] Intel(R) Wireless WiFi driver for Linux
[    1.769543] iwlwifi 0000:01:00.0: enabling device (0000 -> 0002)
[    1.772989] iwlwifi 0000:01:00.0: Detected crf-id 0xbadcafe, cnv-id 0x10 wfpm id 0x80000000
[    1.773468] iwlwifi 0000:01:00.0: PCI dev 24fd/0010, rev=0x230, rfid=0xd55555d5
[    1.774785] iwlwifi 0000:01:00.0: firmware: direct-loading firmware iwlwifi-8265-36.ucode

V tuhle chvíli už je ethernet připravený k použití..

[   18.238426] [    1.780476] e1000e 0000:00:1f.6 eth0: (PCI Express:2.5GT/s:Width x1) 54:b2:03:12:1e:e0
[   18.239396] [    1.780837] e1000e 0000:00:1f.6 eth0: Intel(R) PRO/1000 Network Connection
[   18.240001] [    1.781251] e1000e 0000:00:1f.6 eth0: MAC: 12, PHY: 12, PBA No: FFFFFF-0FF
..
[   18.240654] [    1.795040] iwlwifi 0000:01:00.0: loaded firmware version 36.ca7b901d.0 8265-36.ucode op_mode iwlmvm

.. a zařízení může být přejmenováno na eth0. Také natahování firmware Wi-Fi proběhlo v pořádku, jak je zřejmé z následující informace o přejmenování.

[   18.242715] [    2.075179] e1000e 0000:00:1f.6 eno1: renamed from eth0
..
[   18.247688] [    2.247199] iwlwifi 0000:01:00.0: Detected Intel(R) Dual Band Wireless AC 8265, REV=0x230
..
[   18.249300] [    2.312282] iwlwifi 0000:01:00.0: base HW address: 3c:6a:a7:8a:66:55, OTP minor version: 0x0
[   18.250292] [    2.389956] ieee80211 phy0: Selected rate control algorithm 'iwl-mvm-rs'
[   18.250886] [    2.423290] iwlwifi 0000:01:00.0 wlp1s0: renamed from wlan0
..
[   18.287650] [    7.660321] iwlwifi 0000:01:00.0: Registered PHC clock: iwlwifi-PTP, with index: 1

A v tomto bodě nastává problém, protože na následující krok vůbec nedojde.

Zavádění v ramdisku je přerušeno dřív, než dojde na realizaci fáze nfs-top, která začíná spuštěním následujícího skriptu.

Spuštění skriptu enable_wireless

Začíná detekcí zařízení. K nahození aplikace wpa_supplicant dojde jen v případě, že není k dispozici ethernet.

[   18.288258] [   10.711742] Successfully initialized wpa_supplicant
[   18.288865] [   10.801533] Waiting for connection (max 10 seconds)
[   18.289450] [   10.811253] REPEAT CONFIGURE NETWORK

V tomto bodě končí ramdiskový skript enable_wireless svou práci a volá standardní funkci configure_networking Divné je, že se v logu neobjevila žádná informace o stavu WLAN. Nicméně další průběh byl normální.

[   18.290051] [   14.247300] wlp1s0: authenticate with 48:4a:e9:53:3a:91
[   18.290660] [   14.261987] wlp1s0: send auth to 48:4a:e9:53:3a:91 (try 1/3)
[   18.291214] [   14.269409] wlp1s0: authenticated
[   18.291821] [   14.271065] wlp1s0: associate with 48:4a:e9:53:3a:91 (try 1/3)
[   18.292482] [   14.273719] wlp1s0: RX AssocResp from 48:4a:e9:53:3a:91 (capab=0x1411 status=0 aid=6)
[   18.293428] [   14.279101] wlp1s0: associated
[   18.294092] [   14.395891] wlp1s0: Limiting TX power to 30 (30 - 0) dBm as advertised by 48:4a:e9:53:3a:91
[   18.295067] [   15.737428] printk: console [netcon0] enabled
[   18.295634] [   15.738288] netconsole: network logging started
[   18.296197] [   17.764430] netpoll: netconsole: local port 6665
[   18.296790] [   17.765430] netpoll: netconsole: local IPv4 address 192.168.65.28
[   18.297360] [   17.766410] netpoll: netconsole: interface 'wlp1s0'
[   18.297901] [   17.767389] netpoll: netconsole: remote port 9294
[   18.298468] [   17.768307] netpoll: netconsole: remote IPv4 address 192.168.65.4
[   18.299059] [   17.769242] netpoll: netconsole: remote ethernet address 9e:a2:58:82:1b:fd
[   18.299576] [   17.770160] netconsole: network logging started
[   18.300106] [   17.770563] START REMOTE LOG FROM 192.168.65.28 turtle08
[   18.300613] [   17.770940] ------------[ cut here ]------------
[   18.301254] [   17.770942] WARNING: CPU: 5 PID: 337 at net/mac80211/tx.c:3801 ieee80211_tx_dequeue+0xcb3/0xd30 [mac80211]
[   18.303079] [   17.771036] Modules linked in: netconsole configfs ctr ccm hid_generic usbhid hid iwlmvm mac80211 crc32_pclmul crc32c_intel libarc4 iwlwifi ghash_clmulni_intel ahci sha512_ssse3 libahci xhci_pci sha512_generic cfg80211 xhci_hcd nvme aesni_intel libata nvme_core intel_lpss_pci crypto_simd t10_pi e1000e usbcore scsi_mod crc64_rocksoft_generic intel_lpss crc64_rocksoft cryptd crc_t10dif crct10dif_generic rfkill crct10dif_pclmul crc64 crct10dif_common scsi_common idma64 usb_common fan video wmi
[   18.305486] [   17.771069] CPU: 5 PID: 337 Comm: debug Not tainted 6.5.0-0.deb12.4-amd64 #1  Debian 6.5.10-1~bpo12+1
[   18.306550] [   17.771073] Hardware name: Intel(R) Client Systems NUC7i7DNKE/NUC7i7DNB, BIOS DNKBLi7v.86A.0052.2018.0808.1344 08/08/2018
[   18.307533] [   17.771075] RIP: 0010:ieee80211_tx_dequeue+0xcb3/0xd30 [mac80211]
[   18.308456] [   17.771150] Code: ff ff 01 ce 48 89 ef 29 d6 e8 a9 66 9f e3 48 85 c0 0f 84 23 f8 ff ff 0f b7 85 b8 00 00 00 48 03 85 c8 00 00 00 e9 f5 f7 ff ff <0f> 0b e9 af f3 ff ff 0f 0b e9 05 f8 ff ff 4c 8b 6c 24 40 48 89 eb
[   18.309851] [   17.771152] RSP: 0018:ffffbaf940b7f820 EFLAGS: 00010046
[   18.310487] [   17.771155] RAX: 0000000080000003 RBX: 0000000000000002 RCX: 0000000000000000
[   18.311126] [   17.771156] RDX: ffff95428747b400 RSI: ffff95418036a0e8 RDI: ffffbaf940b7f8b8
[   18.311764] [   17.771158] RBP: ffff95418036a114 R08: ffff95418036a000 R09: 000000000000001c
[   18.312406] [   17.771159] R10: ffff95418036a0e8 R11: 0000000000000000 R12: ffff95418036a000
[   18.313051] [   17.771161] R13: ffff9541626e5c70 R14: ffff95418036a0e8 R15: ffff95416205a088
[   18.313726] [   17.771162] FS:  00007efd53804740(0000) GS:ffff9542a5d40000(0000) knlGS:0000000000000000
[   18.314776] [   17.771165] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[   18.315454] [   17.771166] CR2: 000055e8168f1b88 CR3: 0000000104018003 CR4: 00000000003706e0
[   18.316134] [   17.771169] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
[   18.316812] [   17.771170] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
[   18.317367] [   17.771171] Call Trace:
[   18.317909] [   17.771174]  <TASK>
[   18.318527] [   17.771176]  ? ieee80211_tx_dequeue+0xcb3/0xd30 [mac80211]
[   18.319091] [   17.771249]  ? __warn+0x81/0x130
[   18.319696] [   17.771255]  ? ieee80211_tx_dequeue+0xcb3/0xd30 [mac80211]
[   18.320264] [   17.771327]  ? report_bug+0x171/0x1a0
[   18.320806] [   17.771332]  ? handle_bug+0x41/0x70
[   18.321347] [   17.771336]  ? exc_invalid_op+0x17/0x70
[   18.321903] [   17.771339]  ? asm_exc_invalid_op+0x1a/0x20
[   18.322469] [   17.771344]  ? ieee80211_tx_dequeue+0xcb3/0xd30 [mac80211]
[   18.323028] [   17.771417]  iwl_mvm_mac_itxq_xmit+0x77/0x100 [iwlmvm]
[   18.323574] [   17.771451]  ieee80211_queue_skb+0x573/0x6b0 [mac80211]
[   18.324116] [   17.771524]  __ieee80211_xmit_fast+0x7d8/0xad0 [mac80211]
[   18.324629] [   17.771597]  ? __skb_get_hash+0x64/0x200
[   18.325119] [   17.771601]  ? __skb_get_hash+0xa4/0x200
[   18.325650] [   17.771605]  __ieee80211_subif_start_xmit+0x258/0x400 [mac80211]
[   18.326174] [   17.771678]  ieee80211_subif_start_xmit+0x56/0x470 [mac80211]
[   18.326643] [   17.771751]  netpoll_start_xmit+0x125/0x1a0
[   18.327109] [   17.771756]  netpoll_send_skb+0x170/0x280
[   18.327570] [   17.771760]  write_msg+0xe0/0xf0 [netconsole]
[   18.328017] [   17.771768]  console_flush_all+0x175/0x4d0
[   18.328449] [   17.771775]  console_unlock+0x8a/0xf0
[   18.328871] [   17.771779]  vprintk_emit+0x1d2/0x280
[   18.329310] [   17.771785]  devkmsg_emit.constprop.0+0x5f/0x80
[   18.329737] [   17.771790]  devkmsg_write+0xbd/0x1b0
[   18.330134] [   17.771795]  vfs_write+0x23b/0x420
[   18.330520] [   17.771802]  ksys_write+0x6f/0xf0
[   18.330904] [   17.771806]  do_syscall_64+0x5c/0xc0
[   18.331308] [   17.771811]  ? do_user_addr_fault+0x179/0x640
[   18.331724] [   17.771816]  ? exit_to_user_mode_prepare+0x40/0x1e0
[   18.332141] [   17.771822]  entry_SYSCALL_64_after_hwframe+0x6e/0xd8
[   18.332526] [   17.771825] RIP: 0033:0x7efd538ff240
[   18.333294] [   17.771827] Code: 40 00 48 8b 15 c1 9b 0d 00 f7 d8 64 89 02 48 c7 c0 ff ff ff ff eb b7 0f 1f 00 80 3d a1 23 0e 00 00 74 17 b8 01 00 00 00 0f 05 <48> 3d 00 f0 ff ff 77 58 c3 0f 1f 80 00 00 00 00 48 83 ec 28 48 89
[   18.334319] [   17.771829] RSP: 002b:00007ffe39d9e4d8 EFLAGS: 00000202 ORIG_RAX: 0000000000000001
[   18.334840] [   17.771832] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007efd538ff240
[   18.335387] [   17.771834] RDX: 000000000000002d RSI: 000055e8168f1b80 RDI: 0000000000000001
[   18.335918] [   17.771835] RBP: 000055e8168f1b80 R08: 0000000000000000 R09: 003830656c747275
[   18.336452] [   17.771837] R10: 00000000000001b6 R11: 0000000000000202 R12: 000000000000002d
[   18.336987] [   17.771838] R13: 00007efd538046c0 R14: 0000000000000001 R15: 00007ffe39d9e540
[   18.337398] [   17.771843]  </TASK>
[   18.337865] [   17.771843] ---[ end trace 0000000000000000 ]---
[   18.454249] Adding swap device /dev/nvme0n1p3.
..
[   26.147969] crypto (366): drop_caches: 3
[   26.148423] DISCONNECT WiFi device wlp1s0
[   26.259653] crypto - Size of tmpfs is set on 12733545 kb
[   26.364689] crypto - mount TMPFS
[   26.476060] crypto - Mount sandwich /tmp/opt4:/tmp/opt3:/tmp/opt2:/tmp/opt1: with overlay ...
[   26.587243] crypto - Directory on overlayed /root for move tmpfs
[   26.693498] crypto - set hostname
[   26.821666] turtle08 is prepared
[   26.925359] Shutdown network
[   27.050463] OK - sandwich is DONE!
[   27.163968] overlay - System on /root is done for start
[   27.244280] Not activating Mandatory Access Control as /sbin/tomoyo-init does not exist.
[   27.499399] systemd[1]: Inserted module 'autofs4'