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.

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

Incorrect ping parameter on wirless open ac connection test #1533

Closed
omar-selo opened this issue Oct 7, 2024 · 2 comments
Closed

Incorrect ping parameter on wirless open ac connection test #1533

omar-selo opened this issue Oct 7, 2024 · 2 comments
Labels
bug Something isn't working

Comments

@omar-selo
Copy link
Contributor

Bug Description

During SRU snap testing, one of the devices kept failing wireless/wireless_connection_open_ac_np_wlp1s0 test with the logs provided below. Zooming in on the ping test we see the following logs:

## Perform a ping test
Got gateway address: 192.168.144.1 (TP-LINK TECHNOLOGIES CO.,LTD.)
Ping result: {'transmitted': 0, 'received': 0, 'pct_loss': 0, 'cause': "Failed with exception: Command '['ping', '192.168.144.1 (TP-LINK TECHNOLOGIES CO.,LTD.)', '-c', '5', '-w', '10', '-Iwlp1s0']' returned non-zero exit status 2.\nstdout: \nstderr: ping: 192.168.144.1 (TP-LINK TECHNOLOGIES CO.,LTD.): Name or service not known\n"}
Connection test failed

This suggests that the test is trying to ping the string '192.168.144.1 (TP-LINK TECHNOLOGIES CO.,LTD.)' instead of just 192.168.144.1.

To Reproduce

Run http://10.102.156.15:8080/job/cert-dawson-i-uc20-snapd-beta/ job and observer the result of wireless/wireless_connection_open_ac_np_wlp1s0 test

Environment

  • OS UC20
  • checkbox Version: 4.2.0-dev99-9568
  • checkbox20 Version: 4.2.0-dev99-2054

Relevant log output

Interface eno1 using module e1000e
  Parameters:
    copybreak: 256

Checking kernel ring buffer for e1000e messages:
kern  :info  : [Wed Oct  2 08:37:55 2024] e1000e: EEE TX LPI TIMER: 00000011
kern  :info  : [Wed Oct  2 08:38:01 2024] e1000e: eno1 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: None


Interface wlp1s0 using module iwlwifi
  Parameters:
    lar_disable: N
    fw_monitor: N
    11n_disable: 0
    power_save: N
    swcrypto: 0
    antenna_coupling: 0
    power_level: 0
    amsdu_size: 0
    uapsd_disable: 3
    fw_restart: Y
    led_mode: 0
    disable_11ax: N
    enable_ini: N
    disable_11ac: N
    bt_coex_active: Y
    remove_when_gone: N
    nvm_file: (null)

Checking kernel ring buffer for iwlwifi messages:
kern  :info  : [Wed Oct  2 08:34:33 2024] iwlwifi 0000:01:00.0: Applying debug destination EXTERNAL_DRAM
kern  :info  : [Wed Oct  2 08:34:33 2024] iwlwifi 0000:01:00.0: Applying debug destination EXTERNAL_DRAM
kern  :warn  : [Wed Oct  2 08:34:33 2024] iwlwifi 0000:01:00.0: FW already configured (0) - re-configuring
kern  :err   : [Wed Oct  2 08:34:33 2024] iwlwifi 0000:01:00.0: BIOS contains WGDS but no WRDS
kern  :info  : [Wed Oct  2 08:37:56 2024] iwlwifi 0000:01:00.0: Applying debug destination EXTERNAL_DRAM
kern  :info  : [Wed Oct  2 08:37:56 2024] iwlwifi 0000:01:00.0: Applying debug destination EXTERNAL_DRAM
kern  :warn  : [Wed Oct  2 08:37:56 2024] iwlwifi 0000:01:00.0: FW already configured (0) - re-configuring
kern  :err   : [Wed Oct  2 08:37:56 2024] iwlwifi 0000:01:00.0: BIOS contains WGDS but no WRDS


## Backup any existing netplan configuration files
Clear backup location
Backing up from /etc/netplan
  /etc/netplan/50-cloud-init.yaml

## Delete any existing netplan configuration files
  /etc/netplan/50-cloud-init.yaml

