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+LP7yfQVPCf0JGVH56Hw9aXU9Puztp4TY= 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 = 37.12.27.245 IPv4 mask = 255.255.255.252 IPv4 gateway = 37.12.27.246 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=156 ms --- 8.8.8.8 ping statistics --- 1 packets transmitted, 1 received, 0% packet loss, time 0ms rtt min/avg/max/mdev = 156.163/156.163/156.163/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
May 14 13:48:18.941911 osdx systemd-journald[2365]: Runtime Journal (/run/log/journal/2ff9a722e66347bbb77e671cb607c8ee) is 8.0M, max 80.5M, 72.5M free. May 14 13:48:18.948893 osdx systemd-journald[2365]: Received client request to rotate journal, rotating. May 14 13:48:18.949077 osdx systemd-journald[2365]: Vacuuming done, freed 0B of archived journals from /run/log/journal/2ff9a722e66347bbb77e671cb607c8ee. May 14 13:48:19.034514 osdx OSDxCLI[519076]: User 'admin' executed a new command: 'system journal clear'. May 14 13:48:27.914770 osdx wwan-accessibility-control[523401]: [Core/wwan0/1] Warning: Previous packet pending - ID: 64649, Sequence: 0 May 14 13:48:27.914792 osdx wwan-accessibility-control[523401]: [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
May 14 13:49:01.353545 osdx systemd-journald[2365]: Runtime Journal (/run/log/journal/2ff9a722e66347bbb77e671cb607c8ee) is 8.0M, max 80.5M, 72.5M free. May 14 13:49:01.360650 osdx systemd-journald[2365]: Received client request to rotate journal, rotating. May 14 13:49:01.360832 osdx systemd-journald[2365]: Vacuuming done, freed 0B of archived journals from /run/log/journal/2ff9a722e66347bbb77e671cb607c8ee. May 14 13:49:01.442467 osdx OSDxCLI[519076]: User 'admin' executed a new command: 'system journal clear'. May 14 13:49:01.574109 osdx OSDxCLI[519076]: User 'admin' entered the configuration menu. May 14 13:49:01.671646 osdx OSDxCLI[519076]: User 'admin' added a new cfg line: 'set interfaces cellular cell0 traffic control in PLOSS'. May 14 13:49:01.762777 osdx OSDxCLI[519076]: User 'admin' added a new cfg line: 'set traffic control PLOSS type network-emulator packet-loss 100'. May 14 13:49:01.877611 osdx OSDxCLI[519076]: User 'admin' added a new cfg line: 'show changes'. May 14 13:49:02.027613 osdx ubnt-cfgd[523491]: inactive May 14 13:49:02.162258 osdx INFO[523502]: FRR daemons did not change May 14 13:49:02.251018 osdx (udev-worker)[523517]: ifb.cell0: Could not set Alias=, MACAddress=/MACAddressPolicy=, TransmitQueues=, ReceiveQueues=, TransmitQueueLength=, MTUBytes=, GenericSegmentOffloadMaxBytes= or GenericSegmentOffloadMaxSegments=, ignoring: Operation not supported May 14 13:49:02.251182 osdx (udev-worker)[523517]: Network interface NamePolicy= disabled on kernel command line. May 14 13:49:02.297839 osdx cfgd[2045]: [519076]Completed change to active configuration May 14 13:49:02.319092 osdx systemd[1]: osdx-ledsd.service: Sent signal SIGUSR2 to main process 2699 (osdx-ledsd) on client request. May 14 13:49:02.319135 osdx osdx-ledsd[2699]: Config changed, checking config paths May 14 13:49:02.322932 osdx OSDxCLI[519076]: User 'admin' committed the configuration. May 14 13:49:02.368573 osdx OSDxCLI[519076]: User 'admin' left the configuration menu. May 14 13:49:03.575210 osdx OSDxCLI[519076]: User 'admin' executed a new command: 'ping 8.8.8.8 count 1 size 56 timeout 1'. May 14 13:49:17.915863 osdx wwan-accessibility-control[523401]: [Core/wwan0/1] Warning: Previous packet pending - ID: 64649, Sequence: 5 May 14 13:49:17.915881 osdx wwan-accessibility-control[523401]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 1 - interval reduced to 10 seconds May 14 13:49:23.916429 osdx OSDxCLI[519076]: User 'admin' executed a new command: 'system journal show | cat'. May 14 13:49:25.264438 osdx OSDxCLI[519076]: User 'admin' executed a new command: 'system journal show | cat'. May 14 13:49:26.628431 osdx OSDxCLI[519076]: User 'admin' executed a new command: 'system journal show | cat'. May 14 13:49:27.916089 osdx wwan-accessibility-control[523401]: [Core/wwan0/1] Warning: Previous packet pending - ID: 64649, Sequence: 6 May 14 13:49:27.916108 osdx wwan-accessibility-control[523401]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 2 - interval reduced to 5 seconds May 14 13:49:27.992388 osdx OSDxCLI[519076]: User 'admin' executed a new command: 'system journal show | cat'. May 14 13:49:29.384422 osdx OSDxCLI[519076]: User 'admin' executed a new command: 'system journal show | cat'. May 14 13:49:30.792415 osdx OSDxCLI[519076]: User 'admin' executed a new command: 'system journal show | cat'. May 14 13:49:32.204432 osdx OSDxCLI[519076]: User 'admin' executed a new command: 'system journal show | cat'. May 14 13:49:32.916360 osdx wwan-accessibility-control[523401]: [Core/wwan0/1] Warning: Previous packet pending - ID: 64649, Sequence: 7 May 14 13:49:32.916376 osdx wwan-accessibility-control[523401]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 3 - interval reduced to 5 seconds May 14 13:49:33.660439 osdx OSDxCLI[519076]: User 'admin' executed a new command: 'system journal show | cat'. May 14 13:49:35.120433 osdx OSDxCLI[519076]: User 'admin' executed a new command: 'system journal show | cat'. May 14 13:49:36.616445 osdx OSDxCLI[519076]: User 'admin' executed a new command: 'system journal show | cat'. May 14 13:49:37.916627 osdx wwan-accessibility-control[523401]: [Core/wwan0/1] Warning: Previous packet pending - ID: 64649, Sequence: 8 May 14 13:49:37.916646 osdx wwan-accessibility-control[523401]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 4 - interval reduced to 5 seconds May 14 13:49:37.929064 osdx WARNING[523610]: [wwan0/1] Requesting reconnection... May 14 13:49:37.938343 osdx wwan-cli-socket[523612]: [Device/wwan0] Info: wwan-cli-socket reconnect 60000 wwan0 May 14 13:49:37.938896 osdx wwan-module[519061]: [Device/wwan0] Info: Reconnecting device... May 14 13:49:37.938912 osdx wwan-module[519061]: [Device/wwan0] Warning: [PDP#1] Requesting reconnection... May 14 13:49:37.938983 osdx wwan-module[519061]: [Device/wwan0] Info: WDS[0]: Stopping network connection... May 14 13:49:38.069291 osdx wwan-module[519061]: [Device/wwan0] Info: WDS[0]: Network connection was stopped! May 14 13:49:38.075153 osdx kernel: net _wwan0: link_state 0x1 -> 0x0 May 14 13:49:38.078409 osdx wwan-module[519061]: [Device/wwan0] Info: [PDP#1] Checking registration state... May 14 13:49:38.096593 osdx OSDxCLI[519076]: User 'admin' executed a new command: 'system journal show | cat'. May 14 13:49:38.109615 osdx wwan-accessibility-control[523401]: [Core/wwan0/1] Info: Execution stopped May 14 13:49:38.110080 osdx systemd[1]: Stopping wwan-accessibility-control@wwan0pdp1.service - WWAN Accessibility Control... May 14 13:49:38.113266 osdx systemd[1]: wwan-accessibility-control@wwan0pdp1.service: Deactivated successfully. May 14 13:49:38.113767 osdx systemd[1]: Stopped wwan-accessibility-control@wwan0pdp1.service - WWAN Accessibility Control. May 14 13:49:38.130289 osdx INFO[523618]: Stop DHCP client for cell0 May 14 13:49:38.144279 osdx dhclient[523623]: Killed old client process May 14 13:49:38.197320 osdx wwan-module[519061]: [Device/wwan0] Info: [PDP#1] Device registered and PS attached successfully May 14 13:49:38.197339 osdx wwan-module[519061]: [Device/wwan0] Info: [PDP#1] Establishing network connection... May 14 13:49:38.275367 osdx dhclient[523623]: DHCPRELEASE of 37.12.27.245 on cell0 to 37.12.27.246 port 67 May 14 13:49:38.456625 osdx wwan-module[519061]: [Device/wwan0] Info: [PDP#1] Network connection was successfully started: PDH=[4243820752] May 14 13:49:38.583108 osdx kernel: net _wwan0: link_state 0x0 -> 0x1 May 14 13:49:38.799108 osdx kernel: cell0: (slave _wwan0_1): Releasing backup interface May 14 13:49:39.015138 osdx kernel: cell0: (slave _wwan0_1): The slave device specified does not support setting the MAC address May 14 13:49:39.019106 osdx kernel: cell0: (slave _wwan0_1): making interface the new active one May 14 13:49:39.019293 osdx kernel: cell0: (slave _wwan0_1): Enslaving as an active interface with an up link May 14 13:49:39.035375 osdx kernel: 8021q: adding VLAN 0 to HW filter on device cell0 May 14 13:49:39.039313 osdx INFO[523673]: 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 U2FsdGVkX1+VEPGBoDckt7UdCKhLaVk0IWjF1IRiLaI= 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.12.213 IPv4 mask = 255.255.255.252 IPv4 gateway = 37.12.12.214 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=145 ms --- 8.8.8.8 ping statistics --- 1 packets transmitted, 1 received, 0% packet loss, time 0ms rtt min/avg/max/mdev = 145.101/145.101/145.101/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
May 12 23:43:33.233889 osdx systemd-journald[2488]: Runtime Journal (/run/log/journal/6722bf9e6bef4767b24a20b95807067f) is 8.0M, max 69.4M, 61.4M free. May 12 23:43:33.235374 osdx systemd-journald[2488]: Received client request to rotate journal, rotating. May 12 23:43:33.235427 osdx systemd-journald[2488]: Vacuuming done, freed 0B of archived journals from /run/log/journal/6722bf9e6bef4767b24a20b95807067f. May 12 23:43:33.288354 osdx OSDxCLI[97895]: User 'admin' executed a new command: 'system journal clear'. May 12 23:43:42.396443 osdx wwan-accessibility-control[98731]: [Core/wwan0/1] Warning: Previous packet pending - ID: 33195, Sequence: 0 May 12 23:43:42.396451 osdx wwan-accessibility-control[98731]: [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
May 12 23:44:15.517279 osdx systemd-journald[2488]: Runtime Journal (/run/log/journal/6722bf9e6bef4767b24a20b95807067f) is 8.0M, max 69.4M, 61.4M free. May 12 23:44:15.519207 osdx systemd-journald[2488]: Received client request to rotate journal, rotating. May 12 23:44:15.519281 osdx systemd-journald[2488]: Vacuuming done, freed 0B of archived journals from /run/log/journal/6722bf9e6bef4767b24a20b95807067f. May 12 23:44:15.572365 osdx OSDxCLI[97895]: User 'admin' executed a new command: 'system journal clear'. May 12 23:44:15.685878 osdx OSDxCLI[97895]: User 'admin' entered the configuration menu. May 12 23:44:15.771955 osdx OSDxCLI[97895]: User 'admin' added a new cfg line: 'set interfaces cellular cell0 traffic control in PLOSS'. May 12 23:44:15.853879 osdx OSDxCLI[97895]: User 'admin' added a new cfg line: 'set traffic control PLOSS type network-emulator packet-loss 100'. May 12 23:44:15.970174 osdx OSDxCLI[97895]: User 'admin' added a new cfg line: 'show changes'. May 12 23:44:16.054857 osdx ubnt-cfgd[98822]: inactive May 12 23:44:16.097464 osdx INFO[98833]: FRR daemons did not change May 12 23:44:16.120168 osdx (udev-worker)[98846]: ifb.cell0: Could not set Alias=, MACAddress=/MACAddressPolicy=, TransmitQueues=, ReceiveQueues=, TransmitQueueLength=, MTUBytes=, GenericSegmentOffloadMaxBytes= or GenericSegmentOffloadMaxSegments=, ignoring: Operation not supported May 12 23:44:16.120201 osdx (udev-worker)[98846]: Network interface NamePolicy= disabled on kernel command line. May 12 23:44:16.133850 osdx cfgd[2107]: [97895]Completed change to active configuration May 12 23:44:16.134469 osdx OSDxCLI[97895]: User 'admin' committed the configuration. May 12 23:44:16.168796 osdx OSDxCLI[97895]: User 'admin' left the configuration menu. May 12 23:44:17.308456 osdx OSDxCLI[97895]: User 'admin' executed a new command: 'ping 8.8.8.8 count 1 size 56 timeout 1'. May 12 23:44:32.397157 osdx wwan-accessibility-control[98731]: [Core/wwan0/1] Warning: Previous packet pending - ID: 33195, Sequence: 5 May 12 23:44:32.397162 osdx wwan-accessibility-control[98731]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 1 - interval reduced to 10 seconds May 12 23:44:37.583639 osdx OSDxCLI[97895]: User 'admin' executed a new command: 'system journal show | cat'. May 12 23:44:38.871636 osdx OSDxCLI[97895]: User 'admin' executed a new command: 'system journal show | cat'. May 12 23:44:40.159628 osdx OSDxCLI[97895]: User 'admin' executed a new command: 'system journal show | cat'. May 12 23:44:41.455636 osdx OSDxCLI[97895]: User 'admin' executed a new command: 'system journal show | cat'. May 12 23:44:42.397274 osdx wwan-accessibility-control[98731]: [Core/wwan0/1] Warning: Previous packet pending - ID: 33195, Sequence: 6 May 12 23:44:42.397279 osdx wwan-accessibility-control[98731]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 2 - interval reduced to 5 seconds May 12 23:44:42.795640 osdx OSDxCLI[97895]: User 'admin' executed a new command: 'system journal show | cat'. May 12 23:44:44.143645 osdx OSDxCLI[97895]: User 'admin' executed a new command: 'system journal show | cat'. May 12 23:44:45.507647 osdx OSDxCLI[97895]: User 'admin' executed a new command: 'system journal show | cat'. May 12 23:44:46.875635 osdx OSDxCLI[97895]: User 'admin' executed a new command: 'system journal show | cat'. May 12 23:44:47.397433 osdx wwan-accessibility-control[98731]: [Core/wwan0/1] Warning: Previous packet pending - ID: 33195, Sequence: 7 May 12 23:44:47.397438 osdx wwan-accessibility-control[98731]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 3 - interval reduced to 5 seconds May 12 23:44:48.307643 osdx OSDxCLI[97895]: User 'admin' executed a new command: 'system journal show | cat'. May 12 23:44:49.723641 osdx OSDxCLI[97895]: User 'admin' executed a new command: 'system journal show | cat'. May 12 23:44:51.211624 osdx OSDxCLI[97895]: User 'admin' executed a new command: 'system journal show | cat'. May 12 23:44:52.397606 osdx wwan-accessibility-control[98731]: [Core/wwan0/1] Warning: Previous packet pending - ID: 33195, Sequence: 8 May 12 23:44:52.397612 osdx wwan-accessibility-control[98731]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 4 - interval reduced to 5 seconds May 12 23:44:52.401390 osdx WARNING[98943]: [wwan0/1] Requesting reconnection... May 12 23:44:52.404208 osdx wwan-cli-socket[98945]: [Device/wwan0] Info: wwan-cli-socket reconnect 60000 wwan0 May 12 23:44:52.404471 osdx wwan-module[3921]: [Device/wwan0] Info: Reconnecting device... May 12 23:44:52.404478 osdx wwan-module[3921]: [Device/wwan0] Warning: [PDP#1] Requesting reconnection... May 12 23:44:52.404507 osdx wwan-module[3921]: [Device/wwan0] Info: WDS[0]: Stopping network connection... May 12 23:44:52.530854 osdx wwan-module[3921]: [Device/wwan0] Info: WDS[0]: Network connection was stopped! May 12 23:44:52.535208 osdx kernel: net _wwan0: link_state 0x1 -> 0x0 May 12 23:44:52.536288 osdx wwan-module[3921]: [Device/wwan0] Info: [PDP#1] Checking registration state... May 12 23:44:52.541781 osdx systemd[1]: Stopping wwan-accessibility-control@wwan0pdp1.service - WWAN Accessibility Control... May 12 23:44:52.541819 osdx wwan-accessibility-control[98731]: [Core/wwan0/1] Info: Execution stopped May 12 23:44:52.542527 osdx systemd[1]: wwan-accessibility-control@wwan0pdp1.service: Deactivated successfully. May 12 23:44:52.542683 osdx systemd[1]: Stopped wwan-accessibility-control@wwan0pdp1.service - WWAN Accessibility Control. May 12 23:44:52.546464 osdx INFO[98949]: Stop DHCP client for cell0 May 12 23:44:52.549561 osdx dhclient[98956]: Killed old client process May 12 23:44:52.594807 osdx wwan-module[3921]: [Device/wwan0] Info: [PDP#1] Device registered and PS attached successfully May 12 23:44:52.594813 osdx wwan-module[3921]: [Device/wwan0] Info: [PDP#1] Establishing network connection... May 12 23:44:52.643637 osdx OSDxCLI[97895]: User 'admin' executed a new command: 'system journal show | cat'. May 12 23:44:52.671341 osdx dhclient[98956]: DHCPRELEASE of 37.12.12.213 on cell0 to 37.12.12.214 port 67 May 12 23:44:52.819678 osdx wwan-module[3921]: [Device/wwan0] Info: [PDP#1] Network connection was successfully started: PDH=[3799249216] May 12 23:44:52.827228 osdx kernel: cell0: (slave _wwan0_1): Releasing backup interface May 12 23:44:52.883206 osdx kernel: net _wwan0: link_state 0x0 -> 0x1 May 12 23:44:52.899207 osdx kernel: cell0: (slave _wwan0_1): The slave device specified does not support setting the MAC address May 12 23:44:52.899273 osdx kernel: cell0: (slave _wwan0_1): making interface the new active one May 12 23:44:52.899290 osdx kernel: cell0: (slave _wwan0_1): Enslaving as an active interface with an up link May 12 23:44:52.903223 osdx kernel: 8021q: adding VLAN 0 to HW filter on device cell0 May 12 23:44:52.903969 osdx INFO[99012]: Start DHCP client for cell0 May 12 23:44:53.079390 osdx dhclient[99025]: DHCPDISCOVER on cell0 to 255.255.255.255 port 67 interval 4 May 12 23:44:53.081906 osdx dhclient[99025]: DHCPOFFER of 5.205.193.32 from 5.205.193.33 May 12 23:44:53.081929 osdx dhclient[99025]: DHCPREQUEST for 5.205.193.32 on cell0 to 255.255.255.255 port 67 May 12 23:44:53.083830 osdx dhclient[99025]: DHCPACK of 5.205.193.32 from 5.205.193.33 May 12 23:44:53.123645 osdx systemd[1]: Started wwan-accessibility-control@wwan0pdp1.service - WWAN Accessibility Control. May 12 23:44:53.127587 osdx wwan-accessibility-control[99037]: [Core/wwan0/1] Info: Starting '/osdx/sbin/wwan-accessibility-control'... May 12 23:44:53.190446 osdx dhclient[99025]: bound to 5.205.193.32 -- renewal in 3559 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 U2FsdGVkX19micqgFHTNPFIJz2GAw1O07o6cP65B02k= 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.4.145 IPv4 mask = 255.255.255.252 IPv4 gateway = 37.12.4.146 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=37.5 ms --- 8.8.8.8 ping statistics --- 1 packets transmitted, 1 received, 0% packet loss, time 0ms rtt min/avg/max/mdev = 37.525/37.525/37.525/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
May 14 07:24:31.555002 osdx systemd-journald[4453]: Runtime Journal (/run/log/journal/2ff9a722e66347bbb77e671cb607c8ee) is 8.0M, max 80.3M, 72.3M free. May 14 07:24:31.560062 osdx systemd-journald[4453]: Received client request to rotate journal, rotating. May 14 07:24:31.560170 osdx systemd-journald[4453]: Vacuuming done, freed 0B of archived journals from /run/log/journal/2ff9a722e66347bbb77e671cb607c8ee. May 14 07:24:31.632893 osdx OSDxCLI[72133]: User 'admin' executed a new command: 'system journal clear'. May 14 07:24:31.914014 osdx wwan-accessibility-control[73027]: [Core/wwan0/1] Warning: Previous packet pending - ID: 7491, Sequence: 0 May 14 07:24:31.914029 osdx wwan-accessibility-control[73027]: [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
May 14 07:25:13.978647 osdx systemd-journald[4453]: Runtime Journal (/run/log/journal/2ff9a722e66347bbb77e671cb607c8ee) is 8.0M, max 80.3M, 72.3M free. May 14 07:25:13.983507 osdx systemd-journald[4453]: Received client request to rotate journal, rotating. May 14 07:25:13.983617 osdx systemd-journald[4453]: Vacuuming done, freed 0B of archived journals from /run/log/journal/2ff9a722e66347bbb77e671cb607c8ee. May 14 07:25:14.056835 osdx OSDxCLI[72133]: User 'admin' executed a new command: 'system journal clear'. May 14 07:25:14.220154 osdx OSDxCLI[72133]: User 'admin' entered the configuration menu. May 14 07:25:14.326824 osdx OSDxCLI[72133]: User 'admin' added a new cfg line: 'set interfaces cellular cell0 traffic control in PLOSS'. May 14 07:25:14.445224 osdx OSDxCLI[72133]: User 'admin' added a new cfg line: 'set traffic control PLOSS type network-emulator packet-loss 100'. May 14 07:25:14.555645 osdx OSDxCLI[72133]: User 'admin' added a new cfg line: 'show changes'. May 14 07:25:14.692184 osdx ubnt-cfgd[73124]: inactive May 14 07:25:14.796273 osdx INFO[73135]: FRR daemons did not change May 14 07:25:14.846957 osdx (udev-worker)[311]: ifb.cell0: Could not set Alias=, MACAddress=/MACAddressPolicy=, TransmitQueues=, ReceiveQueues=, TransmitQueueLength=, MTUBytes=, GenericSegmentOffloadMaxBytes= or GenericSegmentOffloadMaxSegments=, ignoring: Operation not supported May 14 07:25:14.878453 osdx kernel: netem: version 1.3 May 14 07:25:14.912634 osdx cfgd[4127]: [72133]Completed change to active configuration May 14 07:25:14.926964 osdx systemd[1]: osdx-ledsd.service: Sent signal SIGUSR2 to main process 4933 (osdx-ledsd) on client request. May 14 07:25:14.926989 osdx osdx-ledsd[4933]: Config changed, checking config paths May 14 07:25:14.929456 osdx OSDxCLI[72133]: User 'admin' committed the configuration. May 14 07:25:14.974489 osdx OSDxCLI[72133]: User 'admin' left the configuration menu. May 14 07:25:16.181370 osdx OSDxCLI[72133]: User 'admin' executed a new command: 'ping 8.8.8.8 count 1 size 56 timeout 1'. May 14 07:25:31.914860 osdx wwan-accessibility-control[73027]: [Core/wwan0/1] Warning: Previous packet pending - ID: 7491, Sequence: 6 May 14 07:25:31.914875 osdx wwan-accessibility-control[73027]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 1 - interval reduced to 10 seconds May 14 07:25:36.531347 osdx OSDxCLI[72133]: User 'admin' executed a new command: 'system journal show | cat'. May 14 07:25:37.887364 osdx OSDxCLI[72133]: User 'admin' executed a new command: 'system journal show | cat'. May 14 07:25:39.235371 osdx OSDxCLI[72133]: User 'admin' executed a new command: 'system journal show | cat'. May 14 07:25:40.615353 osdx OSDxCLI[72133]: User 'admin' executed a new command: 'system journal show | cat'. May 14 07:25:41.915048 osdx wwan-accessibility-control[73027]: [Core/wwan0/1] Warning: Previous packet pending - ID: 7491, Sequence: 7 May 14 07:25:41.915063 osdx wwan-accessibility-control[73027]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 2 - interval reduced to 5 seconds May 14 07:25:41.995374 osdx OSDxCLI[72133]: User 'admin' executed a new command: 'system journal show | cat'. May 14 07:25:43.411358 osdx OSDxCLI[72133]: User 'admin' executed a new command: 'system journal show | cat'. May 14 07:25:44.823366 osdx OSDxCLI[72133]: User 'admin' executed a new command: 'system journal show | cat'. May 14 07:25:46.243350 osdx OSDxCLI[72133]: User 'admin' executed a new command: 'system journal show | cat'. May 14 07:25:46.915230 osdx wwan-accessibility-control[73027]: [Core/wwan0/1] Warning: Previous packet pending - ID: 7491, Sequence: 8 May 14 07:25:46.915244 osdx wwan-accessibility-control[73027]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 3 - interval reduced to 5 seconds May 14 07:25:47.699355 osdx OSDxCLI[72133]: User 'admin' executed a new command: 'system journal show | cat'. May 14 07:25:49.167356 osdx OSDxCLI[72133]: User 'admin' executed a new command: 'system journal show | cat'. May 14 07:25:50.643366 osdx OSDxCLI[72133]: User 'admin' executed a new command: 'system journal show | cat'. May 14 07:25:51.915412 osdx wwan-accessibility-control[73027]: [Core/wwan0/1] Warning: Previous packet pending - ID: 7491, Sequence: 9 May 14 07:25:51.915426 osdx wwan-accessibility-control[73027]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 4 - interval reduced to 5 seconds May 14 07:25:51.925835 osdx WARNING[73247]: [wwan0/1] Requesting reconnection... May 14 07:25:51.932425 osdx wwan-cli-socket[73249]: [Device/wwan0] Info: wwan-cli-socket reconnect 60000 wwan0 May 14 07:25:51.932812 osdx wwan-module[4967]: [Device/wwan0] Info: Reconnecting device... May 14 07:25:51.932825 osdx wwan-module[4967]: [Device/wwan0] Warning: [PDP#1] Requesting reconnection... May 14 07:25:51.932876 osdx wwan-module[4967]: [Device/wwan0] Info: WDS[0]: Stopping network connection... May 14 07:25:52.042123 osdx wwan-module[4967]: [Device/wwan0] Info: WDS[0]: Network connection was stopped! May 14 07:25:52.046443 osdx kernel: net _wwan0: link_state 0x1 -> 0x0 May 14 07:25:52.049960 osdx wwan-module[4967]: [Device/wwan0] Info: [PDP#1] Checking registration state... May 14 07:25:52.070633 osdx wwan-accessibility-control[73027]: [Core/wwan0/1] Info: Execution stopped May 14 07:25:52.070753 osdx systemd[1]: Stopping wwan-accessibility-control@wwan0pdp1.service - WWAN Accessibility Control... May 14 07:25:52.072723 osdx systemd[1]: wwan-accessibility-control@wwan0pdp1.service: Deactivated successfully. May 14 07:25:52.073116 osdx systemd[1]: Stopped wwan-accessibility-control@wwan0pdp1.service - WWAN Accessibility Control. May 14 07:25:52.083179 osdx INFO[73253]: Stop DHCP client for cell0 May 14 07:25:52.090016 osdx dhclient[73260]: Killed old client process May 14 07:25:52.106049 osdx wwan-module[4967]: [Device/wwan0] Info: [PDP#1] Device registered and PS attached successfully May 14 07:25:52.106064 osdx wwan-module[4967]: [Device/wwan0] Info: [PDP#1] Establishing network connection... May 14 07:25:52.135370 osdx OSDxCLI[72133]: User 'admin' executed a new command: 'system journal show | cat'. May 14 07:25:52.222658 osdx dhclient[73260]: DHCPRELEASE of 37.12.4.145 on cell0 to 37.12.4.146 port 67 May 14 07:25:52.331878 osdx wwan-module[4967]: [Device/wwan0] Info: [PDP#1] Network connection was successfully started: PDH=[3799283680] May 14 07:25:52.398441 osdx kernel: net _wwan0: link_state 0x0 -> 0x1 May 14 07:25:52.554435 osdx kernel: cell0: (slave _wwan0_1): Releasing backup interface May 14 07:25:52.734452 osdx kernel: cell0: (slave _wwan0_1): The slave device specified does not support setting the MAC address May 14 07:25:52.738435 osdx kernel: cell0: (slave _wwan0_1): making interface the new active one May 14 07:25:52.738554 osdx kernel: cell0: (slave _wwan0_1): Enslaving as an active interface with an up link May 14 07:25:52.750445 osdx kernel: 8021q: adding VLAN 0 to HW filter on device cell0 May 14 07:25:52.750536 osdx INFO[73310]: Start DHCP client for cell0 May 14 07:25:53.090730 osdx dhclient[73327]: DHCPDISCOVER on cell0 to 255.255.255.255 port 67 interval 5 May 14 07:25:53.093169 osdx dhclient[73327]: DHCPOFFER of 88.31.116.149 from 88.31.116.150 May 14 07:25:53.093222 osdx dhclient[73327]: DHCPREQUEST for 88.31.116.149 on cell0 to 255.255.255.255 port 67 May 14 07:25:53.095438 osdx dhclient[73327]: DHCPACK of 88.31.116.149 from 88.31.116.150 May 14 07:25:53.139851 osdx systemd[1]: Started wwan-accessibility-control@wwan0pdp1.service - WWAN Accessibility Control. May 14 07:25:53.152802 osdx wwan-accessibility-control[73339]: [Core/wwan0/1] Info: Starting '/osdx/sbin/wwan-accessibility-control'...
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/VyjMQmA8LDFeDXvfcFTEZ5MCuFX2+AoU= 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 = 81.47.67.172 IPv4 mask = 255.255.255.248 IPv4 gateway = 81.47.67.173 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=178 ms --- 8.8.8.8 ping statistics --- 1 packets transmitted, 1 received, 0% packet loss, time 0ms rtt min/avg/max/mdev = 178.301/178.301/178.301/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
May 18 11:18:30.189156 osdx systemd-journald[621701]: Runtime Journal (/run/log/journal/2ff9a722e66347bbb77e671cb607c8ee) is 8.2M, max 80.5M, 72.2M free. May 18 11:18:30.196494 osdx systemd-journald[621701]: Received client request to rotate journal, rotating. May 18 11:18:30.196682 osdx systemd-journald[621701]: Vacuuming done, freed 0B of archived journals from /run/log/journal/2ff9a722e66347bbb77e671cb607c8ee. May 18 11:18:30.296537 osdx OSDxCLI[825810]: User 'admin' executed a new command: 'system journal clear'. May 18 11:18:39.147069 osdx wwan-accessibility-control[831075]: [Core/wwan0/1] Warning: Previous packet pending - ID: 44643, Sequence: 0 May 18 11:18:39.147092 osdx wwan-accessibility-control[831075]: [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
May 18 11:19:12.628901 osdx systemd-journald[621701]: Runtime Journal (/run/log/journal/2ff9a722e66347bbb77e671cb607c8ee) is 8.0M, max 80.5M, 72.5M free. May 18 11:19:12.636130 osdx systemd-journald[621701]: Received client request to rotate journal, rotating. May 18 11:19:12.636316 osdx systemd-journald[621701]: Vacuuming done, freed 0B of archived journals from /run/log/journal/2ff9a722e66347bbb77e671cb607c8ee. May 18 11:19:12.720615 osdx OSDxCLI[825810]: User 'admin' executed a new command: 'system journal clear'. May 18 11:19:12.864505 osdx OSDxCLI[825810]: User 'admin' entered the configuration menu. May 18 11:19:12.967582 osdx OSDxCLI[825810]: User 'admin' added a new cfg line: 'set interfaces cellular cell0 traffic control in PLOSS'. May 18 11:19:13.061314 osdx OSDxCLI[825810]: User 'admin' added a new cfg line: 'set traffic control PLOSS type network-emulator packet-loss 100'. May 18 11:19:13.174995 osdx OSDxCLI[825810]: User 'admin' added a new cfg line: 'show changes'. May 18 11:19:13.325559 osdx ubnt-cfgd[831166]: inactive May 18 11:19:13.480558 osdx INFO[831177]: FRR daemons did not change May 18 11:19:13.557909 osdx (udev-worker)[831190]: ifb.cell0: Could not set Alias=, MACAddress=/MACAddressPolicy=, TransmitQueues=, ReceiveQueues=, TransmitQueueLength=, MTUBytes=, GenericSegmentOffloadMaxBytes= or GenericSegmentOffloadMaxSegments=, ignoring: Operation not supported May 18 11:19:13.558020 osdx (udev-worker)[831190]: Network interface NamePolicy= disabled on kernel command line. May 18 11:19:13.623715 osdx cfgd[2603]: [825810]Completed change to active configuration May 18 11:19:13.644787 osdx systemd[1]: osdx-ledsd.service: Sent signal SIGUSR2 to main process 3480 (osdx-ledsd) on client request. May 18 11:19:13.644830 osdx osdx-ledsd[3480]: Config changed, checking config paths May 18 11:19:13.649276 osdx OSDxCLI[825810]: User 'admin' committed the configuration. May 18 11:19:13.690846 osdx OSDxCLI[825810]: User 'admin' left the configuration menu. May 18 11:19:14.909443 osdx OSDxCLI[825810]: User 'admin' executed a new command: 'ping 8.8.8.8 count 1 size 56 timeout 1'. May 18 11:19:29.148311 osdx wwan-accessibility-control[831075]: [Core/wwan0/1] Warning: Previous packet pending - ID: 44643, Sequence: 5 May 18 11:19:29.148330 osdx wwan-accessibility-control[831075]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 1 - interval reduced to 10 seconds May 18 11:19:35.250521 osdx OSDxCLI[825810]: User 'admin' executed a new command: 'system journal show | cat'. May 18 11:19:36.590514 osdx OSDxCLI[825810]: User 'admin' executed a new command: 'system journal show | cat'. May 18 11:19:37.942491 osdx OSDxCLI[825810]: User 'admin' executed a new command: 'system journal show | cat'. May 18 11:19:39.148600 osdx wwan-accessibility-control[831075]: [Core/wwan0/1] Warning: Previous packet pending - ID: 44643, Sequence: 6 May 18 11:19:39.148621 osdx wwan-accessibility-control[831075]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 2 - interval reduced to 5 seconds May 18 11:19:39.298468 osdx OSDxCLI[825810]: User 'admin' executed a new command: 'system journal show | cat'. May 18 11:19:40.698511 osdx OSDxCLI[825810]: User 'admin' executed a new command: 'system journal show | cat'. May 18 11:19:42.106503 osdx OSDxCLI[825810]: User 'admin' executed a new command: 'system journal show | cat'. May 18 11:19:43.522459 osdx OSDxCLI[825810]: User 'admin' executed a new command: 'system journal show | cat'. May 18 11:19:44.148929 osdx wwan-accessibility-control[831075]: [Core/wwan0/1] Warning: Previous packet pending - ID: 44643, Sequence: 7 May 18 11:19:44.148949 osdx wwan-accessibility-control[831075]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 3 - interval reduced to 5 seconds May 18 11:19:44.986527 osdx OSDxCLI[825810]: User 'admin' executed a new command: 'system journal show | cat'. May 18 11:19:46.450463 osdx OSDxCLI[825810]: User 'admin' executed a new command: 'system journal show | cat'. May 18 11:19:47.934520 osdx OSDxCLI[825810]: User 'admin' executed a new command: 'system journal show | cat'. May 18 11:19:49.149229 osdx wwan-accessibility-control[831075]: [Core/wwan0/1] Warning: Previous packet pending - ID: 44643, Sequence: 8 May 18 11:19:49.149258 osdx wwan-accessibility-control[831075]: [Core/wwan0/1] Warning: Connection in failure - consecutive failures: 4 - interval reduced to 5 seconds May 18 11:19:49.162416 osdx WARNING[831282]: [wwan0/1] Requesting reconnection... May 18 11:19:49.171895 osdx wwan-cli-socket[831284]: [Device/wwan0] Info: wwan-cli-socket reconnect 60000 wwan0 May 18 11:19:49.172485 osdx wwan-module[3513]: [Device/wwan0] Info: Reconnecting device... May 18 11:19:49.172502 osdx wwan-module[3513]: [Device/wwan0] Warning: [PDP#1] Requesting reconnection... May 18 11:19:49.172579 osdx wwan-module[3513]: [Device/wwan0] Info: WDS[0]: Stopping network connection... May 18 11:19:49.295519 osdx wwan-module[3513]: [Device/wwan0] Info: WDS[0]: Network connection was stopped! May 18 11:19:49.301190 osdx kernel: net _wwan0: link_state 0x1 -> 0x0 May 18 11:19:49.307052 osdx wwan-module[3513]: [Device/wwan0] Info: [PDP#1] Checking registration state... May 18 11:19:49.335529 osdx wwan-accessibility-control[831075]: [Core/wwan0/1] Info: Execution stopped May 18 11:19:49.336287 osdx systemd[1]: Stopping wwan-accessibility-control@wwan0pdp1.service - WWAN Accessibility Control... May 18 11:19:49.339248 osdx systemd[1]: wwan-accessibility-control@wwan0pdp1.service: Deactivated successfully. May 18 11:19:49.339798 osdx systemd[1]: Stopped wwan-accessibility-control@wwan0pdp1.service - WWAN Accessibility Control. May 18 11:19:49.357164 osdx INFO[831288]: Stop DHCP client for cell0 May 18 11:19:49.359469 osdx wwan-module[3513]: [Device/wwan0] Info: [PDP#1] Device registered and PS attached successfully May 18 11:19:49.359489 osdx wwan-module[3513]: [Device/wwan0] Info: [PDP#1] Establishing network connection... May 18 11:19:49.367312 osdx dhclient[831295]: Killed old client process May 18 11:19:49.434476 osdx OSDxCLI[825810]: User 'admin' executed a new command: 'system journal show | cat'. May 18 11:19:49.489430 osdx dhclient[831295]: DHCPRELEASE of 81.47.67.172 on cell0 to 81.47.67.173 port 67 May 18 11:19:49.587090 osdx wwan-module[3513]: [Device/wwan0] Info: [PDP#1] Network connection was successfully started: PDH=[3799225808] May 18 11:19:49.649159 osdx kernel: net _wwan0: link_state 0x0 -> 0x1 May 18 11:19:50.061159 osdx kernel: cell0: (slave _wwan0_1): Releasing backup interface May 18 11:19:50.293284 osdx kernel: cell0: (slave _wwan0_1): The slave device specified does not support setting the MAC address May 18 11:19:50.297155 osdx kernel: cell0: (slave _wwan0_1): making interface the new active one May 18 11:19:50.297369 osdx kernel: cell0: (slave _wwan0_1): Enslaving as an active interface with an up link May 18 11:19:50.317188 osdx kernel: 8021q: adding VLAN 0 to HW filter on device cell0 May 18 11:19:50.317747 osdx INFO[831345]: Start DHCP client for cell0