Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

fix nic_router_uplinks fails #5192

Open
m-stein opened this issue Apr 24, 2024 · 7 comments
Open

fix nic_router_uplinks fails #5192

m-stein opened this issue Apr 24, 2024 · 7 comments
Assignees
@m-stein
Labels
bug

Comments

@m-stein
Copy link
Member

m-stein commented Apr 24, 2024

The nic_router_uplinks test currently fails on x86_64/x86_64/pc/hw|nova|sel4.
@m-stein m-stein added the bug label Apr 24, 2024
@m-stein m-stein self-assigned this Apr 24, 2024
@m-stein
Copy link
Member Author

m-stein commented Apr 24, 2024

@cnuke I failed to fix it on sel4 because the wifi driver doesn't come up. Do you have a clue what to do about this?

[init -> wifi_drv] NR_IRQS: 4352, nr_irqs: 4352, preallocated irqs: 256
[init -> wifi_drv] time-clocksource: dde_counter: mask: 0xffffffffffffff max_cycles: 0x1d854df40, max_idle_ns: 3526361616960 ns
[init -> wifi_drv] time-clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[init -> wifi_drv] NET: Registered PF_NETLINK/PF_ROUTE protocol family
[init -> wifi_drv] time-clocksource: Switched to clocksource dde_counter
[init -> wifi_drv] Intel(R) Wireless WiFi driver for Linux
[init -> wifi_drv] iwlwifi 02:00.0: pci_enable_msi failed - -38
[init -> wifi_drv] task_work_add: task: 0000000037b9efe4 work: 0000000000b84fe6 notify: 0
[init -> wifi_drv] NET: Registered PF_PACKET protocol family
[init -> wifi_drv] sched_clock: Marking stable (54300000, 752117000)->(854355000, -47938000)
[init -> wifi_drv] wireless-reg: Loading compiled-in X.509 certificates for regulatory database
[init -> wifi_drv] wireless-reg: loaded regulatory.db is malformed or signature is missing/invalid
[init -> wifi_drv] iwlwifi 02:00.0: api flags index 2 larger than supported by driver
[init -> wifi_drv] iwlwifi 02:00.0: TLV_FW_FSEQ_VERSION: FSEQ Version: 0.0.2.36
[init -> wifi_drv] iwlwifi 02:00.0: loaded firmware version 68.01d30b0c.0 ty-a0-gf-a0-68.ucode op_mode iwlmvm
[init -> wifi_drv] iwlwifi 02:00.0: Detected Intel(R) Wi-Fi 6 AX210 160MHz, REV=0x420
Warning: invalid signal-context capability
Warning: flush page table entries - mapping cache full - PD: init -> wifi_drv
[init -> wifi_drv] iwlwifi 02:00.0: loaded PNVM version dda57f4f
[init -> wifi_drv] iwlwifi 02:00.0: Detected RF GF, rfid=0x10d000
[init -> wifi_drv] iwlwifi 02:00.0: base HW address: 3c:e9:f7:de:a5:17
Warning: flush page table entries - mapping cache full - PD: init -> wifi_drv
Warning: void Core::Rpc_cap_factory::free(Genode::Native_capability) not implemented - resources leaked: 0x100
[init -> wifi_drv] iwlwifi 02:00.0: firmware didn't ACK the reset - continue anyway
[init -> wifi_drv] iwlwifi 02:00.0: Start IWL Error Log Dump:
[init -> wifi_drv] iwlwifi 02:00.0: Transport status: 0x0000004A, valid: 6
[init -> wifi_drv] iwlwifi 02:00.0: Loaded firmware version: 68.01d30b0c.0 ty-a0-gf-a0-68.ucode
[init -> wifi_drv] iwlwifi 02:00.0: 0x00000084 | NMI_INTERRUPT_UNKNOWN       
[init -> wifi_drv] iwlwifi 02:00.0: 0x00A082F0 | trm_hw_status0
[init -> wifi_drv] iwlwifi 02:00.0: 0x00000000 | trm_hw_status1
[init -> wifi_drv] iwlwifi 02:00.0: 0x004DAF86 | branchlink2
[init -> wifi_drv] iwlwifi 02:00.0: 0x004D13D6 | interruptlink1
[init -> wifi_drv] iwlwifi 02:00.0: 0x004D13D6 | interruptlink2
[init -> wifi_drv] iwlwifi 02:00.0: 0x0001699A | data1
[init -> wifi_drv] iwlwifi 02:00.0: 0x01000000 | data2
[init -> wifi_drv] iwlwifi 02:00.0: 0x00000000 | data3
[init -> wifi_drv] iwlwifi 02:00.0: 0x00000000 | beacon time
[init -> wifi_drv] iwlwifi 02:00.0: 0x00034382 | tsf low
[init -> wifi_drv] iwlwifi 02:00.0: 0x00000000 | tsf hi
[init -> wifi_drv] iwlwifi 02:00.0: 0x00000000 | time gp1
[init -> wifi_drv] iwlwifi 02:00.0: 0x0004848E | time gp2
[init -> wifi_drv] iwlwifi 02:00.0: 0x00000001 | uCode revision type
[init -> wifi_drv] iwlwifi 02:00.0: 0x00000044 | uCode version major
[init -> wifi_drv] iwlwifi 02:00.0: 0x01D30B0C | uCode version minor
[init -> wifi_drv] iwlwifi 02:00.0: 0x00000420 | hw version
[init -> wifi_drv] iwlwifi 02:00.0: 0x00C89002 | board version
[init -> wifi_drv] iwlwifi 02:00.0: 0x8061FF00 | hcmd
[init -> wifi_drv] iwlwifi 02:00.0: 0x20020000 | isr0
[init -> wifi_drv] iwlwifi 02:00.0: 0x00000000 | isr1
[init -> wifi_drv] iwlwifi 02:00.0: 0x48F00002 | isr2
[init -> wifi_drv] iwlwifi 02:00.0: 0x00C0001C | isr3
[init -> wifi_drv] iwlwifi 02:00.0: 0x00000000 | isr4
[init -> wifi_drv] iwlwifi 02:00.0: 0x00000000 | last cmd Id
[init -> wifi_drv] iwlwifi 02:00.0: 0x0001699A | wait_event
[init -> wifi_drv] iwlwifi 02:00.0: 0x00000000 | l2p_control
[init -> wifi_drv] iwlwifi 02:00.0: 0x00000000 | l2p_duration
[init -> wifi_drv] iwlwifi 02:00.0: 0x00000000 | l2p_mhvalid
[init -> wifi_drv] iwlwifi 02:00.0: 0x00000000 | l2p_addr_match
[init -> wifi_drv] iwlwifi 02:00.0: 0x00000009 | lmpm_pmg_sel
[init -> wifi_drv] iwlwifi 02:00.0: 0x00000000 | timestamp
[init -> wifi_drv] iwlwifi 02:00.0: 0x00000028 | flow_handler
[init -> wifi_drv] iwlwifi 02:00.0: Start IWL Error Log Dump:
[init -> wifi_drv] iwlwifi 02:00.0: Transport status: 0x0000004A, valid: 7
[init -> wifi_drv] iwlwifi 02:00.0: 0x20000074 | ADVANCED_SYSASSERT
[init -> wifi_drv] iwlwifi 02:00.0: 0x00000000 | umac branchlink1
[init -> wifi_drv] iwlwifi 02:00.0: 0x8045E21C | umac branchlink2
[init -> wifi_drv] iwlwifi 02:00.0: 0x804804AE | umac interruptlink1
[init -> wifi_drv] iwlwifi 02:00.0: 0x804804AE | umac interruptlink2
[init -> wifi_drv] iwlwifi 02:00.0: 0x01000000 | umac data1
[init -> wifi_drv] iwlwifi 02:00.0: 0x804804AE | umac data2
[init -> wifi_drv] iwlwifi 02:00.0: 0x00000000 | umac data3
[init -> wifi_drv] iwlwifi 02:00.0: 0x00000044 | umac major
[init -> wifi_drv] iwlwifi 02:00.0: 0x01D30B0C | umac minor
[init -> wifi_drv] iwlwifi 02:00.0: 0x000485FF | frame pointer
[init -> wifi_drv] iwlwifi 02:00.0: 0xC088625C | stack pointer
[init -> wifi_drv] iwlwifi 02:00.0: 0x00040F07 | last host cmd
[init -> wifi_drv] iwlwifi 02:00.0: 0x00000400 | isr status reg
[init -> wifi_drv] iwlwifi 02:00.0: IML/ROM dump:
[init -> wifi_drv] iwlwifi 02:00.0: 0x00000B03 | IML/ROM error/state
[init -> wifi_drv] iwlwifi 02:00.0: 0x00008018 | IML/ROM data1
[init -> wifi_drv] iwlwifi 02:00.0: 0x00000080 | IML/ROM WFPM_AUTH_KEY_0
[init -> wifi_drv] iwlwifi 02:00.0: Fseq Registers:
[init -> wifi_drv] iwlwifi 02:00.0: 0x60000000 | FSEQ_ERROR_CODE
[init -> wifi_drv] iwlwifi 02:00.0: 0x80440005 | FSEQ_TOP_INIT_VERSION
[init -> wifi_drv] iwlwifi 02:00.0: 0x00080009 | FSEQ_CNVIO_INIT_VERSION
[init -> wifi_drv] iwlwifi 02:00.0: 0x0000A652 | FSEQ_OTP_VERSION
[init -> wifi_drv] iwlwifi 02:00.0: 0x00000002 | FSEQ_TOP_CONTENT_VERSION
[init -> wifi_drv] iwlwifi 02:00.0: 0x4552414E | FSEQ_ALIVE_TOKEN
[init -> wifi_drv] iwlwifi 02:00.0: 0x00400410 | FSEQ_CNVI_ID
[init -> wifi_drv] iwlwifi 02:00.0: 0x00400410 | FSEQ_CNVR_ID
[init -> wifi_drv] iwlwifi 02:00.0: 0x00400410 | CNVI_AUX_MISC_CHIP
[init -> wifi_drv] iwlwifi 02:00.0: 0x00400410 | CNVR_AUX_MISC_CHIP
[init -> wifi_drv] iwlwifi 02:00.0: 0x00009061 | CNVR_SCU_SD_REGS_SD_REG_DIG_DCDC_VTRIM
[init -> wifi_drv] iwlwifi 02:00.0: 0x00000061 | CNVR_SCU_SD_REGS_SD_REG_ACTIVE_VDIG_MIRROR
[init -> wifi_drv] iwlwifi 02:00.0: WRT: Collecting data: ini trigger 4 fired (delay=0ms).
[init -> wifi_drv] iwlwifi 02:00.0: WRT: Failed to dump region: id=19, type=16
[init -> wifi_drv] Warning: Libc RNG not configured
[init -> wifi_drv] wlan0: authenticate with 4c:1b:86:5b:de:18
[init -> wifi_drv] wlan0: 80 MHz not supported, disabling VHT
[init -> wifi_drv] wlan0: send auth to 4c:1b:86:5b:de:18 (try 1/3)
[init -> wifi_drv] iwlwifi 02:00.0: Session protection failure
[init -> wifi_drv] iwlwifi 02:00.0: Not associated and the session protection is over already...
[init -> wifi_drv] wlan0: Connection to AP 4c:1b:86:5b:de:18 lost
[init -> wifi_drv] wlan0: send auth to 4c:1b:86:5b:de:18 (try 2/3)
[init -> wifi_drv] wlan0: send auth to 4c:1b:86:5b:de:18 (try 3/3)
[init -> wifi_drv] wlan0: authentication with 4c:1b:86:5b:de:18 timed out
[init -> wifi_drv] wlan0: authenticate with 4c:1b:86:5b:de:18
[init -> wifi_drv] wlan0: 80 MHz not supported, disabling VHT
[init -> wifi_drv] wlan0: send auth to 4c:1b:86:5b:de:18 (try 1/3)
[init -> wifi_drv] iwlwifi 02:00.0: Session protection failure
[init -> wifi_drv] iwlwifi 02:00.0: Not associated and the session protection is over already...
[init -> wifi_drv] wlan0: Connection to AP 4c:1b:86:5b:de:18 lost
[init -> wifi_drv] wlan0: send auth to 4c:1b:86:5b:de:18 (try 2/3)
[init -> wifi_drv] iwlwifi 02:00.0: Session protection failure
[init -> wifi_drv] iwlwifi 02:00.0: Not associated and the session protection is over already...
[init -> wifi_drv] wlan0: Connection to AP 4c:1b:86:5b:de:18 lost
[init -> wifi_drv] wlan0: send auth to 4c:1b:86:5b:de:18 (try 3/3)
[init -> wifi_drv] iwlwifi 02:00.0: Session protection failure
[init -> wifi_drv] iwlwifi 02:00.0: Not associated and the session protection is over already...
[init -> wifi_drv] wlan0: Connection to AP 4c:1b:86:5b:de:18 lost
[init -> wifi_drv] wlan0: authentication with 4c:1b:86:5b:de:18 timed out
[init -> wifi_drv] wlan0: authenticate with 4c:1b:86:5b:de:18
[init -> wifi_drv] wlan0: 80 MHz not supported, disabling VHT
[init -> wifi_drv] wlan0: send auth to 4c:1b:86:5b:de:18 (try 1/3)
[init -> wifi_drv] iwlwifi 02:00.0: Session protection failure
[init -> wifi_drv] iwlwifi 02:00.0: Not associated and the session protection is over already...
[init -> wifi_drv] wlan0: Connection to AP 4c:1b:86:5b:de:18 lost
[init -> wifi_drv] wlan0: send auth to 4c:1b:86:5b:de:18 (try 2/3)
[init -> wifi_drv] iwlwifi 02:00.0: Session protection failure
[init -> wifi_drv] iwlwifi 02:00.0: Not associated and the session protection is over already...
[init -> wifi_drv] wlan0: Connection to AP 4c:1b:86:5b:de:18 lost
Warning: flush page table entries - mapping cache full - PD: init -> wifi_drv
[init -> wifi_drv] wlan0: send auth to 4c:1b:86:5b:de:18 (try 3/3)
[init -> wifi_drv] iwlwifi 02:00.0: Session protection failure
[init -> wifi_drv] iwlwifi 02:00.0: Not associated and the session protection is over already...
[init -> wifi_drv] wlan0: Connection to AP 4c:1b:86:5b:de:18 lost
[init -> wifi_drv] wlan0: authentication with 4c:1b:86:5b:de:18 timed out
[init -> wifi_drv] wlan0: authenticate with 4c:1b:86:5b:de:18
[init -> wifi_drv] wlan0: 80 MHz not supported, disabling VHT
[init -> wifi_drv] wlan0: send auth to 4c:1b:86:5b:de:18 (try 1/3)
[init -> wifi_drv] iwlwifi 02:00.0: Session protection failure
[init -> wifi_drv] iwlwifi 02:00.0: Not associated and the session protection is over already...
[init -> wifi_drv] wlan0: Connection to AP 4c:1b:86:5b:de:18 lost
[init -> wifi_drv] wlan0: send auth to 4c:1b:86:5b:de:18 (try 2/3)
[init -> wifi_drv] iwlwifi 02:00.0: Session protection failure
[init -> wifi_drv] iwlwifi 02:00.0: Not associated and the session protection is over already...
[init -> wifi_drv] wlan0: Connection to AP 4c:1b:86:5b:de:18 lost
[init -> wifi_drv] wlan0: send auth to 4c:1b:86:5b:de:18 (try 3/3)
[init -> wifi_drv] iwlwifi 02:00.0: Session protection failure
[init -> wifi_drv] iwlwifi 02:00.0: Not associated and the session protection is over already...
[init -> wifi_drv] wlan0: Connection to AP 4c:1b:86:5b:de:18 lost
[init -> wifi_drv] wlan0: authentication with 4c:1b:86:5b:de:18 timed out

