Check Accessibility Control
This scenario shows how to configure a cellular interface, enabling the accessibility control mechanism that triggers reconnections when network connectivity is lost.
Test Reconnection By Accessibility Control
Description
In DUT0, the cell0 cellular interface is
configured with a cellular profile for which
accessibility control is enabled. Once connectivity
with Google’s DNS public server has been verified, a
situation where 100% of the packets received by the
network are lost is emulated to verify that the
accessibility control mechanism triggers a reconnection.
Scenario
Step 1: Set the following configuration in DUT0 :
set cellular logging level info set cellular profile CELPROFILE accessibility-control ping address 8.8.8.8 set cellular profile CELPROFILE accessibility-control ping interval 10 set cellular profile CELPROFILE apn movistar.es set controllers cellular wwan0 encrypted-pin U2FsdGVkX18CwoDCBdKiGnpwVS9WKzyS2fcINKkg1WQ= set controllers cellular wwan0 pdp 1 profile CELPROFILE set interfaces cellular cell0 address dhcp set interfaces cellular cell0 phy wwan0 pdp 1 set system login user admin authentication encrypted-password '$6$GSjsCj8gHLv$/VcqU6FLi6CT2Oxn0MJQ2C2tqnRDrYKNF8HIYWJp68nvXvPdFccDsT04.WtigUONbKYrgKg8d6rEs8PjljMkH0'
Step 2: Run command controllers cellular wwan0 pdp 1 show network-data-connection at DUT0 and check if output matches the following regular expressions:
Connection status\s* = connectedShow output
Connection status = connected Traffic channel status = active Max. TX channel rate (bps) = 50000000 Max. RX channel rate (bps) = 300000000 IPv4 address = 88.31.33.108 IPv4 mask = 255.255.255.248 IPv4 gateway = 88.31.33.109 IPv4 primary DNS = 80.58.61.248 IPv4 secondary DNS = 80.58.61.249
Note
Once the cellular interface is configured, it can be verified that there is network connectivity by pinging Google's DNS public server.
Step 3: Ping IP address 8.8.8.8 from DUT0:
admin@DUT0$ ping 8.8.8.8 count 1 size 56 timeout 1Show output
PING 8.8.8.8 (8.8.8.8) 56(84) bytes of data. 64 bytes from 8.8.8.8: icmp_seq=1 ttl=117 time=31.4 ms --- 8.8.8.8 ping statistics --- 1 packets transmitted, 1 received, 0% packet loss, time 0ms rtt min/avg/max/mdev = 31.422/31.422/31.422/0.000 ms
Note
The accessibility control is a mechanism where pings are sent at an interval, and to the IP address, configured by the user. The mechanism then waits for a response within this interval. If no response is received before it times out, a second ping is sent and a response is expected within 10 seconds. If there is still no response, two more pings are sent at 5-second intervals. Finally, if there is still no response, the device reconnects to the network.
Note
As a result, you can verify that no reconnection has been recorded in the system logs if you wait long enough.
Step 4: Run command system journal clear at DUT0.
Step 5: Run command system journal show | cat at DUT0 and check if output does not contain the following tokens:
[Device/wwan0] Warning: [PDP#1] Requesting reconnection... [Device/wwan0] Info: WDS[0]: Stopping network connection... [Device/wwan0] Info: [PDP#1] Establishing network connection...Show output
Mar 23 17:41:10.160127 osdx systemd-journald[2101]: Runtime Journal (/run/log/journal/061ca38fd5074456992186287bc84b58) is 8.2M, max 80.5M, 72.2M free. Mar 23 17:41:10.167031 osdx systemd-journald[2101]: Received client request to rotate journal, rotating. Mar 23 17:41:10.167214 osdx systemd-journald[2101]: Vacuuming done, freed 0B of archived journals from /run/log/journal/061ca38fd5074456992186287bc84b58. Mar 23 17:41:10.264595 osdx OSDxCLI[160433]: User 'admin' executed a new command: 'system journal clear'. Mar 23 17:41:19.404749 osdx wwan-accessibility-control[171157]: [Core/wwan0/1] Warning: Previous packet pending - ID: 40085, Sequence: 0 Mar 23 17:41:19.404773 osdx wwan-accessibility-control[171157]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 1 - interval reduced to 10 seconds
Note
However, when traffic control is applied, it is possible to prove the 'ping' command is failing because ICMP packets are being dropped.
Step 6: Run command system journal clear at DUT0.
Step 7: Modify the following configuration lines in DUT0 :
set interfaces cellular cell0 traffic control in PLOSS set traffic control PLOSS type network-emulator packet-loss 100
Step 8: Expect a failure in the following command:
Ping IP address 8.8.8.8 from DUT0:
admin@DUT0$ ping 8.8.8.8 count 1 size 56 timeout 1Show output
PING 8.8.8.8 (8.8.8.8) 56(84) bytes of data. --- 8.8.8.8 ping statistics --- 1 packets transmitted, 0 received, 100% packet loss, time 0ms
Note
You can verify that a reconnection has been recorded in the system logs if you wait long enough.
Step 9: Run command system journal show | cat at DUT0 and check if output contains the following tokens:
[Device/wwan0] Warning: [PDP#1] Requesting reconnection... [Device/wwan0] Info: WDS[0]: Stopping network connection... [Device/wwan0] Info: [PDP#1] Establishing network connection...Show output
Mar 23 17:41:52.562502 osdx systemd-journald[2101]: Runtime Journal (/run/log/journal/061ca38fd5074456992186287bc84b58) is 8.0M, max 80.5M, 72.5M free. Mar 23 17:41:52.569599 osdx systemd-journald[2101]: Received client request to rotate journal, rotating. Mar 23 17:41:52.569788 osdx systemd-journald[2101]: Vacuuming done, freed 0B of archived journals from /run/log/journal/061ca38fd5074456992186287bc84b58. Mar 23 17:41:52.652701 osdx OSDxCLI[160433]: User 'admin' executed a new command: 'system journal clear'. Mar 23 17:41:52.792239 osdx OSDxCLI[160433]: User 'admin' entered the configuration menu. Mar 23 17:41:52.890270 osdx OSDxCLI[160433]: User 'admin' added a new cfg line: 'set interfaces cellular cell0 traffic control in PLOSS'. Mar 23 17:41:52.992945 osdx OSDxCLI[160433]: User 'admin' added a new cfg line: 'set traffic control PLOSS type network-emulator packet-loss 100'. Mar 23 17:41:53.103771 osdx OSDxCLI[160433]: User 'admin' added a new cfg line: 'show changes'. Mar 23 17:41:53.245446 osdx ubnt-cfgd[171240]: inactive Mar 23 17:41:53.371194 osdx INFO[171250]: FRR daemons did not change Mar 23 17:41:53.471451 osdx (udev-worker)[171270]: ifb.cell0: Could not set Alias=, MACAddress=/MACAddressPolicy=, TransmitQueues=, ReceiveQueues=, TransmitQueueLength=, MTUBytes=, GenericSegmentOffloadMaxBytes= or GenericSegmentOffloadMaxSegments=, ignoring: Operation not supported Mar 23 17:41:53.471553 osdx (udev-worker)[171270]: Network interface NamePolicy= disabled on kernel command line. Mar 23 17:41:53.490793 osdx cfgd[1758]: [160433]Completed change to active configuration Mar 23 17:41:53.524309 osdx systemd[1]: osdx-ledsd.service: Sent signal SIGUSR2 to main process 2425 (osdx-ledsd) on client request. Mar 23 17:41:53.524342 osdx osdx-ledsd[2425]: Config changed, checking config paths Mar 23 17:41:53.528303 osdx OSDxCLI[160433]: User 'admin' committed the configuration. Mar 23 17:41:53.559246 osdx OSDxCLI[160433]: User 'admin' left the configuration menu. Mar 23 17:41:54.769464 osdx OSDxCLI[160433]: User 'admin' executed a new command: 'ping 8.8.8.8 count 1 size 56 timeout 1'. Mar 23 17:42:09.405797 osdx wwan-accessibility-control[171157]: [Core/wwan0/1] Warning: Previous packet pending - ID: 40085, Sequence: 5 Mar 23 17:42:09.405815 osdx wwan-accessibility-control[171157]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 1 - interval reduced to 10 seconds Mar 23 17:42:15.118657 osdx OSDxCLI[160433]: User 'admin' executed a new command: 'system journal show | cat'. Mar 23 17:42:16.454597 osdx OSDxCLI[160433]: User 'admin' executed a new command: 'system journal show | cat'. Mar 23 17:42:17.810623 osdx OSDxCLI[160433]: User 'admin' executed a new command: 'system journal show | cat'. Mar 23 17:42:19.170619 osdx OSDxCLI[160433]: User 'admin' executed a new command: 'system journal show | cat'. Mar 23 17:42:19.406044 osdx wwan-accessibility-control[171157]: [Core/wwan0/1] Warning: Previous packet pending - ID: 40085, Sequence: 6 Mar 23 17:42:19.406062 osdx wwan-accessibility-control[171157]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 2 - interval reduced to 5 seconds Mar 23 17:42:20.566611 osdx OSDxCLI[160433]: User 'admin' executed a new command: 'system journal show | cat'. Mar 23 17:42:21.978615 osdx OSDxCLI[160433]: User 'admin' executed a new command: 'system journal show | cat'. Mar 23 17:42:23.390610 osdx OSDxCLI[160433]: User 'admin' executed a new command: 'system journal show | cat'. Mar 23 17:42:24.406295 osdx wwan-accessibility-control[171157]: [Core/wwan0/1] Warning: Previous packet pending - ID: 40085, Sequence: 7 Mar 23 17:42:24.406312 osdx wwan-accessibility-control[171157]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 3 - interval reduced to 5 seconds Mar 23 17:42:24.850626 osdx OSDxCLI[160433]: User 'admin' executed a new command: 'system journal show | cat'. Mar 23 17:42:26.314616 osdx OSDxCLI[160433]: User 'admin' executed a new command: 'system journal show | cat'. Mar 23 17:42:27.798612 osdx OSDxCLI[160433]: User 'admin' executed a new command: 'system journal show | cat'. Mar 23 17:42:29.274553 osdx OSDxCLI[160433]: User 'admin' executed a new command: 'system journal show | cat'. Mar 23 17:42:29.406540 osdx wwan-accessibility-control[171157]: [Core/wwan0/1] Warning: Previous packet pending - ID: 40085, Sequence: 8 Mar 23 17:42:29.406557 osdx wwan-accessibility-control[171157]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 4 - interval reduced to 5 seconds Mar 23 17:42:29.418964 osdx WARNING[171380]: [wwan0/1] Requesting reconnection... Mar 23 17:42:29.428177 osdx wwan-cli-socket[171382]: [Device/wwan0] Info: wwan-cli-socket reconnect 60000 wwan0 Mar 23 17:42:29.428733 osdx wwan-module[160416]: [Device/wwan0] Info: Reconnecting device... Mar 23 17:42:29.428755 osdx wwan-module[160416]: [Device/wwan0] Warning: [PDP#1] Requesting reconnection... Mar 23 17:42:29.428827 osdx wwan-module[160416]: [Device/wwan0] Info: WDS[0]: Stopping network connection... Mar 23 17:42:29.546232 osdx wwan-module[160416]: [Device/wwan0] Info: WDS[0]: Network connection was stopped! Mar 23 17:42:29.554176 osdx kernel: net _wwan0: link_state 0x1 -> 0x0 Mar 23 17:42:29.555939 osdx wwan-module[160416]: [Device/wwan0] Info: Checking registration state... Mar 23 17:42:29.585929 osdx wwan-accessibility-control[171157]: [Core/wwan0/1] Info: Execution stopped Mar 23 17:42:29.586327 osdx systemd[1]: Stopping wwan-accessibility-control@wwan0pdp1.service - WWAN Accessibility Control... Mar 23 17:42:29.589534 osdx systemd[1]: wwan-accessibility-control@wwan0pdp1.service: Deactivated successfully. Mar 23 17:42:29.590064 osdx systemd[1]: Stopped wwan-accessibility-control@wwan0pdp1.service - WWAN Accessibility Control. Mar 23 17:42:29.606131 osdx INFO[171387]: Stop DHCP client for cell0 Mar 23 17:42:29.615833 osdx dhclient[171393]: Killed old client process Mar 23 17:42:29.674212 osdx wwan-module[160416]: [Device/wwan0] Info: Device registered and PS attached successfully Mar 23 17:42:29.674235 osdx wwan-module[160416]: [Device/wwan0] Info: [PDP#1] Establishing network connection... Mar 23 17:42:29.745572 osdx dhclient[171393]: DHCPRELEASE of 88.31.33.108 on cell0 to 88.31.33.109 port 67 Mar 23 17:42:29.933503 osdx wwan-module[160416]: [Device/wwan0] Info: [PDP#1] Network connection was successfully started: PDH=[1861284528] Mar 23 17:42:30.061316 osdx kernel: net _wwan0: link_state 0x0 -> 0x1 Mar 23 17:42:30.281397 osdx kernel: cell0: (slave _wwan0_1): Releasing backup interface Mar 23 17:42:30.361621 osdx kernel: cell0: (slave _wwan0_1): The slave device specified does not support setting the MAC address Mar 23 17:42:30.361842 osdx kernel: cell0: (slave _wwan0_1): making interface the new active one Mar 23 17:42:30.365370 osdx kernel: cell0: (slave _wwan0_1): Enslaving as an active interface with an up link Mar 23 17:42:30.381631 osdx kernel: 8021q: adding VLAN 0 to HW filter on device cell0 Mar 23 17:42:30.385037 osdx INFO[171442]: Start DHCP client for cell0
Step 1: Set the following configuration in DUT0 :
set cellular logging level info set cellular profile CELPROFILE accessibility-control ping address 8.8.8.8 set cellular profile CELPROFILE accessibility-control ping interval 10 set cellular profile CELPROFILE apn movistar.es set controllers cellular wwan0 sim select socket_1 set controllers cellular wwan0 sim socket socket_1 encrypted-pin U2FsdGVkX18O5q4iWh8yDUrUUMr9uhG56H8W+DUUOdI= set controllers cellular wwan0 sim socket socket_1 pdp 1 profile CELPROFILE set interfaces cellular cell0 address dhcp set interfaces cellular cell0 phy wwan0 pdp 1 set system login user admin authentication encrypted-password '$6$GSjsCj8gHLv$/VcqU6FLi6CT2Oxn0MJQ2C2tqnRDrYKNF8HIYWJp68nvXvPdFccDsT04.WtigUONbKYrgKg8d6rEs8PjljMkH0'
Step 2: Run command controllers cellular wwan0 pdp 1 show network-data-connection at DUT0 and check if output matches the following regular expressions:
Connection status\s* = connectedShow output
Connection status = connected Traffic channel status = active Max. TX channel rate (bps) = 0 Max. RX channel rate (bps) = 0 IPv4 address = 81.47.68.39 IPv4 mask = 255.255.255.240 IPv4 gateway = 81.47.68.40 IPv4 primary DNS = 80.58.61.248 IPv4 secondary DNS = 80.58.61.249
Note
Once the cellular interface is configured, it can be verified that there is network connectivity by pinging Google's DNS public server.
Step 3: Ping IP address 8.8.8.8 from DUT0:
admin@DUT0$ ping 8.8.8.8 count 1 size 56 timeout 1Show output
PING 8.8.8.8 (8.8.8.8) 56(84) bytes of data. 64 bytes from 8.8.8.8: icmp_seq=1 ttl=118 time=169 ms --- 8.8.8.8 ping statistics --- 1 packets transmitted, 1 received, 0% packet loss, time 0ms rtt min/avg/max/mdev = 169.055/169.055/169.055/0.000 ms
Note
The accessibility control is a mechanism where pings are sent at an interval, and to the IP address, configured by the user. The mechanism then waits for a response within this interval. If no response is received before it times out, a second ping is sent and a response is expected within 10 seconds. If there is still no response, two more pings are sent at 5-second intervals. Finally, if there is still no response, the device reconnects to the network.
Note
As a result, you can verify that no reconnection has been recorded in the system logs if you wait long enough.
Step 4: Run command system journal clear at DUT0.
Step 5: Run command system journal show | cat at DUT0 and check if output does not contain the following tokens:
[Device/wwan0] Warning: [PDP#1] Requesting reconnection... [Device/wwan0] Info: WDS[0]: Stopping network connection... [Device/wwan0] Info: [PDP#1] Establishing network connection...Show output
Mar 23 11:16:03.008084 osdx systemd-journald[2405]: Runtime Journal (/run/log/journal/7c919151e9af4b43885b805d90f44a99) is 8.0M, max 69.4M, 61.4M free. Mar 23 11:16:03.009636 osdx systemd-journald[2405]: Received client request to rotate journal, rotating. Mar 23 11:16:03.009689 osdx systemd-journald[2405]: Vacuuming done, freed 0B of archived journals from /run/log/journal/7c919151e9af4b43885b805d90f44a99. Mar 23 11:16:03.066002 osdx OSDxCLI[579609]: User 'admin' executed a new command: 'system journal clear'. Mar 23 11:16:06.929468 osdx wwan-accessibility-control[583746]: [Core/wwan0/1] Warning: Previous packet pending - ID: 59458, Sequence: 0 Mar 23 11:16:06.929475 osdx wwan-accessibility-control[583746]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 1 - interval reduced to 10 seconds
Note
However, when traffic control is applied, it is possible to prove the 'ping' command is failing because ICMP packets are being dropped.
Step 6: Run command system journal clear at DUT0.
Step 7: Modify the following configuration lines in DUT0 :
set interfaces cellular cell0 traffic control in PLOSS set traffic control PLOSS type network-emulator packet-loss 100
Step 8: Expect a failure in the following command:
Ping IP address 8.8.8.8 from DUT0:
admin@DUT0$ ping 8.8.8.8 count 1 size 56 timeout 1Show output
PING 8.8.8.8 (8.8.8.8) 56(84) bytes of data. --- 8.8.8.8 ping statistics --- 1 packets transmitted, 0 received, 100% packet loss, time 0ms
Note
You can verify that a reconnection has been recorded in the system logs if you wait long enough.
Step 9: Run command system journal show | cat at DUT0 and check if output contains the following tokens:
[Device/wwan0] Warning: [PDP#1] Requesting reconnection... [Device/wwan0] Info: WDS[0]: Stopping network connection... [Device/wwan0] Info: [PDP#1] Establishing network connection...Show output
Mar 23 11:16:45.323229 osdx systemd-journald[2405]: Runtime Journal (/run/log/journal/7c919151e9af4b43885b805d90f44a99) is 8.0M, max 69.4M, 61.4M free. Mar 23 11:16:45.324871 osdx systemd-journald[2405]: Received client request to rotate journal, rotating. Mar 23 11:16:45.324944 osdx systemd-journald[2405]: Vacuuming done, freed 0B of archived journals from /run/log/journal/7c919151e9af4b43885b805d90f44a99. Mar 23 11:16:45.377980 osdx OSDxCLI[579609]: User 'admin' executed a new command: 'system journal clear'. Mar 23 11:16:45.499513 osdx OSDxCLI[579609]: User 'admin' entered the configuration menu. Mar 23 11:16:45.592772 osdx OSDxCLI[579609]: User 'admin' added a new cfg line: 'set interfaces cellular cell0 traffic control in PLOSS'. Mar 23 11:16:45.671679 osdx OSDxCLI[579609]: User 'admin' added a new cfg line: 'set traffic control PLOSS type network-emulator packet-loss 100'. Mar 23 11:16:45.780244 osdx OSDxCLI[579609]: User 'admin' added a new cfg line: 'show changes'. Mar 23 11:16:45.864401 osdx ubnt-cfgd[583837]: inactive Mar 23 11:16:45.905887 osdx INFO[583847]: FRR daemons did not change Mar 23 11:16:45.931201 osdx (udev-worker)[583865]: ifb.cell0: Could not set Alias=, MACAddress=/MACAddressPolicy=, TransmitQueues=, ReceiveQueues=, TransmitQueueLength=, MTUBytes=, GenericSegmentOffloadMaxBytes= or GenericSegmentOffloadMaxSegments=, ignoring: Operation not supported Mar 23 11:16:45.931230 osdx (udev-worker)[583865]: Network interface NamePolicy= disabled on kernel command line. Mar 23 11:16:45.939303 osdx cfgd[2020]: [579609]Completed change to active configuration Mar 23 11:16:45.942366 osdx OSDxCLI[579609]: User 'admin' committed the configuration. Mar 23 11:16:45.982513 osdx OSDxCLI[579609]: User 'admin' left the configuration menu. Mar 23 11:16:47.126167 osdx OSDxCLI[579609]: User 'admin' executed a new command: 'ping 8.8.8.8 count 1 size 56 timeout 1'. Mar 23 11:16:56.930210 osdx wwan-accessibility-control[583746]: [Core/wwan0/1] Warning: Previous packet pending - ID: 59458, Sequence: 5 Mar 23 11:16:56.930216 osdx wwan-accessibility-control[583746]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 1 - interval reduced to 10 seconds Mar 23 11:17:06.930456 osdx wwan-accessibility-control[583746]: [Core/wwan0/1] Warning: Previous packet pending - ID: 59458, Sequence: 6 Mar 23 11:17:06.930461 osdx wwan-accessibility-control[583746]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 2 - interval reduced to 5 seconds Mar 23 11:17:07.433318 osdx OSDxCLI[579609]: User 'admin' executed a new command: 'system journal show | cat'. Mar 23 11:17:08.761333 osdx OSDxCLI[579609]: User 'admin' executed a new command: 'system journal show | cat'. Mar 23 11:17:10.113329 osdx OSDxCLI[579609]: User 'admin' executed a new command: 'system journal show | cat'. Mar 23 11:17:11.445317 osdx OSDxCLI[579609]: User 'admin' executed a new command: 'system journal show | cat'. Mar 23 11:17:11.930591 osdx wwan-accessibility-control[583746]: [Core/wwan0/1] Warning: Previous packet pending - ID: 59458, Sequence: 7 Mar 23 11:17:11.930596 osdx wwan-accessibility-control[583746]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 3 - interval reduced to 5 seconds Mar 23 11:17:12.841326 osdx OSDxCLI[579609]: User 'admin' executed a new command: 'system journal show | cat'. Mar 23 11:17:14.217342 osdx OSDxCLI[579609]: User 'admin' executed a new command: 'system journal show | cat'. Mar 23 11:17:15.645320 osdx OSDxCLI[579609]: User 'admin' executed a new command: 'system journal show | cat'. Mar 23 11:17:16.930769 osdx wwan-accessibility-control[583746]: [Core/wwan0/1] Warning: Previous packet pending - ID: 59458, Sequence: 8 Mar 23 11:17:16.930775 osdx wwan-accessibility-control[583746]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 4 - interval reduced to 5 seconds Mar 23 11:17:16.934307 osdx WARNING[583961]: [wwan0/1] Requesting reconnection... Mar 23 11:17:16.937064 osdx wwan-cli-socket[583963]: [Device/wwan0] Info: wwan-cli-socket reconnect 60000 wwan0 Mar 23 11:17:16.937300 osdx wwan-module[3802]: [Device/wwan0] Info: Reconnecting device... Mar 23 11:17:16.937307 osdx wwan-module[3802]: [Device/wwan0] Warning: [PDP#1] Requesting reconnection... Mar 23 11:17:16.937334 osdx wwan-module[3802]: [Device/wwan0] Info: WDS[0]: Stopping network connection... Mar 23 11:17:17.028182 osdx wwan-module[3802]: [Device/wwan0] Info: WDS[0]: Network connection was stopped! Mar 23 11:17:17.032874 osdx kernel: net _wwan0: link_state 0x1 -> 0x0 Mar 23 11:17:17.035235 osdx wwan-module[3802]: [Device/wwan0] Info: Checking registration state... Mar 23 11:17:17.038645 osdx wwan-accessibility-control[583746]: [Core/wwan0/1] Info: Execution stopped Mar 23 11:17:17.038672 osdx systemd[1]: Stopping wwan-accessibility-control@wwan0pdp1.service - WWAN Accessibility Control... Mar 23 11:17:17.039314 osdx systemd[1]: wwan-accessibility-control@wwan0pdp1.service: Deactivated successfully. Mar 23 11:17:17.039475 osdx systemd[1]: Stopped wwan-accessibility-control@wwan0pdp1.service - WWAN Accessibility Control. Mar 23 11:17:17.043263 osdx INFO[583967]: Stop DHCP client for cell0 Mar 23 11:17:17.045338 osdx OSDxCLI[579609]: User 'admin' executed a new command: 'system journal show | cat'. Mar 23 11:17:17.046351 osdx dhclient[583974]: Killed old client process Mar 23 11:17:17.092141 osdx wwan-module[3802]: [Device/wwan0] Info: Device registered and PS attached successfully Mar 23 11:17:17.092149 osdx wwan-module[3802]: [Device/wwan0] Info: [PDP#1] Establishing network connection... Mar 23 11:17:17.169040 osdx dhclient[583974]: DHCPRELEASE of 81.47.68.39 on cell0 to 81.47.68.40 port 67 Mar 23 11:17:17.284999 osdx wwan-module[3802]: [Device/wwan0] Info: [PDP#1] Network connection was successfully started: PDH=[3798867552] Mar 23 11:17:17.328915 osdx kernel: cell0: (slave _wwan0_1): Releasing backup interface Mar 23 11:17:17.348900 osdx kernel: net _wwan0: link_state 0x0 -> 0x1 Mar 23 11:17:17.384883 osdx kernel: cell0: (slave _wwan0_1): The slave device specified does not support setting the MAC address Mar 23 11:17:17.384951 osdx kernel: cell0: (slave _wwan0_1): making interface the new active one Mar 23 11:17:17.384968 osdx kernel: cell0: (slave _wwan0_1): Enslaving as an active interface with an up link Mar 23 11:17:17.390401 osdx INFO[584021]: Start DHCP client for cell0 Mar 23 11:17:17.392888 osdx kernel: 8021q: adding VLAN 0 to HW filter on device cell0 Mar 23 11:17:17.561093 osdx dhclient[584034]: DHCPDISCOVER on cell0 to 255.255.255.255 port 67 interval 7 Mar 23 11:17:17.563678 osdx dhclient[584034]: DHCPOFFER of 37.12.71.239 from 37.12.71.240 Mar 23 11:17:17.563702 osdx dhclient[584034]: DHCPREQUEST for 37.12.71.239 on cell0 to 255.255.255.255 port 67 Mar 23 11:17:17.565764 osdx dhclient[584034]: DHCPACK of 37.12.71.239 from 37.12.71.240 Mar 23 11:17:17.597336 osdx systemd[1]: Started wwan-accessibility-control@wwan0pdp1.service - WWAN Accessibility Control. Mar 23 11:17:17.601423 osdx wwan-accessibility-control[584046]: [Core/wwan0/1] Info: Starting '/osdx/sbin/wwan-accessibility-control'... Mar 23 11:17:17.679348 osdx dhclient[584034]: bound to 37.12.71.239 -- renewal in 3211 seconds.
Step 1: Set the following configuration in DUT0 :
set cellular logging level info set cellular profile CELPROFILE accessibility-control ping address 8.8.8.8 set cellular profile CELPROFILE accessibility-control ping interval 10 set cellular profile CELPROFILE apn movistar.es set controllers cellular wwan0 sim select socket_1 set controllers cellular wwan0 sim socket socket_1 encrypted-pin U2FsdGVkX19CzflnJgKc9meVpabY9wr00z1D0XAJsh0= set controllers cellular wwan0 sim socket socket_1 pdp 1 profile CELPROFILE set interfaces cellular cell0 address dhcp set interfaces cellular cell0 phy wwan0 pdp 1 set system login user admin authentication encrypted-password '$6$GSjsCj8gHLv$/VcqU6FLi6CT2Oxn0MJQ2C2tqnRDrYKNF8HIYWJp68nvXvPdFccDsT04.WtigUONbKYrgKg8d6rEs8PjljMkH0'
Step 2: Run command controllers cellular wwan0 pdp 1 show network-data-connection at DUT0 and check if output matches the following regular expressions:
Connection status\s* = connectedShow output
Connection status = connected Traffic channel status = active Max. TX channel rate (bps) = 0 Max. RX channel rate (bps) = 0 IPv4 address = 37.12.64.181 IPv4 mask = 255.255.255.252 IPv4 gateway = 37.12.64.182 IPv4 primary DNS = 80.58.61.248 IPv4 secondary DNS = 80.58.61.249
Note
Once the cellular interface is configured, it can be verified that there is network connectivity by pinging Google's DNS public server.
Step 3: Ping IP address 8.8.8.8 from DUT0:
admin@DUT0$ ping 8.8.8.8 count 1 size 56 timeout 1Show output
PING 8.8.8.8 (8.8.8.8) 56(84) bytes of data. 64 bytes from 8.8.8.8: icmp_seq=1 ttl=117 time=176 ms --- 8.8.8.8 ping statistics --- 1 packets transmitted, 1 received, 0% packet loss, time 0ms rtt min/avg/max/mdev = 176.223/176.223/176.223/0.000 ms
Note
The accessibility control is a mechanism where pings are sent at an interval, and to the IP address, configured by the user. The mechanism then waits for a response within this interval. If no response is received before it times out, a second ping is sent and a response is expected within 10 seconds. If there is still no response, two more pings are sent at 5-second intervals. Finally, if there is still no response, the device reconnects to the network.
Note
As a result, you can verify that no reconnection has been recorded in the system logs if you wait long enough.
Step 4: Run command system journal clear at DUT0.
Step 5: Run command system journal show | cat at DUT0 and check if output does not contain the following tokens:
[Device/wwan0] Warning: [PDP#1] Requesting reconnection... [Device/wwan0] Info: WDS[0]: Stopping network connection... [Device/wwan0] Info: [PDP#1] Establishing network connection...Show output
Mar 23 18:29:07.176915 osdx systemd-journald[4182]: Runtime Journal (/run/log/journal/061ca38fd5074456992186287bc84b58) is 8.2M, max 80.3M, 72.0M free. Mar 23 18:29:07.181832 osdx systemd-journald[4182]: Received client request to rotate journal, rotating. Mar 23 18:29:07.181945 osdx systemd-journald[4182]: Vacuuming done, freed 0B of archived journals from /run/log/journal/061ca38fd5074456992186287bc84b58. Mar 23 18:29:07.266594 osdx OSDxCLI[114729]: User 'admin' executed a new command: 'system journal clear'. Mar 23 18:29:11.458236 osdx wwan-accessibility-control[126363]: [Core/wwan0/1] Warning: Previous packet pending - ID: 60827, Sequence: 0 Mar 23 18:29:11.458253 osdx wwan-accessibility-control[126363]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 1 - interval reduced to 10 seconds
Note
However, when traffic control is applied, it is possible to prove the 'ping' command is failing because ICMP packets are being dropped.
Step 6: Run command system journal clear at DUT0.
Step 7: Modify the following configuration lines in DUT0 :
set interfaces cellular cell0 traffic control in PLOSS set traffic control PLOSS type network-emulator packet-loss 100
Step 8: Expect a failure in the following command:
Ping IP address 8.8.8.8 from DUT0:
admin@DUT0$ ping 8.8.8.8 count 1 size 56 timeout 1Show output
PING 8.8.8.8 (8.8.8.8) 56(84) bytes of data. --- 8.8.8.8 ping statistics --- 1 packets transmitted, 0 received, 100% packet loss, time 0ms
Note
You can verify that a reconnection has been recorded in the system logs if you wait long enough.
Step 9: Run command system journal show | cat at DUT0 and check if output contains the following tokens:
[Device/wwan0] Warning: [PDP#1] Requesting reconnection... [Device/wwan0] Info: WDS[0]: Stopping network connection... [Device/wwan0] Info: [PDP#1] Establishing network connection...Show output
Mar 23 18:29:49.588064 osdx systemd-journald[4182]: Runtime Journal (/run/log/journal/061ca38fd5074456992186287bc84b58) is 8.0M, max 80.3M, 72.3M free. Mar 23 18:29:49.593197 osdx systemd-journald[4182]: Received client request to rotate journal, rotating. Mar 23 18:29:49.593318 osdx systemd-journald[4182]: Vacuuming done, freed 0B of archived journals from /run/log/journal/061ca38fd5074456992186287bc84b58. Mar 23 18:29:49.666657 osdx OSDxCLI[114729]: User 'admin' executed a new command: 'system journal clear'. Mar 23 18:29:49.828693 osdx OSDxCLI[114729]: User 'admin' entered the configuration menu. Mar 23 18:29:49.941812 osdx OSDxCLI[114729]: User 'admin' added a new cfg line: 'set interfaces cellular cell0 traffic control in PLOSS'. Mar 23 18:29:50.049769 osdx OSDxCLI[114729]: User 'admin' added a new cfg line: 'set traffic control PLOSS type network-emulator packet-loss 100'. Mar 23 18:29:50.161197 osdx OSDxCLI[114729]: User 'admin' added a new cfg line: 'show changes'. Mar 23 18:29:50.305535 osdx ubnt-cfgd[126455]: inactive Mar 23 18:29:50.401971 osdx INFO[126465]: FRR daemons did not change Mar 23 18:29:50.465293 osdx (udev-worker)[289]: ifb.cell0: Could not set Alias=, MACAddress=/MACAddressPolicy=, TransmitQueues=, ReceiveQueues=, TransmitQueueLength=, MTUBytes=, GenericSegmentOffloadMaxBytes= or GenericSegmentOffloadMaxSegments=, ignoring: Operation not supported Mar 23 18:29:50.500197 osdx kernel: netem: version 1.3 Mar 23 18:29:50.513961 osdx cfgd[3836]: [114729]Completed change to active configuration Mar 23 18:29:50.534021 osdx systemd[1]: osdx-ledsd.service: Sent signal SIGUSR2 to main process 4648 (osdx-ledsd) on client request. Mar 23 18:29:50.534052 osdx osdx-ledsd[4648]: Config changed, checking config paths Mar 23 18:29:50.536696 osdx OSDxCLI[114729]: User 'admin' committed the configuration. Mar 23 18:29:50.568320 osdx OSDxCLI[114729]: User 'admin' left the configuration menu. Mar 23 18:29:51.763068 osdx OSDxCLI[114729]: User 'admin' executed a new command: 'ping 8.8.8.8 count 1 size 56 timeout 1'. Mar 23 18:30:01.458957 osdx wwan-accessibility-control[126363]: [Core/wwan0/1] Warning: Previous packet pending - ID: 60827, Sequence: 5 Mar 23 18:30:01.458971 osdx wwan-accessibility-control[126363]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 1 - interval reduced to 10 seconds Mar 23 18:30:11.459135 osdx wwan-accessibility-control[126363]: [Core/wwan0/1] Warning: Previous packet pending - ID: 60827, Sequence: 6 Mar 23 18:30:11.459150 osdx wwan-accessibility-control[126363]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 2 - interval reduced to 5 seconds Mar 23 18:30:12.129090 osdx OSDxCLI[114729]: User 'admin' executed a new command: 'system journal show | cat'. Mar 23 18:30:13.513088 osdx OSDxCLI[114729]: User 'admin' executed a new command: 'system journal show | cat'. Mar 23 18:30:14.901091 osdx OSDxCLI[114729]: User 'admin' executed a new command: 'system journal show | cat'. Mar 23 18:30:16.293103 osdx OSDxCLI[114729]: User 'admin' executed a new command: 'system journal show | cat'. Mar 23 18:30:16.459314 osdx wwan-accessibility-control[126363]: [Core/wwan0/1] Warning: Previous packet pending - ID: 60827, Sequence: 7 Mar 23 18:30:16.459328 osdx wwan-accessibility-control[126363]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 3 - interval reduced to 5 seconds Mar 23 18:30:17.717097 osdx OSDxCLI[114729]: User 'admin' executed a new command: 'system journal show | cat'. Mar 23 18:30:19.177095 osdx OSDxCLI[114729]: User 'admin' executed a new command: 'system journal show | cat'. Mar 23 18:30:20.645106 osdx OSDxCLI[114729]: User 'admin' executed a new command: 'system journal show | cat'. Mar 23 18:30:21.459492 osdx wwan-accessibility-control[126363]: [Core/wwan0/1] Warning: Previous packet pending - ID: 60827, Sequence: 8 Mar 23 18:30:21.459506 osdx wwan-accessibility-control[126363]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 4 - interval reduced to 5 seconds Mar 23 18:30:21.469608 osdx WARNING[126571]: [wwan0/1] Requesting reconnection... Mar 23 18:30:21.476257 osdx wwan-cli-socket[126573]: [Device/wwan0] Info: wwan-cli-socket reconnect 60000 wwan0 Mar 23 18:30:21.476646 osdx wwan-module[4682]: [Device/wwan0] Info: Reconnecting device... Mar 23 18:30:21.476658 osdx wwan-module[4682]: [Device/wwan0] Warning: [PDP#1] Requesting reconnection... Mar 23 18:30:21.476715 osdx wwan-module[4682]: [Device/wwan0] Info: WDS[0]: Stopping network connection... Mar 23 18:30:21.562553 osdx wwan-module[4682]: [Device/wwan0] Info: WDS[0]: Network connection was stopped! Mar 23 18:30:21.568171 osdx kernel: net _wwan0: link_state 0x1 -> 0x0 Mar 23 18:30:21.571155 osdx wwan-module[4682]: [Device/wwan0] Info: Checking registration state... Mar 23 18:30:21.591393 osdx wwan-accessibility-control[126363]: [Core/wwan0/1] Info: Execution stopped Mar 23 18:30:21.591501 osdx systemd[1]: Stopping wwan-accessibility-control@wwan0pdp1.service - WWAN Accessibility Control... Mar 23 18:30:21.593485 osdx systemd[1]: wwan-accessibility-control@wwan0pdp1.service: Deactivated successfully. Mar 23 18:30:21.593862 osdx systemd[1]: Stopped wwan-accessibility-control@wwan0pdp1.service - WWAN Accessibility Control. Mar 23 18:30:21.603940 osdx INFO[126577]: Stop DHCP client for cell0 Mar 23 18:30:21.611087 osdx dhclient[126584]: Killed old client process Mar 23 18:30:21.627044 osdx wwan-module[4682]: [Device/wwan0] Info: Device registered and PS attached successfully Mar 23 18:30:21.627059 osdx wwan-module[4682]: [Device/wwan0] Info: [PDP#1] Establishing network connection... Mar 23 18:30:21.736377 osdx dhclient[126584]: DHCPRELEASE of 37.12.64.181 on cell0 to 37.12.64.182 port 67