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 U2FsdGVkX1/M+u/75qvw6MaRw/YhWVBxY5ObGW0gPrA= 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 the command controllers cellular wwan0 pdp 1 show network-data-connection on DUT0 and check whether the 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 = 176.82.165.117 IPv4 mask = 255.255.255.252 IPv4 gateway = 176.82.165.118 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 the 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=41.7 ms --- 8.8.8.8 ping statistics --- 1 packets transmitted, 1 received, 0% packet loss, time 0ms rtt min/avg/max/mdev = 41.727/41.727/41.727/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 the command system journal clear on DUT0.
Step 5: Run the command system journal show | cat on DUT0 and check whether the 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
Sep 17 02:50:16.431135 osdx systemd-journald[2389]: Runtime Journal (/run/log/journal/6a66c8bc96ce4f178e17aba81ad62a1f) is 8.0M, max 80.5M, 72.5M free. Sep 17 02:50:16.438053 osdx systemd-journald[2389]: Received client request to rotate journal, rotating. Sep 17 02:50:16.438236 osdx systemd-journald[2389]: Vacuuming done, freed 0B of archived journals from /run/log/journal/6a66c8bc96ce4f178e17aba81ad62a1f. Sep 17 02:50:16.523284 osdx OSDxCLI[404749]: User 'admin' executed a new command: 'system journal clear'. Sep 17 02:50:25.515937 osdx wwan-accessibility-control[414304]: [Core/wwan0/1] Warning: Previous packet pending - ID: 21088, Sequence: 0 Sep 17 02:50:25.515959 osdx wwan-accessibility-control[414304]: [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 the command system journal clear on 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 the 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 the command system journal show | cat on DUT0 and check whether the 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
Sep 17 02:50:58.829751 osdx systemd-journald[2389]: Runtime Journal (/run/log/journal/6a66c8bc96ce4f178e17aba81ad62a1f) is 8.0M, max 80.5M, 72.5M free. Sep 17 02:50:58.836874 osdx systemd-journald[2389]: Received client request to rotate journal, rotating. Sep 17 02:50:58.837058 osdx systemd-journald[2389]: Vacuuming done, freed 0B of archived journals from /run/log/journal/6a66c8bc96ce4f178e17aba81ad62a1f. Sep 17 02:50:58.919284 osdx OSDxCLI[404749]: User 'admin' executed a new command: 'system journal clear'. Sep 17 02:50:59.051457 osdx OSDxCLI[404749]: User 'admin' entered the configuration menu. Sep 17 02:50:59.150123 osdx OSDxCLI[404749]: User 'admin' added a new cfg line: 'set interfaces cellular cell0 traffic control in PLOSS'. Sep 17 02:50:59.259171 osdx OSDxCLI[404749]: User 'admin' added a new cfg line: 'set traffic control PLOSS type network-emulator packet-loss 100'. Sep 17 02:50:59.371243 osdx OSDxCLI[404749]: User 'admin' added a new cfg line: 'show changes'. Sep 17 02:50:59.521002 osdx ubnt-cfgd[414401]: inactive Sep 17 02:50:59.665962 osdx INFO[414412]: FRR daemons did not change Sep 17 02:50:59.789006 osdx (udev-worker)[414428]: ifb.cell0: Could not set Alias=, MACAddress=/MACAddressPolicy=, TransmitQueues=, ReceiveQueues=, TransmitQueueLength=, MTUBytes=, GenericSegmentOffloadMaxBytes= or GenericSegmentOffloadMaxSegments=, ignoring: Operation not supported Sep 17 02:50:59.789126 osdx (udev-worker)[414428]: Network interface NamePolicy= disabled on kernel command line. Sep 17 02:50:59.847920 osdx kernel: Mirror/redirect action on Sep 17 02:50:59.867912 osdx kernel: netem: version 1.3 Sep 17 02:50:59.905739 osdx cfgd[2057]: [404749]Completed change to active configuration Sep 17 02:50:59.926891 osdx systemd[1]: osdx-ledsd.service: Sent signal SIGUSR2 to main process 2722 (osdx-ledsd) on client request. Sep 17 02:50:59.926929 osdx osdx-ledsd[2722]: Config changed, checking config paths Sep 17 02:50:59.930827 osdx OSDxCLI[404749]: User 'admin' committed the configuration. Sep 17 02:50:59.965456 osdx OSDxCLI[404749]: User 'admin' left the configuration menu. Sep 17 02:51:01.176032 osdx OSDxCLI[404749]: User 'admin' executed a new command: 'ping 8.8.8.8 count 1 size 56 timeout 1'. Sep 17 02:51:15.516998 osdx wwan-accessibility-control[414304]: [Core/wwan0/1] Warning: Previous packet pending - ID: 21088, Sequence: 5 Sep 17 02:51:15.517019 osdx wwan-accessibility-control[414304]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 1 - interval reduced to 10 seconds Sep 17 02:51:21.537215 osdx OSDxCLI[404749]: User 'admin' executed a new command: 'system journal show | cat'. Sep 17 02:51:22.885240 osdx OSDxCLI[404749]: User 'admin' executed a new command: 'system journal show | cat'. Sep 17 02:51:24.253230 osdx OSDxCLI[404749]: User 'admin' executed a new command: 'system journal show | cat'. Sep 17 02:51:25.517269 osdx wwan-accessibility-control[414304]: [Core/wwan0/1] Warning: Previous packet pending - ID: 21088, Sequence: 6 Sep 17 02:51:25.517293 osdx wwan-accessibility-control[414304]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 2 - interval reduced to 5 seconds Sep 17 02:51:25.657172 osdx OSDxCLI[404749]: User 'admin' executed a new command: 'system journal show | cat'. Sep 17 02:51:27.085206 osdx OSDxCLI[404749]: User 'admin' executed a new command: 'system journal show | cat'. Sep 17 02:51:28.501225 osdx OSDxCLI[404749]: User 'admin' executed a new command: 'system journal show | cat'. Sep 17 02:51:29.953216 osdx OSDxCLI[404749]: User 'admin' executed a new command: 'system journal show | cat'. Sep 17 02:51:30.517591 osdx wwan-accessibility-control[414304]: [Core/wwan0/1] Warning: Previous packet pending - ID: 21088, Sequence: 7 Sep 17 02:51:30.517608 osdx wwan-accessibility-control[414304]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 3 - interval reduced to 5 seconds Sep 17 02:51:31.417223 osdx OSDxCLI[404749]: User 'admin' executed a new command: 'system journal show | cat'. Sep 17 02:51:32.901239 osdx OSDxCLI[404749]: User 'admin' executed a new command: 'system journal show | cat'. Sep 17 02:51:34.465196 osdx OSDxCLI[404749]: User 'admin' executed a new command: 'system journal show | cat'. Sep 17 02:51:35.517852 osdx wwan-accessibility-control[414304]: [Core/wwan0/1] Warning: Previous packet pending - ID: 21088, Sequence: 8 Sep 17 02:51:35.517870 osdx wwan-accessibility-control[414304]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 4 - interval reduced to 5 seconds Sep 17 02:51:35.530554 osdx WARNING[414522]: [wwan0/1] Requesting reconnection... Sep 17 02:51:35.539974 osdx wwan-cli-socket[414525]: [Device/wwan0] Info: wwan-cli-socket reconnect 60000 wwan0 Sep 17 02:51:35.540546 osdx wwan-module[404734]: [Device/wwan0] Info: Reconnecting device... Sep 17 02:51:35.540561 osdx wwan-module[404734]: [Device/wwan0] Warning: [PDP#1] Requesting reconnection... Sep 17 02:51:35.540630 osdx wwan-module[404734]: [Device/wwan0] Info: WDS[0]: Stopping network connection... Sep 17 02:51:35.655021 osdx wwan-module[404734]: [Device/wwan0] Info: WDS[0]: Network connection was stopped! Sep 17 02:51:35.660095 osdx kernel: net _wwan0: link_state 0x1 -> 0x0 Sep 17 02:51:35.669043 osdx wwan-module[404734]: [Device/wwan0] Info: [PDP#1] Checking registration state... Sep 17 02:51:35.693183 osdx wwan-accessibility-control[414304]: [Core/wwan0/1] Info: Execution stopped Sep 17 02:51:35.693581 osdx systemd[1]: Stopping wwan-accessibility-control@wwan0pdp1.service - WWAN Accessibility Control... Sep 17 02:51:35.696584 osdx systemd[1]: wwan-accessibility-control@wwan0pdp1.service: Deactivated successfully. Sep 17 02:51:35.697117 osdx systemd[1]: Stopped wwan-accessibility-control@wwan0pdp1.service - WWAN Accessibility Control. Sep 17 02:51:35.713582 osdx INFO[414533]: Stop DHCP client for cell0 Sep 17 02:51:35.726043 osdx dhclient[414540]: Killed old client process Sep 17 02:51:35.782306 osdx wwan-module[404734]: [Device/wwan0] Info: [PDP#1] Device registered and PS attached successfully Sep 17 02:51:35.856187 osdx dhclient[414540]: DHCPRELEASE of 176.82.165.117 on cell0 to 176.82.165.118 port 67 Sep 17 02:51:36.033404 osdx OSDxCLI[404749]: User 'admin' executed a new command: 'system journal show | cat'. Sep 17 02:51:36.230465 osdx wwan-module[404734]: [Device/wwan0] Info: [PDP#1] Establishing network connection... Sep 17 02:51:36.391915 osdx kernel: cell0: (slave _wwan0_1): Releasing backup interface Sep 17 02:51:36.457190 osdx wwan-module[404734]: [Device/wwan0] Info: [PDP#1] Network connection was successfully started: PDH=[3308525408] Sep 17 02:51:36.583896 osdx kernel: net _wwan0: link_state 0x0 -> 0x1 Sep 17 02:51:36.623920 osdx kernel: cell0: (slave _wwan0_1): The slave device specified does not support setting the MAC address Sep 17 02:51:36.624137 osdx kernel: cell0: (slave _wwan0_1): making interface the new active one Sep 17 02:51:36.627923 osdx kernel: cell0: (slave _wwan0_1): Enslaving as an active interface with an up link Sep 17 02:51:36.643918 osdx kernel: 8021q: adding VLAN 0 to HW filter on device cell0 Sep 17 02:51:36.644965 osdx INFO[414595]: Start DHCP client for cell0 Sep 17 02:51:37.144500 osdx dhclient[414608]: DHCPDISCOVER on cell0 to 255.255.255.255 port 67 interval 6 Sep 17 02:51:37.150095 osdx dhclient[414608]: DHCPOFFER of 2.143.59.26 from 2.143.59.25 Sep 17 02:51:37.150177 osdx dhclient[414608]: DHCPREQUEST for 2.143.59.26 on cell0 to 255.255.255.255 port 67
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 U2FsdGVkX19cDgFqERrartIVlwr2SbJL+GhCdkfl1J4= 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 the command controllers cellular wwan0 pdp 1 show network-data-connection on DUT0 and check whether the 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 = 5.205.255.170 IPv4 mask = 255.255.255.252 IPv4 gateway = 5.205.255.169 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 the 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=38.8 ms --- 8.8.8.8 ping statistics --- 1 packets transmitted, 1 received, 0% packet loss, time 0ms rtt min/avg/max/mdev = 38.812/38.812/38.812/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 the command system journal clear on DUT0.
Step 5: Run the command system journal show | cat on DUT0 and check whether the 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
Sep 16 14:42:20.211733 osdx systemd-journald[2507]: Runtime Journal (/run/log/journal/c4b215c21f5d4e8598c3edc070196847) is 8.0M, max 69.4M, 61.4M free. Sep 16 14:42:20.213411 osdx systemd-journald[2507]: Received client request to rotate journal, rotating. Sep 16 14:42:20.213463 osdx systemd-journald[2507]: Vacuuming done, freed 0B of archived journals from /run/log/journal/c4b215c21f5d4e8598c3edc070196847. Sep 16 14:42:20.266394 osdx OSDxCLI[115773]: User 'admin' executed a new command: 'system journal clear'. Sep 16 14:42:25.918300 osdx wwan-accessibility-control[119503]: [Core/wwan0/1] Warning: Previous packet pending - ID: 53967, Sequence: 0 Sep 16 14:42:25.918308 osdx wwan-accessibility-control[119503]: [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 the command system journal clear on 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 the 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 the command system journal show | cat on DUT0 and check whether the 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
Sep 16 14:43:02.487515 osdx systemd-journald[2507]: Runtime Journal (/run/log/journal/c4b215c21f5d4e8598c3edc070196847) is 8.0M, max 69.4M, 61.4M free. Sep 16 14:43:02.489323 osdx systemd-journald[2507]: Received client request to rotate journal, rotating. Sep 16 14:43:02.489395 osdx systemd-journald[2507]: Vacuuming done, freed 0B of archived journals from /run/log/journal/c4b215c21f5d4e8598c3edc070196847. Sep 16 14:43:02.546346 osdx OSDxCLI[115773]: User 'admin' executed a new command: 'system journal clear'. Sep 16 14:43:02.680000 osdx OSDxCLI[115773]: User 'admin' entered the configuration menu. Sep 16 14:43:02.776110 osdx OSDxCLI[115773]: User 'admin' added a new cfg line: 'set interfaces cellular cell0 traffic control in PLOSS'. Sep 16 14:43:02.852319 osdx OSDxCLI[115773]: User 'admin' added a new cfg line: 'set traffic control PLOSS type network-emulator packet-loss 100'. Sep 16 14:43:03.008861 osdx OSDxCLI[115773]: User 'admin' added a new cfg line: 'show changes'. Sep 16 14:43:03.112894 osdx ubnt-cfgd[119601]: inactive Sep 16 14:43:03.174298 osdx INFO[119612]: FRR daemons did not change Sep 16 14:43:03.206644 osdx (udev-worker)[119627]: ifb.cell0: Could not set Alias=, MACAddress=/MACAddressPolicy=, TransmitQueues=, ReceiveQueues=, TransmitQueueLength=, MTUBytes=, GenericSegmentOffloadMaxBytes= or GenericSegmentOffloadMaxSegments=, ignoring: Operation not supported Sep 16 14:43:03.206672 osdx (udev-worker)[119627]: Network interface NamePolicy= disabled on kernel command line. Sep 16 14:43:03.229306 osdx kernel: u32 classifier Sep 16 14:43:03.229369 osdx kernel: Performance counters on Sep 16 14:43:03.229386 osdx kernel: input device check on Sep 16 14:43:03.229400 osdx kernel: Actions configured Sep 16 14:43:03.233321 osdx kernel: Mirror/redirect action on Sep 16 14:43:03.237302 osdx kernel: netem: version 1.3 Sep 16 14:43:03.248674 osdx cfgd[2101]: [115773]Completed change to active configuration Sep 16 14:43:03.249373 osdx OSDxCLI[115773]: User 'admin' committed the configuration. Sep 16 14:43:03.290918 osdx OSDxCLI[115773]: User 'admin' left the configuration menu. Sep 16 14:43:04.466553 osdx OSDxCLI[115773]: User 'admin' executed a new command: 'ping 8.8.8.8 count 1 size 56 timeout 1'. Sep 16 14:43:15.918920 osdx wwan-accessibility-control[119503]: [Core/wwan0/1] Warning: Previous packet pending - ID: 53967, Sequence: 5 Sep 16 14:43:15.918928 osdx wwan-accessibility-control[119503]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 1 - interval reduced to 10 seconds Sep 16 14:43:24.789740 osdx OSDxCLI[115773]: User 'admin' executed a new command: 'system journal show | cat'. Sep 16 14:43:25.919205 osdx wwan-accessibility-control[119503]: [Core/wwan0/1] Warning: Previous packet pending - ID: 53967, Sequence: 6 Sep 16 14:43:25.919213 osdx wwan-accessibility-control[119503]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 2 - interval reduced to 5 seconds Sep 16 14:43:26.149726 osdx OSDxCLI[115773]: User 'admin' executed a new command: 'system journal show | cat'. Sep 16 14:43:27.517722 osdx OSDxCLI[115773]: User 'admin' executed a new command: 'system journal show | cat'. Sep 16 14:43:28.893732 osdx OSDxCLI[115773]: User 'admin' executed a new command: 'system journal show | cat'. Sep 16 14:43:30.281725 osdx OSDxCLI[115773]: User 'admin' executed a new command: 'system journal show | cat'. Sep 16 14:43:30.919335 osdx wwan-accessibility-control[119503]: [Core/wwan0/1] Warning: Previous packet pending - ID: 53967, Sequence: 7 Sep 16 14:43:30.919342 osdx wwan-accessibility-control[119503]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 3 - interval reduced to 5 seconds Sep 16 14:43:31.701724 osdx OSDxCLI[115773]: User 'admin' executed a new command: 'system journal show | cat'. Sep 16 14:43:33.145735 osdx OSDxCLI[115773]: User 'admin' executed a new command: 'system journal show | cat'. Sep 16 14:43:34.581745 osdx OSDxCLI[115773]: User 'admin' executed a new command: 'system journal show | cat'. Sep 16 14:43:35.919462 osdx wwan-accessibility-control[119503]: [Core/wwan0/1] Warning: Previous packet pending - ID: 53967, Sequence: 8 Sep 16 14:43:35.919469 osdx wwan-accessibility-control[119503]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 4 - interval reduced to 5 seconds Sep 16 14:43:35.922966 osdx WARNING[119712]: [wwan0/1] Requesting reconnection... Sep 16 14:43:35.925844 osdx wwan-cli-socket[119714]: [Device/wwan0] Info: wwan-cli-socket reconnect 60000 wwan0 Sep 16 14:43:35.926081 osdx wwan-module[3940]: [Device/wwan0] Info: Reconnecting device... Sep 16 14:43:35.926087 osdx wwan-module[3940]: [Device/wwan0] Warning: [PDP#1] Requesting reconnection... Sep 16 14:43:35.926113 osdx wwan-module[3940]: [Device/wwan0] Info: WDS[0]: Stopping network connection... Sep 16 14:43:36.025759 osdx OSDxCLI[115773]: User 'admin' executed a new command: 'system journal show | cat'. Sep 16 14:43:36.049028 osdx wwan-module[3940]: [Device/wwan0] Info: WDS[0]: Network connection was stopped! Sep 16 14:43:36.053303 osdx kernel: net _wwan0: link_state 0x1 -> 0x0 Sep 16 14:43:36.054719 osdx wwan-module[3940]: [Device/wwan0] Info: [PDP#1] Checking registration state... Sep 16 14:43:36.059583 osdx systemd[1]: Stopping wwan-accessibility-control@wwan0pdp1.service - WWAN Accessibility Control... Sep 16 14:43:36.059585 osdx wwan-accessibility-control[119503]: [Core/wwan0/1] Info: Execution stopped Sep 16 14:43:36.060345 osdx systemd[1]: wwan-accessibility-control@wwan0pdp1.service: Deactivated successfully. Sep 16 14:43:36.060504 osdx systemd[1]: Stopped wwan-accessibility-control@wwan0pdp1.service - WWAN Accessibility Control. Sep 16 14:43:36.064174 osdx INFO[119718]: Stop DHCP client for cell0 Sep 16 14:43:36.067205 osdx dhclient[119725]: Killed old client process Sep 16 14:43:36.112854 osdx wwan-module[3940]: [Device/wwan0] Info: [PDP#1] Device registered and PS attached successfully Sep 16 14:43:36.201438 osdx dhclient[119725]: DHCPRELEASE of 5.205.255.170 on cell0 to 5.205.255.169 port 67 Sep 16 14:43:36.336870 osdx wwan-module[3940]: [Device/wwan0] Info: [PDP#1] Establishing network connection... Sep 16 14:43:36.345311 osdx kernel: cell0: (slave _wwan0_1): Releasing backup interface Sep 16 14:43:36.593855 osdx wwan-module[3940]: [Device/wwan0] Info: [PDP#1] Network connection was successfully started: PDH=[3798950352] Sep 16 14:43:36.657294 osdx kernel: net _wwan0: link_state 0x0 -> 0x1 Sep 16 14:43:36.673301 osdx kernel: cell0: (slave _wwan0_1): The slave device specified does not support setting the MAC address Sep 16 14:43:36.673362 osdx kernel: cell0: (slave _wwan0_1): making interface the new active one Sep 16 14:43:36.673378 osdx kernel: cell0: (slave _wwan0_1): Enslaving as an active interface with an up link Sep 16 14:43:36.677304 osdx kernel: 8021q: adding VLAN 0 to HW filter on device cell0 Sep 16 14:43:36.677417 osdx INFO[119780]: Start DHCP client for cell0 Sep 16 14:43:36.857486 osdx dhclient[119793]: DHCPDISCOVER on cell0 to 255.255.255.255 port 67 interval 5 Sep 16 14:43:36.860058 osdx dhclient[119793]: DHCPOFFER of 37.12.7.74 from 37.12.7.73 Sep 16 14:43:36.860085 osdx dhclient[119793]: DHCPREQUEST for 37.12.7.74 on cell0 to 255.255.255.255 port 67 Sep 16 14:43:36.862248 osdx dhclient[119793]: DHCPACK of 37.12.7.74 from 37.12.7.73 Sep 16 14:43:36.893760 osdx systemd[1]: Started wwan-accessibility-control@wwan0pdp1.service - WWAN Accessibility Control. Sep 16 14:43:36.897785 osdx wwan-accessibility-control[119805]: [Core/wwan0/1] Info: Starting '/osdx/sbin/wwan-accessibility-control'... Sep 16 14:43:36.969083 osdx dhclient[119793]: bound to 37.12.7.74 -- renewal in 3581 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 U2FsdGVkX18UOezjZPVcdjo2xlhiVDfLL/0LzFi4I3w= 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 the command controllers cellular wwan0 pdp 1 show network-data-connection on DUT0 and check whether the 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.47.87 IPv4 mask = 255.255.255.240 IPv4 gateway = 37.12.47.88 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 the 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=116 time=36.9 ms --- 8.8.8.8 ping statistics --- 1 packets transmitted, 1 received, 0% packet loss, time 0ms rtt min/avg/max/mdev = 36.870/36.870/36.870/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 the command system journal clear on DUT0.
Step 5: Run the command system journal show | cat on DUT0 and check whether the 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
Sep 16 14:04:35.222863 osdx systemd-journald[4464]: Runtime Journal (/run/log/journal/6a66c8bc96ce4f178e17aba81ad62a1f) is 8.0M, max 80.3M, 72.3M free. Sep 16 14:04:35.227707 osdx systemd-journald[4464]: Received client request to rotate journal, rotating. Sep 16 14:04:35.227817 osdx systemd-journald[4464]: Vacuuming done, freed 0B of archived journals from /run/log/journal/6a66c8bc96ce4f178e17aba81ad62a1f. Sep 16 14:04:35.300002 osdx OSDxCLI[18614]: User 'admin' executed a new command: 'system journal clear'. Sep 16 14:04:42.097439 osdx wwan-accessibility-control[19502]: [Core/wwan0/1] Warning: Previous packet pending - ID: 19502, Sequence: 0 Sep 16 14:04:42.097457 osdx wwan-accessibility-control[19502]: [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 the command system journal clear on 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 the 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 the command system journal show | cat on DUT0 and check whether the 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
Sep 16 14:05:17.650190 osdx systemd-journald[4464]: Runtime Journal (/run/log/journal/6a66c8bc96ce4f178e17aba81ad62a1f) is 8.0M, max 80.3M, 72.3M free. Sep 16 14:05:17.655326 osdx systemd-journald[4464]: Received client request to rotate journal, rotating. Sep 16 14:05:17.655436 osdx systemd-journald[4464]: Vacuuming done, freed 0B of archived journals from /run/log/journal/6a66c8bc96ce4f178e17aba81ad62a1f. Sep 16 14:05:17.728013 osdx OSDxCLI[18614]: User 'admin' executed a new command: 'system journal clear'. Sep 16 14:05:17.898722 osdx OSDxCLI[18614]: User 'admin' entered the configuration menu. Sep 16 14:05:18.034852 osdx OSDxCLI[18614]: User 'admin' added a new cfg line: 'set interfaces cellular cell0 traffic control in PLOSS'. Sep 16 14:05:18.177760 osdx OSDxCLI[18614]: User 'admin' added a new cfg line: 'set traffic control PLOSS type network-emulator packet-loss 100'. Sep 16 14:05:18.319840 osdx OSDxCLI[18614]: User 'admin' added a new cfg line: 'show changes'. Sep 16 14:05:18.500443 osdx ubnt-cfgd[19605]: inactive Sep 16 14:05:18.626208 osdx INFO[19616]: FRR daemons did not change Sep 16 14:05:18.704782 osdx (udev-worker)[303]: ifb.cell0: Could not set Alias=, MACAddress=/MACAddressPolicy=, TransmitQueues=, ReceiveQueues=, TransmitQueueLength=, MTUBytes=, GenericSegmentOffloadMaxBytes= or GenericSegmentOffloadMaxSegments=, ignoring: Operation not supported Sep 16 14:05:18.745557 osdx kernel: Mirror/redirect action on Sep 16 14:05:18.757632 osdx kernel: netem: version 1.3 Sep 16 14:05:18.797550 osdx cfgd[4117]: [18614]Completed change to active configuration Sep 16 14:05:18.812285 osdx systemd[1]: osdx-ledsd.service: Sent signal SIGUSR2 to main process 4947 (osdx-ledsd) on client request. Sep 16 14:05:18.812310 osdx osdx-ledsd[4947]: Config changed, checking config paths Sep 16 14:05:18.814917 osdx OSDxCLI[18614]: User 'admin' committed the configuration. Sep 16 14:05:18.853705 osdx OSDxCLI[18614]: User 'admin' left the configuration menu. Sep 16 14:05:20.080482 osdx OSDxCLI[18614]: User 'admin' executed a new command: 'ping 8.8.8.8 count 1 size 56 timeout 1'. Sep 16 14:05:32.098256 osdx wwan-accessibility-control[19502]: [Core/wwan0/1] Warning: Previous packet pending - ID: 19502, Sequence: 5 Sep 16 14:05:32.098271 osdx wwan-accessibility-control[19502]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 1 - interval reduced to 10 seconds Sep 16 14:05:40.426490 osdx OSDxCLI[18614]: User 'admin' executed a new command: 'system journal show | cat'. Sep 16 14:05:41.786483 osdx OSDxCLI[18614]: User 'admin' executed a new command: 'system journal show | cat'. Sep 16 14:05:42.098452 osdx wwan-accessibility-control[19502]: [Core/wwan0/1] Warning: Previous packet pending - ID: 19502, Sequence: 6 Sep 16 14:05:42.098467 osdx wwan-accessibility-control[19502]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 2 - interval reduced to 5 seconds Sep 16 14:05:43.170493 osdx OSDxCLI[18614]: User 'admin' executed a new command: 'system journal show | cat'. Sep 16 14:05:44.598596 osdx OSDxCLI[18614]: User 'admin' executed a new command: 'system journal show | cat'. Sep 16 14:05:46.006489 osdx OSDxCLI[18614]: User 'admin' executed a new command: 'system journal show | cat'. Sep 16 14:05:47.098655 osdx wwan-accessibility-control[19502]: [Core/wwan0/1] Warning: Previous packet pending - ID: 19502, Sequence: 7 Sep 16 14:05:47.098671 osdx wwan-accessibility-control[19502]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 3 - interval reduced to 5 seconds Sep 16 14:05:47.450528 osdx OSDxCLI[18614]: User 'admin' executed a new command: 'system journal show | cat'. Sep 16 14:05:48.898500 osdx OSDxCLI[18614]: User 'admin' executed a new command: 'system journal show | cat'. Sep 16 14:05:50.358506 osdx OSDxCLI[18614]: User 'admin' executed a new command: 'system journal show | cat'. Sep 16 14:05:51.894499 osdx OSDxCLI[18614]: User 'admin' executed a new command: 'system journal show | cat'. Sep 16 14:05:52.098848 osdx wwan-accessibility-control[19502]: [Core/wwan0/1] Warning: Previous packet pending - ID: 19502, Sequence: 8 Sep 16 14:05:52.098862 osdx wwan-accessibility-control[19502]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 4 - interval reduced to 5 seconds Sep 16 14:05:52.108886 osdx WARNING[19714]: [wwan0/1] Requesting reconnection... Sep 16 14:05:52.115419 osdx wwan-cli-socket[19716]: [Device/wwan0] Info: wwan-cli-socket reconnect 60000 wwan0 Sep 16 14:05:52.115818 osdx wwan-module[4983]: [Device/wwan0] Info: Reconnecting device... Sep 16 14:05:52.115830 osdx wwan-module[4983]: [Device/wwan0] Warning: [PDP#1] Requesting reconnection... Sep 16 14:05:52.115884 osdx wwan-module[4983]: [Device/wwan0] Info: WDS[0]: Stopping network connection... Sep 16 14:05:52.245820 osdx wwan-module[4983]: [Device/wwan0] Info: WDS[0]: Network connection was stopped! Sep 16 14:05:52.249704 osdx kernel: net _wwan0: link_state 0x1 -> 0x0 Sep 16 14:05:52.258201 osdx wwan-module[4983]: [Device/wwan0] Info: [PDP#1] Checking registration state... Sep 16 14:05:52.274596 osdx wwan-accessibility-control[19502]: [Core/wwan0/1] Info: Execution stopped Sep 16 14:05:52.274771 osdx systemd[1]: Stopping wwan-accessibility-control@wwan0pdp1.service - WWAN Accessibility Control... Sep 16 14:05:52.276717 osdx systemd[1]: wwan-accessibility-control@wwan0pdp1.service: Deactivated successfully. Sep 16 14:05:52.277101 osdx systemd[1]: Stopped wwan-accessibility-control@wwan0pdp1.service - WWAN Accessibility Control. Sep 16 14:05:52.287284 osdx INFO[19720]: Stop DHCP client for cell0 Sep 16 14:05:52.294157 osdx dhclient[19727]: Killed old client process Sep 16 14:05:52.310015 osdx wwan-module[4983]: [Device/wwan0] Info: [PDP#1] Device registered and PS attached successfully Sep 16 14:05:52.409759 osdx dhclient[19727]: DHCPRELEASE of 37.12.47.87 on cell0 to 37.12.47.88 port 67 Sep 16 14:05:52.598230 osdx wwan-module[4983]: [Device/wwan0] Info: [PDP#1] Establishing network connection... Sep 16 14:05:52.741570 osdx kernel: cell0: (slave _wwan0_1): Releasing backup interface Sep 16 14:05:52.824357 osdx wwan-module[4983]: [Device/wwan0] Info: [PDP#1] Network connection was successfully started: PDH=[3794898000] Sep 16 14:05:52.889582 osdx kernel: net _wwan0: link_state 0x0 -> 0x1 Sep 16 14:05:52.941566 osdx kernel: cell0: (slave _wwan0_1): The slave device specified does not support setting the MAC address Sep 16 14:05:52.941727 osdx kernel: cell0: (slave _wwan0_1): making interface the new active one Sep 16 14:05:52.945638 osdx kernel: cell0: (slave _wwan0_1): Enslaving as an active interface with an up link Sep 16 14:05:52.957262 osdx INFO[19782]: Start DHCP client for cell0 Sep 16 14:05:52.958032 osdx kernel: 8021q: adding VLAN 0 to HW filter on device 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 U2FsdGVkX1+Fn2Jd6rAJPYnYF/5p8thJKfg3TfJzjvI= 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 the command controllers cellular wwan0 pdp 1 show network-data-connection on DUT0 and check whether the 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.13.147.186 IPv4 mask = 255.255.255.252 IPv4 gateway = 37.13.147.185 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 the 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=25.4 ms --- 8.8.8.8 ping statistics --- 1 packets transmitted, 1 received, 0% packet loss, time 0ms rtt min/avg/max/mdev = 25.416/25.416/25.416/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 the command system journal clear on DUT0.
Step 5: Run the command system journal show | cat on DUT0 and check whether the 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
Sep 17 04:43:26.242847 osdx systemd-journald[879964]: Runtime Journal (/run/log/journal/6a66c8bc96ce4f178e17aba81ad62a1f) is 8.2M, max 80.5M, 72.2M free. Sep 17 04:43:26.249861 osdx systemd-journald[879964]: Received client request to rotate journal, rotating. Sep 17 04:43:26.250046 osdx systemd-journald[879964]: Vacuuming done, freed 0B of archived journals from /run/log/journal/6a66c8bc96ce4f178e17aba81ad62a1f. Sep 17 04:43:26.346933 osdx OSDxCLI[1043593]: User 'admin' executed a new command: 'system journal clear'. Sep 17 04:43:30.676799 osdx wwan-accessibility-control[1049000]: [Core/wwan0/1] Warning: Previous packet pending - ID: 424, Sequence: 0 Sep 17 04:43:30.676821 osdx wwan-accessibility-control[1049000]: [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 the command system journal clear on 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 the 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 the command system journal show | cat on DUT0 and check whether the 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
Sep 17 04:44:08.661309 osdx systemd-journald[879964]: Runtime Journal (/run/log/journal/6a66c8bc96ce4f178e17aba81ad62a1f) is 8.0M, max 80.5M, 72.5M free. Sep 17 04:44:08.668502 osdx systemd-journald[879964]: Received client request to rotate journal, rotating. Sep 17 04:44:08.668686 osdx systemd-journald[879964]: Vacuuming done, freed 0B of archived journals from /run/log/journal/6a66c8bc96ce4f178e17aba81ad62a1f. Sep 17 04:44:08.751025 osdx OSDxCLI[1043593]: User 'admin' executed a new command: 'system journal clear'. Sep 17 04:44:08.887005 osdx OSDxCLI[1043593]: User 'admin' entered the configuration menu. Sep 17 04:44:08.991276 osdx OSDxCLI[1043593]: User 'admin' added a new cfg line: 'set interfaces cellular cell0 traffic control in PLOSS'. Sep 17 04:44:09.087500 osdx OSDxCLI[1043593]: User 'admin' added a new cfg line: 'set traffic control PLOSS type network-emulator packet-loss 100'. Sep 17 04:44:09.206121 osdx OSDxCLI[1043593]: User 'admin' added a new cfg line: 'show changes'. Sep 17 04:44:09.355953 osdx ubnt-cfgd[1049105]: inactive Sep 17 04:44:09.490263 osdx INFO[1049116]: FRR daemons did not change Sep 17 04:44:09.563719 osdx (udev-worker)[1049129]: ifb.cell0: Could not set Alias=, MACAddress=/MACAddressPolicy=, TransmitQueues=, ReceiveQueues=, TransmitQueueLength=, MTUBytes=, GenericSegmentOffloadMaxBytes= or GenericSegmentOffloadMaxSegments=, ignoring: Operation not supported Sep 17 04:44:09.563822 osdx (udev-worker)[1049129]: Network interface NamePolicy= disabled on kernel command line. Sep 17 04:44:09.633385 osdx cfgd[1771]: [1043593]Completed change to active configuration Sep 17 04:44:09.654523 osdx systemd[1]: osdx-ledsd.service: Sent signal SIGUSR2 to main process 2818 (osdx-ledsd) on client request. Sep 17 04:44:09.654554 osdx osdx-ledsd[2818]: Config changed, checking config paths Sep 17 04:44:09.658327 osdx OSDxCLI[1043593]: User 'admin' committed the configuration. Sep 17 04:44:09.705228 osdx OSDxCLI[1043593]: User 'admin' left the configuration menu. Sep 17 04:44:10.911762 osdx OSDxCLI[1043593]: User 'admin' executed a new command: 'ping 8.8.8.8 count 1 size 56 timeout 1'. Sep 17 04:44:20.677737 osdx wwan-accessibility-control[1049000]: [Core/wwan0/1] Warning: Previous packet pending - ID: 424, Sequence: 5 Sep 17 04:44:20.677757 osdx wwan-accessibility-control[1049000]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 1 - interval reduced to 10 seconds Sep 17 04:44:30.677988 osdx wwan-accessibility-control[1049000]: [Core/wwan0/1] Warning: Previous packet pending - ID: 424, Sequence: 6 Sep 17 04:44:30.678009 osdx wwan-accessibility-control[1049000]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 2 - interval reduced to 5 seconds Sep 17 04:44:31.280969 osdx OSDxCLI[1043593]: User 'admin' executed a new command: 'system journal show | cat'. Sep 17 04:44:32.648994 osdx OSDxCLI[1043593]: User 'admin' executed a new command: 'system journal show | cat'. Sep 17 04:44:34.052973 osdx OSDxCLI[1043593]: User 'admin' executed a new command: 'system journal show | cat'. Sep 17 04:44:35.440992 osdx OSDxCLI[1043593]: User 'admin' executed a new command: 'system journal show | cat'. Sep 17 04:44:35.678239 osdx wwan-accessibility-control[1049000]: [Core/wwan0/1] Warning: Previous packet pending - ID: 424, Sequence: 7 Sep 17 04:44:35.678259 osdx wwan-accessibility-control[1049000]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 3 - interval reduced to 5 seconds Sep 17 04:44:36.873020 osdx OSDxCLI[1043593]: User 'admin' executed a new command: 'system journal show | cat'. Sep 17 04:44:38.313038 osdx OSDxCLI[1043593]: User 'admin' executed a new command: 'system journal show | cat'. Sep 17 04:44:39.757043 osdx OSDxCLI[1043593]: User 'admin' executed a new command: 'system journal show | cat'. Sep 17 04:44:40.678461 osdx wwan-accessibility-control[1049000]: [Core/wwan0/1] Warning: Previous packet pending - ID: 424, Sequence: 8 Sep 17 04:44:40.678477 osdx wwan-accessibility-control[1049000]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 4 - interval reduced to 5 seconds Sep 17 04:44:40.690502 osdx WARNING[1049206]: [wwan0/1] Requesting reconnection... Sep 17 04:44:40.699609 osdx wwan-cli-socket[1049208]: [Device/wwan0] Info: wwan-cli-socket reconnect 60000 wwan0 Sep 17 04:44:40.700198 osdx wwan-module[2856]: [Device/wwan0] Info: Reconnecting device... Sep 17 04:44:40.700213 osdx wwan-module[2856]: [Device/wwan0] Warning: [PDP#1] Requesting reconnection... Sep 17 04:44:40.700285 osdx wwan-module[2856]: [Device/wwan0] Info: WDS[0]: Stopping network connection... Sep 17 04:44:40.799333 osdx wwan-module[2856]: [Device/wwan0] Info: WDS[0]: Network connection was stopped! Sep 17 04:44:40.803690 osdx kernel: net _wwan0: link_state 0x1 -> 0x0 Sep 17 04:44:40.807568 osdx wwan-module[2856]: [Device/wwan0] Info: [PDP#1] Checking registration state... Sep 17 04:44:40.810633 osdx wwan-module[2856]: [Device/wwan0] Info: [PDP#1] Device registered and PS attached successfully Sep 17 04:44:40.837088 osdx wwan-module[2856]: [Device/wwan0] Info: [PDP#1] Establishing network connection... Sep 17 04:44:40.838727 osdx systemd[1]: Stopping wwan-accessibility-control@wwan0pdp1.service - WWAN Accessibility Control... Sep 17 04:44:40.840108 osdx wwan-accessibility-control[1049000]: [Core/wwan0/1] Info: Execution stopped Sep 17 04:44:40.842438 osdx systemd[1]: wwan-accessibility-control@wwan0pdp1.service: Deactivated successfully. Sep 17 04:44:40.842990 osdx systemd[1]: Stopped wwan-accessibility-control@wwan0pdp1.service - WWAN Accessibility Control. Sep 17 04:44:40.864482 osdx INFO[1049214]: Stop DHCP client for cell0 Sep 17 04:44:40.874960 osdx dhclient[1049224]: Killed old client process
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 U2FsdGVkX1/NGAfNPcheDgOW37hm7PoMQFHa3X5fClg= 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 the command controllers cellular wwan0 pdp 1 show network-data-connection on DUT0 and check whether the 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 = 176.82.177.64 IPv4 mask = 255.255.255.128 IPv4 gateway = 176.82.177.65 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 the 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=24.8 ms --- 8.8.8.8 ping statistics --- 1 packets transmitted, 1 received, 0% packet loss, time 0ms rtt min/avg/max/mdev = 24.787/24.787/24.787/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 the command system journal clear on DUT0.
Step 5: Run the command system journal show | cat on DUT0 and check whether the 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
Sep 16 16:15:06.088297 osdx systemd-journald[2967]: Runtime Journal (/run/log/journal/6a66c8bc96ce4f178e17aba81ad62a1f) is 8.2M, max 80.5M, 72.2M free. Sep 16 16:15:06.096037 osdx systemd-journald[2967]: Received client request to rotate journal, rotating. Sep 16 16:15:06.096237 osdx systemd-journald[2967]: Vacuuming done, freed 0B of archived journals from /run/log/journal/6a66c8bc96ce4f178e17aba81ad62a1f. Sep 16 16:15:06.197733 osdx OSDxCLI[99974]: User 'admin' executed a new command: 'system journal clear'. Sep 16 16:15:07.820170 osdx wwan-accessibility-control[102410]: [Core/wwan0/1] Warning: Previous packet pending - ID: 36874, Sequence: 0 Sep 16 16:15:07.820192 osdx wwan-accessibility-control[102410]: [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 the command system journal clear on 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 the 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 the command system journal show | cat on DUT0 and check whether the 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
Sep 16 16:15:48.557131 osdx systemd-journald[2967]: Runtime Journal (/run/log/journal/6a66c8bc96ce4f178e17aba81ad62a1f) is 8.0M, max 80.5M, 72.5M free. Sep 16 16:15:48.565163 osdx systemd-journald[2967]: Received client request to rotate journal, rotating. Sep 16 16:15:48.565352 osdx systemd-journald[2967]: Vacuuming done, freed 0B of archived journals from /run/log/journal/6a66c8bc96ce4f178e17aba81ad62a1f. Sep 16 16:15:48.649761 osdx OSDxCLI[99974]: User 'admin' executed a new command: 'system journal clear'. Sep 16 16:15:48.823284 osdx OSDxCLI[99974]: User 'admin' entered the configuration menu. Sep 16 16:15:48.965432 osdx OSDxCLI[99974]: User 'admin' added a new cfg line: 'set interfaces cellular cell0 traffic control in PLOSS'. Sep 16 16:15:49.101739 osdx OSDxCLI[99974]: User 'admin' added a new cfg line: 'set traffic control PLOSS type network-emulator packet-loss 100'. Sep 16 16:15:49.233729 osdx OSDxCLI[99974]: User 'admin' added a new cfg line: 'show changes'. Sep 16 16:15:49.404295 osdx ubnt-cfgd[102513]: inactive Sep 16 16:15:49.595003 osdx INFO[102524]: FRR daemons did not change Sep 16 16:15:49.710232 osdx (udev-worker)[102538]: ifb.cell0: Could not set Alias=, MACAddress=/MACAddressPolicy=, TransmitQueues=, ReceiveQueues=, TransmitQueueLength=, MTUBytes=, GenericSegmentOffloadMaxBytes= or GenericSegmentOffloadMaxSegments=, ignoring: Operation not supported Sep 16 16:15:49.710342 osdx (udev-worker)[102538]: Network interface NamePolicy= disabled on kernel command line. Sep 16 16:15:49.774029 osdx kernel: Mirror/redirect action on Sep 16 16:15:49.794042 osdx kernel: netem: version 1.3 Sep 16 16:15:49.851070 osdx cfgd[2599]: [99974]Completed change to active configuration Sep 16 16:15:49.872849 osdx systemd[1]: osdx-ledsd.service: Sent signal SIGUSR2 to main process 3500 (osdx-ledsd) on client request. Sep 16 16:15:49.872899 osdx osdx-ledsd[3500]: Config changed, checking config paths Sep 16 16:15:49.877197 osdx OSDxCLI[99974]: User 'admin' committed the configuration. Sep 16 16:15:49.928166 osdx OSDxCLI[99974]: User 'admin' left the configuration menu. Sep 16 16:15:51.174396 osdx OSDxCLI[99974]: User 'admin' executed a new command: 'ping 8.8.8.8 count 1 size 56 timeout 1'. Sep 16 16:16:07.821354 osdx wwan-accessibility-control[102410]: [Core/wwan0/1] Warning: Previous packet pending - ID: 36874, Sequence: 6 Sep 16 16:16:07.821373 osdx wwan-accessibility-control[102410]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 1 - interval reduced to 10 seconds Sep 16 16:16:11.531373 osdx OSDxCLI[99974]: User 'admin' executed a new command: 'system journal show | cat'. Sep 16 16:16:12.895410 osdx OSDxCLI[99974]: User 'admin' executed a new command: 'system journal show | cat'. Sep 16 16:16:14.259464 osdx OSDxCLI[99974]: User 'admin' executed a new command: 'system journal show | cat'. Sep 16 16:16:15.643482 osdx OSDxCLI[99974]: User 'admin' executed a new command: 'system journal show | cat'. Sep 16 16:16:17.035526 osdx OSDxCLI[99974]: User 'admin' executed a new command: 'system journal show | cat'. Sep 16 16:16:17.821625 osdx wwan-accessibility-control[102410]: [Core/wwan0/1] Warning: Previous packet pending - ID: 36874, Sequence: 7 Sep 16 16:16:17.821643 osdx wwan-accessibility-control[102410]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 2 - interval reduced to 5 seconds Sep 16 16:16:18.463484 osdx OSDxCLI[99974]: User 'admin' executed a new command: 'system journal show | cat'. Sep 16 16:16:19.911490 osdx OSDxCLI[99974]: User 'admin' executed a new command: 'system journal show | cat'. Sep 16 16:16:21.351412 osdx OSDxCLI[99974]: User 'admin' executed a new command: 'system journal show | cat'. Sep 16 16:16:22.819399 osdx OSDxCLI[99974]: User 'admin' executed a new command: 'system journal show | cat'. Sep 16 16:16:22.821835 osdx wwan-accessibility-control[102410]: [Core/wwan0/1] Warning: Previous packet pending - ID: 36874, Sequence: 8 Sep 16 16:16:22.821850 osdx wwan-accessibility-control[102410]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 3 - interval reduced to 5 seconds Sep 16 16:16:24.311390 osdx OSDxCLI[99974]: User 'admin' executed a new command: 'system journal show | cat'. Sep 16 16:16:25.879398 osdx OSDxCLI[99974]: User 'admin' executed a new command: 'system journal show | cat'. Sep 16 16:16:27.403382 osdx OSDxCLI[99974]: User 'admin' executed a new command: 'system journal show | cat'. Sep 16 16:16:27.822090 osdx wwan-accessibility-control[102410]: [Core/wwan0/1] Warning: Previous packet pending - ID: 36874, Sequence: 9 Sep 16 16:16:27.822106 osdx wwan-accessibility-control[102410]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 4 - interval reduced to 5 seconds Sep 16 16:16:27.835400 osdx WARNING[102647]: [wwan0/1] Requesting reconnection... Sep 16 16:16:27.845052 osdx wwan-cli-socket[102649]: [Device/wwan0] Info: wwan-cli-socket reconnect 60000 wwan0 Sep 16 16:16:27.845643 osdx wwan-module[3538]: [Device/wwan0] Info: Reconnecting device... Sep 16 16:16:27.845658 osdx wwan-module[3538]: [Device/wwan0] Warning: [PDP#1] Requesting reconnection... Sep 16 16:16:27.845738 osdx wwan-module[3538]: [Device/wwan0] Info: WDS[0]: Stopping network connection... Sep 16 16:16:27.931074 osdx wwan-module[3538]: [Device/wwan0] Info: WDS[0]: Network connection was stopped! Sep 16 16:16:27.938048 osdx kernel: net _wwan0: link_state 0x1 -> 0x0 Sep 16 16:16:27.942870 osdx wwan-module[3538]: [Device/wwan0] Info: [PDP#1] Checking registration state... Sep 16 16:16:27.972480 osdx wwan-accessibility-control[102410]: [Core/wwan0/1] Info: Execution stopped Sep 16 16:16:27.972869 osdx systemd[1]: Stopping wwan-accessibility-control@wwan0pdp1.service - WWAN Accessibility Control... Sep 16 16:16:27.976123 osdx systemd[1]: wwan-accessibility-control@wwan0pdp1.service: Deactivated successfully. Sep 16 16:16:27.976657 osdx systemd[1]: Stopped wwan-accessibility-control@wwan0pdp1.service - WWAN Accessibility Control. Sep 16 16:16:27.993233 osdx INFO[102653]: Stop DHCP client for cell0 Sep 16 16:16:27.995072 osdx wwan-module[3538]: [Device/wwan0] Info: [PDP#1] Device registered and PS attached successfully Sep 16 16:16:28.004015 osdx dhclient[102660]: Killed old client process Sep 16 16:16:28.126351 osdx dhclient[102660]: DHCPRELEASE of 176.82.177.64 on cell0 to 176.82.177.65 port 67 Sep 16 16:16:28.315275 osdx wwan-module[3538]: [Device/wwan0] Info: [PDP#1] Establishing network connection...