m-stein added a commit to m-stein/genode that referenced this issue Apr 24, 2024
@m-stein
nic_router_uplinks.run: raise timeouts
d5c738f 
At least on x86_64/x86_64/pc/hw|nova, the test used to fail because the net
setup sometimes required more than the 3 seconds that the test was giving each
step. This commit raises the step timeout to 5 seconds and the test timeout
from 70 to 90 seconds in order to be on the safe side.

Ref genodelabs#5192
m-stein added a commit to m-stein/genode that referenced this issue Apr 24, 2024
@m-stein
nic_router_uplinks.run: raise timeouts
467b5c9 
At least on x86_64/x86_64/pc/hw|nova, the test used to fail because the net
setup sometimes required more than the 3 seconds that the test was giving each
step. This commit raises the step timeout to 5 seconds and the test timeout
from 70 to 90 seconds in order to be on the safe side.

Ref genodelabs#5192
@m-stein
Copy link
Member Author

m-stein commented Apr 24, 2024

@chelmuth This 467b5c9 should fix hw and nova.

@chelmuth
Copy link
Member

Merged to staging.

chelmuth pushed a commit that referenced this issue Apr 24, 2024
@m-stein @chelmuth
nic_router_uplinks.run: raise timeouts
13ff144 
At least on x86_64/x86_64/pc/hw|nova, the test used to fail because the net
setup sometimes required more than the 3 seconds that the test was giving each
step. This commit raises the step timeout to 5 seconds and the test timeout
from 70 to 90 seconds in order to be on the safe side.