## Generate a test netplan configuration
# This is the network config written by checkbox
network:
  renderer: networkd
  version: 2
  wifis:
    wlp1s0:
      access-points:
        cert-ac-open-tel-l3-01: {}
      dhcp4: true
      nameservers: {}


## Write the test netplan config file to disk

## Apply the test configuration
+ netplan --debug apply

## Wait for interface to be routable
Reached routable state

## Display address
+ ip address show dev wlp1s0
3: wlp1s0: <BROADCAST,MULTICAST,UP,LOWER_UP> mtu 1500 qdisc noqueue state UP group default qlen 1000
    link/ether ac:ed:5c:db:45:39 brd ff:ff:ff:ff:ff:ff
    inet 192.168.147.126/20 brd 192.168.159.255 scope global dynamic wlp1s0
       valid_lft 582sec preferred_lft 582sec
    inet6 fe80::aeed:5cff:fedb:4539/64 scope link 
       valid_lft forever preferred_lft forever

## Display route table
+ ip route
default via 10.102.152.1 dev eno1 proto dhcp src 10.102.154.13 metric 100 
default via 192.168.144.1 dev wlp1s0 proto dhcp src 192.168.147.126 metric 600 
10.102.152.0/22 dev eno1 proto kernel scope link src 10.102.154.13 
10.102.152.1 dev eno1 proto dhcp scope link src 10.102.154.13 metric 100 
192.168.144.0/20 dev wlp1s0 proto kernel scope link src 192.168.147.126 
192.168.144.1 dev wlp1s0 proto dhcp scope link src 192.168.147.126 metric 600 

## Perform a ping test
Got gateway address: 192.168.144.1 (TP-LINK TECHNOLOGIES CO.,LTD.)
Ping result: {'transmitted': 0, 'received': 0, 'pct_loss': 0, 'cause': "Failed with exception: Command '['ping', '192.168.144.1 (TP-LINK TECHNOLOGIES CO.,LTD.)', '-c', '5', '-w', '10', '-Iwlp1s0']' returned non-zero exit status 2.\nstdout: \nstderr: ping: 192.168.144.1 (TP-LINK TECHNOLOGIES CO.,LTD.): Name or service not known\n"}
Connection test failed

## Delete the test file

## Restore configuration files
Restoring:
  /etc/netplan/50-cloud-init.yaml
+ netplan --debug apply