Ref #5192
@cnuke
Copy link
Member

cnuke commented Apr 25, 2024

@m-stein I am afraid I have no insight I could provide but judging by the history of CI results the wifi_drv has not been tested or has had issue on seL4 for quite some time now. The messages that look suspicious though are

[…]
Warning: invalid signal-context capability
Warning: flush page table entries - mapping cache full - PD: init -> wifi_drv
[init -> wifi_drv] iwlwifi 02:00.0: loaded PNVM version dda57f4f
[init -> wifi_drv] iwlwifi 02:00.0: Detected RF GF, rfid=0x10d000
[init -> wifi_drv] iwlwifi 02:00.0: base HW address: 3c:e9:f7:de:a5:17
Warning: flush page table entries - mapping cache full - PD: init -> wifi_drv
Warning: void Core::Rpc_cap_factory::free(Genode::Native_capability) not implemented - resources leaked: 0x100
[…]

as I would expect the working-set of memory of the driver to be small enought to not blow the static page table limit.

@m-stein
Copy link
Member Author

m-stein commented Apr 25, 2024

@chelmuth @cnuke Considering cnuke's answer, may I disable sel4 for the test?

@alex-ab
Copy link
Member

alex-ab commented Apr 25, 2024

@m-stein: may you try to give the wifi drv more memory as test case for seL4, it may effect the size of the page cache (so avoiding the flush) ?

@m-stein
Copy link
Member Author

m-stein commented Apr 25, 2024

@alex-ab Thanks for the hint! Will try that.

chelmuth pushed a commit that referenced this issue Apr 25, 2024
@m-stein @chelmuth
nic_router_uplinks.run: raise timeouts
48a5c12 
At least on x86_64/x86_64/pc/hw|nova, the test used to fail because the net
setup sometimes required more than the 3 seconds that the test was giving each
step. This commit raises the step timeout to 5 seconds and the test timeout
from 70 to 90 seconds in order to be on the safe side.

Ref #5192
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees

@m-stein m-stein

Labels
bug
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
4 participants
@chelmuth @cnuke @m-stein @alex-ab