## Journal Entries
+ journalctl -q --no-pager -u systemd-networkd.service -u wpa_supplicant.service -u netplan-* --since "2024-10-02 08:50:44" 
Oct 02 08:50:44 dawson-002 systemd-networkd[745]: wlp1s0: Re-configuring with /run/systemd/network/10-netplan-wlp1s0.network
Oct 02 08:50:44 dawson-002 systemd-networkd[745]: wlp1s0: IPv6 successfully enabled
Oct 02 08:50:49 dawson-002 systemd-networkd[745]: wlp1s0: Re-configuring with /run/systemd/network/10-netplan-wlp1s0.network
Oct 02 08:50:49 dawson-002 systemd[1]: Condition check resulted in OpenVSwitch configuration for cleanup being skipped.
Oct 02 08:50:49 dawson-002 systemd[1]: Started WPA supplicant for netplan wlp1s0.
Oct 02 08:50:49 dawson-002 systemd-networkd[745]: wlp1s0: IPv6 successfully enabled
Oct 02 08:50:49 dawson-002 wpa_supplicant[12075]: Successfully initialized wpa_supplicant
Oct 02 08:50:52 dawson-002 wpa_supplicant[12075]: wlp1s0: SME: Trying to authenticate with ae:84:c6:62:8d:12 (SSID='cert-ac-open-tel-l3-01' freq=5825 MHz)
Oct 02 08:50:52 dawson-002 wpa_supplicant[12075]: wlp1s0: Trying to associate with ae:84:c6:62:8d:12 (SSID='cert-ac-open-tel-l3-01' freq=5825 MHz)
Oct 02 08:50:52 dawson-002 wpa_supplicant[12075]: wlp1s0: Associated with ae:84:c6:62:8d:12
Oct 02 08:50:52 dawson-002 wpa_supplicant[12075]: wlp1s0: CTRL-EVENT-CONNECTED - Connection to ae:84:c6:62:8d:12 completed [id=0 id_str=]
Oct 02 08:50:52 dawson-002 wpa_supplicant[12075]: wlp1s0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Oct 02 08:50:52 dawson-002 systemd-networkd[745]: wlp1s0: Gained carrier
Oct 02 08:50:52 dawson-002 systemd-networkd[745]: wlp1s0: Connected WiFi access point: cert-ac-open-tel-l3-01 (ae:84:c6:62:8d:12)
Oct 02 08:50:52 dawson-002 systemd-networkd[745]: wlp1s0: DHCPv4 address 192.168.147.126/20 via 192.168.144.1
Oct 02 08:51:11 dawson-002 systemd[1]: netplan-wpa-wlp1s0.service: Current command vanished from the unit file, execution of the command list won't be resumed.
Oct 02 08:51:11 dawson-002 systemd[1]: Stopping netplan-wpa-wlp1s0.service...
Oct 02 08:51:11 dawson-002 wpa_supplicant[12075]: nl80211: deinit ifname=p2p-dev-wlp1s0 disabled_11b_rates=0
Oct 02 08:51:11 dawson-002 wpa_supplicant[12075]: p2p-dev-wlp1s0: CTRL-EVENT-TERMINATING
Oct 02 08:51:11 dawson-002 wpa_supplicant[12075]: wlp1s0: CTRL-EVENT-DISCONNECTED bssid=ae:84:c6:62:8d:12 reason=3 locally_generated=1
Oct 02 08:51:11 dawson-002 systemd-networkd[745]: wlp1s0: Lost carrier
Oct 02 08:51:11 dawson-002 systemd-networkd[745]: wlp1s0: DHCP lease lost
Oct 02 08:51:11 dawson-002 wpa_supplicant[12075]: nl80211: deinit ifname=wlp1s0 disabled_11b_rates=0
Oct 02 08:51:11 dawson-002 wpa_supplicant[12075]: wlp1s0: CTRL-EVENT-TERMINATING
Oct 02 08:51:11 dawson-002 systemd[1]: netplan-wpa-wlp1s0.service: Succeeded.
Oct 02 08:51:11 dawson-002 systemd[1]: Stopped netplan-wpa-wlp1s0.service.
Oct 02 08:51:11 dawson-002 systemd-networkd[745]: /run/systemd/network/10-netplan-eno1.network: MTUBytes= in [Link] section and UseMTU= in [DHCP] section are set. Disabling UseMTU=.
Oct 02 08:51:11 dawson-002 systemd-networkd[745]: eno1: Re-configuring with /run/systemd/network/10-netplan-eno1.network
Oct 02 08:51:11 dawson-002 systemd-networkd[745]: eno1: DHCP lease lost
Oct 02 08:51:11 dawson-002 systemd-networkd[745]: eno1: IPv6 successfully enabled
Oct 02 08:51:11 dawson-002 systemd-networkd[745]: eno1: DHCPv4 address 10.102.154.13/22 via 10.102.152.1
Oct 02 08:51:12 dawson-002 systemd-networkd[745]: eno1: Re-configuring with /run/systemd/network/10-netplan-eno1.network
Oct 02 08:51:12 dawson-002 systemd-networkd[745]: eno1: DHCP lease lost
Oct 02 08:51:12 dawson-002 systemd[1]: Condition check resulted in OpenVSwitch configuration for cleanup being skipped.
Oct 02 08:51:12 dawson-002 systemd-networkd[745]: eno1: IPv6 successfully enabled

Additional context

No response

@omar-selo omar-selo added the bug Something isn't working label Oct 7, 2024
Copy link

Thank you for reporting us your feedback!

The internal ticket has been created: https://warthogs.atlassian.net/browse/CHECKBOX-1606.

This message was autogenerated

@seankingyang
Copy link
Contributor

Hi @omar-selo, #1536 fix this issue, and trigger http://10.102.156.15:8080/job/cert-dawson-i-uc20-snapd-beta/83/ to validate it.

checkbox    4.2.0-dev114    
checkbox20  4.2.0-dev114     

Make this issue to closed.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
bug Something isn't working
Projects
None yet
Development

No branches or pull requests

2 participants