Hyunsun Moon | db72b8f | 2020-11-02 18:03:39 -0800 | [diff] [blame] | 1 | #!/usr/bin/env python3 |
Hyunsun Moon | 53097ea | 2020-09-04 17:20:29 -0700 | [diff] [blame] | 2 | |
| 3 | # Copyright 2020-present Open Networking Foundation |
| 4 | # |
Hyunsun Moon | 5cd1eec | 2021-04-02 22:33:42 -0700 | [diff] [blame] | 5 | # SPDX-License-Identifier: LicenseRef-ONF-Member-Only-1.0 |
Hyunsun Moon | 53097ea | 2020-09-04 17:20:29 -0700 | [diff] [blame] | 6 | |
| 7 | import sys |
| 8 | import os |
| 9 | import json |
| 10 | import logging |
| 11 | import enum |
Jeremy Ronquillo | 8d10865 | 2021-11-22 17:34:58 -0800 | [diff] [blame] | 12 | import pycurl |
Hyunsun Moon | 53097ea | 2020-09-04 17:20:29 -0700 | [diff] [blame] | 13 | import time |
| 14 | import serial |
Jeremy Ronquillo | d996b51 | 2021-02-13 13:45:47 -0800 | [diff] [blame] | 15 | import subprocess |
Jeremy Ronquillo | ef17e36 | 2021-11-08 10:56:42 -0800 | [diff] [blame] | 16 | import time |
Hyunsun Moon | 53097ea | 2020-09-04 17:20:29 -0700 | [diff] [blame] | 17 | from collections import namedtuple |
Jeremy Ronquillo | e0a8b42 | 2021-11-02 12:49:15 -0700 | [diff] [blame] | 18 | from statistics import median |
Jeremy Ronquillo | c45955a | 2021-11-09 12:04:57 -0800 | [diff] [blame] | 19 | import xml.etree.ElementTree as ET |
Hyunsun Moon | 53097ea | 2020-09-04 17:20:29 -0700 | [diff] [blame] | 20 | |
| 21 | ''' |
Jeremy Ronquillo | a944fbc | 2021-03-30 10:57:45 -0700 | [diff] [blame] | 22 | "Simple" script that checks Aether network operational status periodically |
Hyunsun Moon | 53097ea | 2020-09-04 17:20:29 -0700 | [diff] [blame] | 23 | by controlling the attached 4G/LTE modem with AT commands and |
| 24 | report the result to the central monitoring server. |
| 25 | ''' |
| 26 | |
Shad Ansari | 341a1c9 | 2022-03-02 09:14:40 -0800 | [diff] [blame] | 27 | USE_MODEM_CMDS = False |
| 28 | |
Jeremy Ronquillo | 6e352b7 | 2021-06-08 10:33:25 -0700 | [diff] [blame] | 29 | # Parse config with backwards compatibility with config.json pre 0.6.6 |
| 30 | config_file_contents = open(os.getenv('CONFIG_FILE', "./config.json")).read() |
| 31 | config_file_contents = config_file_contents.replace("user_plane_ping_test", "dns") |
| 32 | config_file_contents = config_file_contents.replace("speedtest_iperf", "iperf_server") |
Shad Ansari | 416ccab | 2022-03-09 19:06:43 -0800 | [diff] [blame^] | 33 | config_file_contents = config_file_contents.replace("\"speedtest_ping_dns\": \"8.8.8.8\",", "") |
| 34 | # replace 1.1.1.1 with 8.8.8.8 |
| 35 | config_file_contents = config_file_contents.replace("\"1.1.1.1\": \"8.8.8.8\",", "") |
Hyunsun Moon | 53097ea | 2020-09-04 17:20:29 -0700 | [diff] [blame] | 36 | CONF = json.loads( |
Jeremy Ronquillo | 6e352b7 | 2021-06-08 10:33:25 -0700 | [diff] [blame] | 37 | config_file_contents, object_hook=lambda d: namedtuple('X', d.keys())(*d.values()) |
Hyunsun Moon | 53097ea | 2020-09-04 17:20:29 -0700 | [diff] [blame] | 38 | ) |
| 39 | |
| 40 | logging.basicConfig( |
| 41 | filename=CONF.log_file, |
| 42 | format='%(asctime)s [%(levelname)s] %(message)s', |
Hyunsun Moon | 5cd1eec | 2021-04-02 22:33:42 -0700 | [diff] [blame] | 43 | level=logging.getLevelName(CONF.log_level) |
Hyunsun Moon | 53097ea | 2020-09-04 17:20:29 -0700 | [diff] [blame] | 44 | ) |
| 45 | |
Hyunsun Moon | 53097ea | 2020-09-04 17:20:29 -0700 | [diff] [blame] | 46 | |
| 47 | class State(enum.Enum): |
| 48 | error = "-1" |
| 49 | disconnected = "0" |
| 50 | connected = "1" |
| 51 | |
| 52 | @classmethod |
| 53 | def has_value(cls, value): |
| 54 | return value in cls._value2member_map_ |
| 55 | |
| 56 | |
| 57 | class Modem(): |
| 58 | log = logging.getLogger('aether_edge_monitoring.Modem') |
| 59 | |
| 60 | read_timeout = 0.1 |
| 61 | |
| 62 | def __init__(self, port, baudrate): |
| 63 | self.port = port |
| 64 | self.baudrate = baudrate |
| 65 | self._response = None |
| 66 | |
Don Newton | bd91ae2 | 2021-05-11 14:58:18 -0700 | [diff] [blame] | 67 | def get_modem_port(self): |
| 68 | cmd = "ls " + CONF.modem.port |
| 69 | sp = subprocess.Popen(cmd,shell=True,stdout=subprocess.PIPE, |
| 70 | stderr=subprocess.PIPE, universal_newlines=True) |
| 71 | rc = sp.wait() |
| 72 | ret,err = sp.communicate() |
| 73 | if err != "" : |
Shad Ansari | b234ff8 | 2022-02-17 22:14:35 -0800 | [diff] [blame] | 74 | self.log.error("unable to find serial port " + err) |
Don Newton | bd91ae2 | 2021-05-11 14:58:18 -0700 | [diff] [blame] | 75 | |
| 76 | ret = ret.replace(CONF.modem.port,"").strip() |
Shad Ansari | b234ff8 | 2022-02-17 22:14:35 -0800 | [diff] [blame] | 77 | self.log.info("Modem.get_modem_port found " + ret) |
Don Newton | bd91ae2 | 2021-05-11 14:58:18 -0700 | [diff] [blame] | 78 | return ret |
| 79 | |
Hyunsun Moon | 53097ea | 2020-09-04 17:20:29 -0700 | [diff] [blame] | 80 | def connect(self): |
Don Newton | bd91ae2 | 2021-05-11 14:58:18 -0700 | [diff] [blame] | 81 | self.port=self.get_modem_port() |
Shad Ansari | b234ff8 | 2022-02-17 22:14:35 -0800 | [diff] [blame] | 82 | self.log.info("modem.connect Port: %s, BaudRate: %i",self.port,self.baudrate) |
Hyunsun Moon | 53097ea | 2020-09-04 17:20:29 -0700 | [diff] [blame] | 83 | self.serial = serial.Serial( |
| 84 | port=self.port, |
| 85 | baudrate=self.baudrate, |
| 86 | timeout=1) |
| 87 | |
| 88 | def _write(self, command): |
| 89 | if self.serial.inWaiting() > 0: |
| 90 | self.serial.flushInput() |
| 91 | |
| 92 | self._response = b"" |
| 93 | |
| 94 | self.serial.write(bytearray(command + "\r", "ascii")) |
| 95 | read = self.serial.inWaiting() |
| 96 | while True: |
Shad Ansari | b234ff8 | 2022-02-17 22:14:35 -0800 | [diff] [blame] | 97 | self.log.debug("Waiting for write to complete...") |
Hyunsun Moon | 53097ea | 2020-09-04 17:20:29 -0700 | [diff] [blame] | 98 | if read > 0: |
| 99 | self._response += self.serial.read(read) |
| 100 | else: |
| 101 | time.sleep(self.read_timeout) |
| 102 | read = self.serial.inWaiting() |
| 103 | if read == 0: |
| 104 | break |
Shad Ansari | b234ff8 | 2022-02-17 22:14:35 -0800 | [diff] [blame] | 105 | self.log.debug("Write complete...") |
Hyunsun Moon | 53097ea | 2020-09-04 17:20:29 -0700 | [diff] [blame] | 106 | return self._response.decode("ascii").replace('\r\n', ' ') |
| 107 | |
| 108 | def write(self, command, wait_resp=True): |
| 109 | response = self._write(command) |
| 110 | self.log.debug("%s: %s", command, response) |
| 111 | |
| 112 | if wait_resp and "ERROR" in response: |
| 113 | return False, None |
| 114 | return True, response |
| 115 | |
Hyunsun Moon | 5cd1eec | 2021-04-02 22:33:42 -0700 | [diff] [blame] | 116 | def get_state(self): |
Hyunsun Moon | 53097ea | 2020-09-04 17:20:29 -0700 | [diff] [blame] | 117 | success, result = self.write('AT+CGATT?') |
| 118 | if not success or 'CGATT:' not in result: |
| 119 | return State.error |
| 120 | state = result.split('CGATT:')[1].split(' ')[0] |
| 121 | return State(state) |
| 122 | |
| 123 | def close(self): |
| 124 | self.serial.close() |
| 125 | |
| 126 | |
Shad Ansari | b234ff8 | 2022-02-17 22:14:35 -0800 | [diff] [blame] | 127 | def get_control_plane_state(modem, dongle_stats=None): |
Shad Ansari | 341a1c9 | 2022-03-02 09:14:40 -0800 | [diff] [blame] | 128 | if not modem and dongle_stats: |
| 129 | if dongle_stats and dongle_stats['Connection'] == 'Connected': |
| 130 | return State.connected |
| 131 | else: |
| 132 | return State.disconnected |
Shad Ansari | b234ff8 | 2022-02-17 22:14:35 -0800 | [diff] [blame] | 133 | |
Hyunsun Moon | 5cd1eec | 2021-04-02 22:33:42 -0700 | [diff] [blame] | 134 | # Disable radio fuction |
Hyunsun Moon | 53097ea | 2020-09-04 17:20:29 -0700 | [diff] [blame] | 135 | # "echo" works more stable than serial for this action |
Hyunsun Moon | 5cd1eec | 2021-04-02 22:33:42 -0700 | [diff] [blame] | 136 | try: |
Don Newton | bd91ae2 | 2021-05-11 14:58:18 -0700 | [diff] [blame] | 137 | logging.debug("echo 'AT+CFUN=0' > " + modem.port) |
Hyunsun Moon | 5cd1eec | 2021-04-02 22:33:42 -0700 | [diff] [blame] | 138 | subprocess.check_output( |
Don Newton | bd91ae2 | 2021-05-11 14:58:18 -0700 | [diff] [blame] | 139 | "echo 'AT+CFUN=0' > " + modem.port, shell=True) |
Hyunsun Moon | 5cd1eec | 2021-04-02 22:33:42 -0700 | [diff] [blame] | 140 | except subprocess.CalledProcessError as e: |
| 141 | logging.error("Write 'AT+CFUN=0' failed") |
| 142 | return State.error |
Hyunsun Moon | 53097ea | 2020-09-04 17:20:29 -0700 | [diff] [blame] | 143 | |
| 144 | # Wait until the modem is fully disconnected |
| 145 | retry = 0 |
| 146 | state = None |
Hyunsun Moon | 5cd1eec | 2021-04-02 22:33:42 -0700 | [diff] [blame] | 147 | while retry < CONF.detach_timeout: |
| 148 | state = modem.get_state() |
Hyunsun Moon | 53097ea | 2020-09-04 17:20:29 -0700 | [diff] [blame] | 149 | if state is State.disconnected: |
| 150 | break |
| 151 | time.sleep(1) |
| 152 | retry += 1 |
| 153 | |
Hyunsun Moon | 53097ea | 2020-09-04 17:20:29 -0700 | [diff] [blame] | 154 | if state is not State.disconnected: |
Hyunsun Moon | 5cd1eec | 2021-04-02 22:33:42 -0700 | [diff] [blame] | 155 | logging.error("Failed to disconnect") |
| 156 | return State.error |
Hyunsun Moon | 53097ea | 2020-09-04 17:20:29 -0700 | [diff] [blame] | 157 | |
| 158 | time.sleep(2) |
Hyunsun Moon | 5cd1eec | 2021-04-02 22:33:42 -0700 | [diff] [blame] | 159 | # Enable radio function |
Hyunsun Moon | 53097ea | 2020-09-04 17:20:29 -0700 | [diff] [blame] | 160 | # "echo" works more stable than serial for this action |
Hyunsun Moon | 5cd1eec | 2021-04-02 22:33:42 -0700 | [diff] [blame] | 161 | try: |
Don Newton | bd91ae2 | 2021-05-11 14:58:18 -0700 | [diff] [blame] | 162 | logging.debug("echo 'AT+CFUN=1' > " + modem.port) |
Hyunsun Moon | 5cd1eec | 2021-04-02 22:33:42 -0700 | [diff] [blame] | 163 | subprocess.check_output( |
Don Newton | bd91ae2 | 2021-05-11 14:58:18 -0700 | [diff] [blame] | 164 | "echo 'AT+CFUN=1' > " + modem.port, shell=True) |
Hyunsun Moon | 5cd1eec | 2021-04-02 22:33:42 -0700 | [diff] [blame] | 165 | except subprocess.CalledProcessError as e: |
| 166 | logging.error("Write 'AT+CFUN=1' failed") |
| 167 | return State.error |
Hyunsun Moon | 53097ea | 2020-09-04 17:20:29 -0700 | [diff] [blame] | 168 | |
Hyunsun Moon | 5cd1eec | 2021-04-02 22:33:42 -0700 | [diff] [blame] | 169 | # Wait attach_timeout sec for the modem to be fully connected |
Hyunsun Moon | 53097ea | 2020-09-04 17:20:29 -0700 | [diff] [blame] | 170 | retry = 0 |
Hyunsun Moon | 5cd1eec | 2021-04-02 22:33:42 -0700 | [diff] [blame] | 171 | while retry < CONF.attach_timeout: |
| 172 | state = modem.get_state() |
Hyunsun Moon | 53097ea | 2020-09-04 17:20:29 -0700 | [diff] [blame] | 173 | if state is State.connected: |
| 174 | break |
| 175 | time.sleep(1) |
| 176 | retry += 1 |
| 177 | # CGATT sometimes returns None |
| 178 | if state is State.error: |
| 179 | state = State.disconnected |
| 180 | |
Hyunsun Moon | 5cd1eec | 2021-04-02 22:33:42 -0700 | [diff] [blame] | 181 | return state |
Hyunsun Moon | 53097ea | 2020-09-04 17:20:29 -0700 | [diff] [blame] | 182 | |
| 183 | |
Shad Ansari | 341a1c9 | 2022-03-02 09:14:40 -0800 | [diff] [blame] | 184 | def get_user_plane_state(): |
Jeremy Ronquillo | 56d23b1 | 2021-12-02 14:57:42 -0800 | [diff] [blame] | 185 | if "dry_run" in CONF.ips._fields and CONF.ips.dry_run: # run dry_run latency test as user plane test |
Shad Ansari | b3d5475 | 2022-02-28 12:32:58 -0800 | [diff] [blame] | 186 | dry_run_latency, dry_run_passed = run_ping_test(CONF.ips.dry_run, 10) |
Jeremy Ronquillo | 56d23b1 | 2021-12-02 14:57:42 -0800 | [diff] [blame] | 187 | if dry_run_passed: |
| 188 | return State.connected, dry_run_latency |
| 189 | else: |
Shad Ansari | 416ccab | 2022-03-09 19:06:43 -0800 | [diff] [blame^] | 190 | logging.warning("Ping failed: {}".format(CONF.ips.dry_run)) |
Jeremy Ronquillo | 56d23b1 | 2021-12-02 14:57:42 -0800 | [diff] [blame] | 191 | return State.disconnected, dry_run_latency |
| 192 | else: # run default user plane test |
| 193 | try: |
| 194 | subprocess.check_output( |
| 195 | "ping -c 3 " + CONF.ips.dns + ">/dev/null 2>&1", |
| 196 | shell=True) |
| 197 | return State.connected, None |
| 198 | except subprocess.CalledProcessError as e: |
Shad Ansari | 416ccab | 2022-03-09 19:06:43 -0800 | [diff] [blame^] | 199 | logging.warning("Ping failed: {}".format(CONF.ips.dns)) |
Jeremy Ronquillo | 56d23b1 | 2021-12-02 14:57:42 -0800 | [diff] [blame] | 200 | return State.disconnected, None |
Hyunsun Moon | 53097ea | 2020-09-04 17:20:29 -0700 | [diff] [blame] | 201 | |
| 202 | |
Jeremy Ronquillo | d996b51 | 2021-02-13 13:45:47 -0800 | [diff] [blame] | 203 | def run_ping_test(ip, count): |
| 204 | ''' |
| 205 | Runs the ping test |
| 206 | Input: IP to ping, # times to ping |
Jeremy Ronquillo | e0a8b42 | 2021-11-02 12:49:15 -0700 | [diff] [blame] | 207 | Returns: Transmitted packets |
| 208 | Received packets |
| 209 | Median ping ms |
| 210 | Min ping ms |
| 211 | Avg ping ms |
| 212 | Max ping ms |
| 213 | Std Dev ping ms |
Jeremy Ronquillo | d996b51 | 2021-02-13 13:45:47 -0800 | [diff] [blame] | 214 | ''' |
Jeremy Ronquillo | e0a8b42 | 2021-11-02 12:49:15 -0700 | [diff] [blame] | 215 | result = {'transmitted': 0, |
| 216 | 'received': 0, |
| 217 | 'median': 0.0, |
| 218 | 'min': 0.0, |
Jeremy Ronquillo | a944fbc | 2021-03-30 10:57:45 -0700 | [diff] [blame] | 219 | 'avg': 0.0, |
| 220 | 'max': 0.0, |
| 221 | 'stddev': 0.0} |
Jeremy Ronquillo | 6e352b7 | 2021-06-08 10:33:25 -0700 | [diff] [blame] | 222 | if not ip: |
Jeremy Ronquillo | 115c5e3 | 2021-09-30 11:15:56 -0700 | [diff] [blame] | 223 | return result, True |
Jeremy Ronquillo | d996b51 | 2021-02-13 13:45:47 -0800 | [diff] [blame] | 224 | try: |
Jeremy Ronquillo | e0a8b42 | 2021-11-02 12:49:15 -0700 | [diff] [blame] | 225 | pingOutput = subprocess.check_output( |
| 226 | "ping -c " + str(count) + " " + \ |
| 227 | ip, shell=True).decode("UTF-8").split() |
| 228 | result['transmitted'] = int(pingOutput[-15]) |
| 229 | result['received'] = int(pingOutput[-12]) |
| 230 | if result['received'] > 0: |
| 231 | pingValues = [] |
| 232 | |
| 233 | # Hack for getting all ping values for median |
| 234 | for word in pingOutput: |
| 235 | if "time=" in word: |
| 236 | pingValues.append(float(word.split("=")[1])) |
| 237 | result['median'] = round(median(pingValues), 3) |
| 238 | |
| 239 | pingResult = pingOutput[-2].split('/') |
| 240 | result['min'] = float(pingResult[0]) |
| 241 | result['avg'] = float(pingResult[1]) |
| 242 | result['max'] = float(pingResult[2]) |
| 243 | result['stddev'] = float(pingResult[3]) |
| 244 | else: |
| 245 | logging.error("No packets received during ping " + ip) |
| 246 | return result, False |
Jeremy Ronquillo | d996b51 | 2021-02-13 13:45:47 -0800 | [diff] [blame] | 247 | except Exception as e: |
| 248 | logging.error("Ping test failed for " + ip + ": %s", e) |
Jeremy Ronquillo | 115c5e3 | 2021-09-30 11:15:56 -0700 | [diff] [blame] | 249 | return result, False |
| 250 | return result, True |
Jeremy Ronquillo | d996b51 | 2021-02-13 13:45:47 -0800 | [diff] [blame] | 251 | |
| 252 | |
Jeremy Ronquillo | 56d23b1 | 2021-12-02 14:57:42 -0800 | [diff] [blame] | 253 | def get_ping_test(modem, dry_run_latency=None): |
Jeremy Ronquillo | d996b51 | 2021-02-13 13:45:47 -0800 | [diff] [blame] | 254 | ''' |
Jeremy Ronquillo | 677c883 | 2021-04-06 13:53:36 -0700 | [diff] [blame] | 255 | Prepares the ping test. |
Jeremy Ronquillo | e0a8b42 | 2021-11-02 12:49:15 -0700 | [diff] [blame] | 256 | Runs ping tests from 'ips' entry in config.json in order. |
Jeremy Ronquillo | 56d23b1 | 2021-12-02 14:57:42 -0800 | [diff] [blame] | 257 | Note: 'dry_run' is not run here; it is run during the user plane test. |
Jeremy Ronquillo | d996b51 | 2021-02-13 13:45:47 -0800 | [diff] [blame] | 258 | ''' |
| 259 | speedtest_ping = {} |
Jeremy Ronquillo | 115c5e3 | 2021-09-30 11:15:56 -0700 | [diff] [blame] | 260 | status = True |
| 261 | ping_test_passed = True |
Jeremy Ronquillo | 6e352b7 | 2021-06-08 10:33:25 -0700 | [diff] [blame] | 262 | |
Jeremy Ronquillo | 56d23b1 | 2021-12-02 14:57:42 -0800 | [diff] [blame] | 263 | if dry_run_latency: |
| 264 | speedtest_ping["dry_run"] = dry_run_latency |
| 265 | |
Jeremy Ronquillo | 6e352b7 | 2021-06-08 10:33:25 -0700 | [diff] [blame] | 266 | for i in range(0, len(CONF.ips)): |
Jeremy Ronquillo | 56d23b1 | 2021-12-02 14:57:42 -0800 | [diff] [blame] | 267 | if CONF.ips._fields[i] == "dry_run": |
| 268 | continue |
Shad Ansari | b3d5475 | 2022-02-28 12:32:58 -0800 | [diff] [blame] | 269 | count = 10 |
Jeremy Ronquillo | e0a8b42 | 2021-11-02 12:49:15 -0700 | [diff] [blame] | 270 | speedtest_ping[CONF.ips._fields[i]], status = run_ping_test(CONF.ips[i], count) |
Jeremy Ronquillo | 115c5e3 | 2021-09-30 11:15:56 -0700 | [diff] [blame] | 271 | if not status: |
| 272 | ping_test_passed = False |
| 273 | logging.error("Ping test failed. Not running further tests.") |
| 274 | return speedtest_ping, ping_test_passed |
Jeremy Ronquillo | d996b51 | 2021-02-13 13:45:47 -0800 | [diff] [blame] | 275 | |
Jeremy Ronquillo | 677c883 | 2021-04-06 13:53:36 -0700 | [diff] [blame] | 276 | def run_iperf_test(ip, port, time_duration, is_downlink): |
| 277 | ''' |
| 278 | Runs iperf test to specified IP in the config file. |
| 279 | - Runs for 10 seconds (10 iterations) |
| 280 | - Retrieves downlink and uplink test results from json output |
| 281 | ''' |
| 282 | result = 0.0 |
Jeremy Ronquillo | c03ba68 | 2021-10-06 10:27:09 -0700 | [diff] [blame] | 283 | if not ip or port == 0: |
Jeremy Ronquillo | 677c883 | 2021-04-06 13:53:36 -0700 | [diff] [blame] | 284 | return result |
Jeremy Ronquillo | 115c5e3 | 2021-09-30 11:15:56 -0700 | [diff] [blame] | 285 | maxRetries = 2 |
Jeremy Ronquillo | 79c3e67 | 2021-09-03 12:54:55 -0700 | [diff] [blame] | 286 | err = None |
Jeremy Ronquillo | 012ac66 | 2021-08-06 12:13:43 -0700 | [diff] [blame] | 287 | for _ in range(0, maxRetries): |
| 288 | try: |
| 289 | iperfResult = json.loads(subprocess.check_output( |
| 290 | "iperf3 -c " + ip + |
| 291 | " -p " + str(port) + |
| 292 | " -t " + str(time_duration) + |
| 293 | (" -R " if is_downlink else "") + |
| 294 | " --json", shell=True).decode("UTF-8")) |
| 295 | received_mbps = iperfResult['end']['sum_received']['bits_per_second'] / 1000000 |
| 296 | sent_mbps = iperfResult['end']['sum_sent']['bits_per_second'] / 1000000.0 |
| 297 | result = received_mbps if is_downlink else sent_mbps |
| 298 | return result |
| 299 | except Exception as e: |
Jeremy Ronquillo | 79c3e67 | 2021-09-03 12:54:55 -0700 | [diff] [blame] | 300 | err = e |
Jeremy Ronquillo | 012ac66 | 2021-08-06 12:13:43 -0700 | [diff] [blame] | 301 | time.sleep(5) |
| 302 | pass |
Jeremy Ronquillo | 79c3e67 | 2021-09-03 12:54:55 -0700 | [diff] [blame] | 303 | logging.error("After " + str(maxRetries) + " retries, iperf test failed for " + ip + ": %s", err) |
Jeremy Ronquillo | 677c883 | 2021-04-06 13:53:36 -0700 | [diff] [blame] | 304 | return result |
| 305 | |
| 306 | |
| 307 | def get_iperf_test(modem): |
| 308 | ''' |
| 309 | Prepares the iperf test. |
| 310 | ''' |
Jeremy Ronquillo | ef17e36 | 2021-11-08 10:56:42 -0800 | [diff] [blame] | 311 | global hour_iperf_scheduled_time_last_ran |
Jeremy Ronquillo | 677c883 | 2021-04-06 13:53:36 -0700 | [diff] [blame] | 312 | speedtest_iperf = {} |
| 313 | speedtest_iperf['cluster'] = {} |
Jeremy Ronquillo | ef17e36 | 2021-11-08 10:56:42 -0800 | [diff] [blame] | 314 | |
| 315 | if "iperf_schedule" in CONF._fields and len(CONF.iperf_schedule) > 0: |
| 316 | if int(time.strftime("%H")) not in CONF.iperf_schedule: # not in the schedule |
| 317 | hour_iperf_scheduled_time_last_ran = -1 |
| 318 | return None |
| 319 | elif int(time.strftime("%H")) == hour_iperf_scheduled_time_last_ran: # already ran this hour |
| 320 | return None |
| 321 | hour_iperf_scheduled_time_last_ran = int(time.strftime("%H")) |
| 322 | |
Jeremy Ronquillo | 6e352b7 | 2021-06-08 10:33:25 -0700 | [diff] [blame] | 323 | speedtest_iperf['cluster']['downlink'] = run_iperf_test(CONF.ips.iperf_server, CONF.iperf_port, 10, True) |
| 324 | speedtest_iperf['cluster']['uplink'] = run_iperf_test(CONF.ips.iperf_server, CONF.iperf_port, 10, False) |
Jeremy Ronquillo | 677c883 | 2021-04-06 13:53:36 -0700 | [diff] [blame] | 325 | |
| 326 | return speedtest_iperf |
| 327 | |
Jeremy Ronquillo | d996b51 | 2021-02-13 13:45:47 -0800 | [diff] [blame] | 328 | |
Shad Ansari | b234ff8 | 2022-02-17 22:14:35 -0800 | [diff] [blame] | 329 | def get_signal_quality(modem, dongle_stats=None): |
Shad Ansari | 341a1c9 | 2022-03-02 09:14:40 -0800 | [diff] [blame] | 330 | if not modem and dongle_stats: |
| 331 | if dongle_stats['RSRQ'] != '' and dongle_stats['RSRP'] != '': |
| 332 | rsrq = int((float(dongle_stats['RSRQ']) + 19.5) * 2) |
| 333 | rsrp = int(float(dongle_stats['RSRP']) + 140) |
| 334 | return {'rsrq': rsrq, 'rsrp': rsrp} |
| 335 | else: |
| 336 | return {'rsrq': 0, 'rsrp': 0} |
| 337 | |
| 338 | # Fall back to modem cmds |
Shad Ansari | b234ff8 | 2022-02-17 22:14:35 -0800 | [diff] [blame] | 339 | |
Hyunsun Moon | 5cd1eec | 2021-04-02 22:33:42 -0700 | [diff] [blame] | 340 | success, result = modem.write('AT+CESQ') |
Don Newton | bd91ae2 | 2021-05-11 14:58:18 -0700 | [diff] [blame] | 341 | logging.debug("get_signal_quality success %i result %s",success,result) |
Hyunsun Moon | 5cd1eec | 2021-04-02 22:33:42 -0700 | [diff] [blame] | 342 | if not success or 'CESQ: ' not in result: |
| 343 | logging.error("Failed to get signal quality") |
Don Newton | bd91ae2 | 2021-05-11 14:58:18 -0700 | [diff] [blame] | 344 | return {'rsrq':0, 'rsrp':0} |
Hyunsun Moon | 5cd1eec | 2021-04-02 22:33:42 -0700 | [diff] [blame] | 345 | |
| 346 | logging.debug("%s", result) |
| 347 | tmp_rsrq = result.split('CESQ:')[1].split(',')[4] |
| 348 | tmp_rsrp = result.split('CESQ:')[1].split(',')[5] |
| 349 | |
| 350 | rsrq = int(tmp_rsrq.strip()) |
| 351 | rsrp = int(tmp_rsrp.strip().split(' ')[0]) |
| 352 | result = { |
| 353 | 'rsrq': 0 if rsrq is 255 else rsrq, |
| 354 | 'rsrp': 0 if rsrp is 255 else rsrp |
| 355 | } |
| 356 | |
| 357 | return result |
| 358 | |
Shad Ansari | b234ff8 | 2022-02-17 22:14:35 -0800 | [diff] [blame] | 359 | |
| 360 | def get_dongle_stats(): |
Jeremy Ronquillo | c45955a | 2021-11-09 12:04:57 -0800 | [diff] [blame] | 361 | result = {'SuccessfulFetch' : False} |
Jeremy Ronquillo | 56d23b1 | 2021-12-02 14:57:42 -0800 | [diff] [blame] | 362 | if "report_in_band" in CONF._fields: |
| 363 | result['inBandReporting'] = CONF.report_in_band |
| 364 | else: |
| 365 | result['inBandReporting'] = False |
Jeremy Ronquillo | c45955a | 2021-11-09 12:04:57 -0800 | [diff] [blame] | 366 | XMLkeys = ["MAC", |
| 367 | "PLMNStatus", |
| 368 | "UICCStatus", |
| 369 | "IMEI", |
| 370 | "IMSI", |
| 371 | "PLMNSelected", |
| 372 | "MCC", |
| 373 | "MNC", |
| 374 | "PhyCellID", |
| 375 | "CellGlobalID", |
| 376 | "Band", |
| 377 | "EARFCN", |
| 378 | "BandWidth", |
Shad Ansari | b234ff8 | 2022-02-17 22:14:35 -0800 | [diff] [blame] | 379 | "RSRP", |
| 380 | "RSRQ", |
Jeremy Ronquillo | c45955a | 2021-11-09 12:04:57 -0800 | [diff] [blame] | 381 | "ServCellState", |
| 382 | "Connection", |
| 383 | "IPv4Addr"] |
| 384 | dongleStatsXML = None |
| 385 | try: |
Jeremy Ronquillo | 56d23b1 | 2021-12-02 14:57:42 -0800 | [diff] [blame] | 386 | dongleStatsXML = ET.fromstring(subprocess.check_output("curl -u admin:admin -s 'http://192.168.0.1:8080/cgi-bin/ltestatus.cgi?Command=Status'", shell=True).decode("UTF-8")) |
Jeremy Ronquillo | c45955a | 2021-11-09 12:04:57 -0800 | [diff] [blame] | 387 | except Exception as e: |
| 388 | logging.error("Failed to fetch dongle stats from URL: " + str(e)) |
| 389 | return result |
| 390 | try: |
| 391 | for key in XMLkeys: |
| 392 | try: |
| 393 | result[key] = dongleStatsXML.find(key).text |
| 394 | except AttributeError as e: |
| 395 | logging.warn("Failed to find " + key + " in XML.") |
| 396 | result[key] = "" |
| 397 | result["SuccessfulFetch"] = True |
| 398 | except Exception as e: |
| 399 | logging.error("Failed to fetch dongle stats from XML: " + str(e)) |
| 400 | return result |
| 401 | return result |
Hyunsun Moon | 5cd1eec | 2021-04-02 22:33:42 -0700 | [diff] [blame] | 402 | |
Jeremy Ronquillo | c45955a | 2021-11-09 12:04:57 -0800 | [diff] [blame] | 403 | |
| 404 | def report_status(signal_quality, dongle_stats, cp_state=None, up_state=None, speedtest_ping=None, speedtest_iperf=None): |
Hyunsun Moon | 5cd1eec | 2021-04-02 22:33:42 -0700 | [diff] [blame] | 405 | report = { |
| 406 | 'name': CONF.edge_name, |
| 407 | 'status': { |
| 408 | 'control_plane': "disconnected", |
| 409 | 'user_plane': "disconnected" |
| 410 | }, |
Jeremy Ronquillo | c45955a | 2021-11-09 12:04:57 -0800 | [diff] [blame] | 411 | 'dongle_stats': { |
| 412 | 'SuccessfulFetch' : False |
| 413 | }, |
Hyunsun Moon | 5cd1eec | 2021-04-02 22:33:42 -0700 | [diff] [blame] | 414 | 'speedtest': { |
| 415 | 'ping': { |
| 416 | 'dns': { |
Jeremy Ronquillo | e0a8b42 | 2021-11-02 12:49:15 -0700 | [diff] [blame] | 417 | 'transmitted' : 0, |
| 418 | 'received' : 0, |
| 419 | 'median' : 0.0, |
Jeremy Ronquillo | 6e352b7 | 2021-06-08 10:33:25 -0700 | [diff] [blame] | 420 | 'min': 0.0, |
| 421 | 'avg': 0.0, |
| 422 | 'max': 0.0, |
| 423 | 'stddev': 0.0 |
Hyunsun Moon | 5cd1eec | 2021-04-02 22:33:42 -0700 | [diff] [blame] | 424 | } |
Jeremy Ronquillo | 677c883 | 2021-04-06 13:53:36 -0700 | [diff] [blame] | 425 | }, |
| 426 | 'iperf': { |
| 427 | 'cluster': { |
| 428 | 'downlink': 0.0, |
| 429 | 'uplink': 0.0 |
| 430 | } |
Hyunsun Moon | 5cd1eec | 2021-04-02 22:33:42 -0700 | [diff] [blame] | 431 | } |
| 432 | }, |
| 433 | 'signal_quality': { |
| 434 | 'rsrq': 0, |
| 435 | 'rsrp': 0 |
| 436 | } |
| 437 | } |
| 438 | |
| 439 | if cp_state is not None: |
| 440 | report['status']['control_plane'] = cp_state.name |
| 441 | if up_state is not None: |
| 442 | report['status']['user_plane'] = up_state.name |
| 443 | if speedtest_ping is not None: |
| 444 | report['speedtest']['ping'] = speedtest_ping |
Jeremy Ronquillo | 677c883 | 2021-04-06 13:53:36 -0700 | [diff] [blame] | 445 | if speedtest_iperf is not None: |
| 446 | report['speedtest']['iperf'] = speedtest_iperf |
Hyunsun Moon | 5cd1eec | 2021-04-02 22:33:42 -0700 | [diff] [blame] | 447 | report['signal_quality'] = signal_quality |
Jeremy Ronquillo | c45955a | 2021-11-09 12:04:57 -0800 | [diff] [blame] | 448 | report['dongle_stats'] = dongle_stats |
Hyunsun Moon | 53097ea | 2020-09-04 17:20:29 -0700 | [diff] [blame] | 449 | |
| 450 | logging.info("Sending report %s", report) |
Don Newton | bd91ae2 | 2021-05-11 14:58:18 -0700 | [diff] [blame] | 451 | global cycles |
| 452 | cycles += 1 |
| 453 | logging.info("Number of cycles since modem restart %i",cycles) |
Jeremy Ronquillo | 8d10865 | 2021-11-22 17:34:58 -0800 | [diff] [blame] | 454 | |
Hyunsun Moon | 53097ea | 2020-09-04 17:20:29 -0700 | [diff] [blame] | 455 | try: |
Jeremy Ronquillo | eff2e6d | 2021-12-06 10:39:37 -0800 | [diff] [blame] | 456 | interface = None |
| 457 | report_via_modem = "report_in_band" in CONF._fields and CONF.report_in_band and \ |
| 458 | "iface" in CONF.modem._fields and CONF.modem.iface |
| 459 | report_via_given_iface = "report_iface" in CONF._fields and CONF.report_iface |
| 460 | |
Jeremy Ronquillo | 8d10865 | 2021-11-22 17:34:58 -0800 | [diff] [blame] | 461 | c = pycurl.Curl() |
| 462 | c.setopt(pycurl.URL, CONF.report_url) |
| 463 | c.setopt(pycurl.POST, True) |
| 464 | c.setopt(pycurl.HTTPHEADER, ['Content-Type: application/json']) |
| 465 | c.setopt(pycurl.TIMEOUT, 10) |
| 466 | c.setopt(pycurl.POSTFIELDS, json.dumps(report)) |
Jeremy Ronquillo | 56d23b1 | 2021-12-02 14:57:42 -0800 | [diff] [blame] | 467 | c.setopt(pycurl.WRITEFUNCTION, lambda x: None) # don't output to console |
Jeremy Ronquillo | eff2e6d | 2021-12-06 10:39:37 -0800 | [diff] [blame] | 468 | |
| 469 | if report_via_modem: # report in-band |
| 470 | interface = CONF.modem.iface |
| 471 | c.setopt(pycurl.INTERFACE, interface) |
| 472 | elif report_via_given_iface: # report over given interface |
| 473 | interface = CONF.report_iface |
| 474 | c.setopt(pycurl.INTERFACE, interface) |
| 475 | # else, reports over default interface |
| 476 | |
| 477 | try: |
| 478 | c.perform() |
| 479 | logging.info("Report sent via " + interface + "!") |
| 480 | except Exception as e: |
| 481 | if report_via_modem and report_via_given_iface: |
| 482 | logging.warning("Sending report via modem failed. Attempting to send report via " + str(CONF.report_iface) + ".") |
| 483 | interface = CONF.report_iface |
| 484 | c.setopt(pycurl.INTERFACE, interface) |
| 485 | c.perform() |
| 486 | logging.info("Report sent via " + interface + "!") |
| 487 | else: |
| 488 | logging.error("Failed to send report: " + str(e)) |
Jeremy Ronquillo | 8d10865 | 2021-11-22 17:34:58 -0800 | [diff] [blame] | 489 | c.close() |
| 490 | except Exception as e: |
| 491 | logging.error("Failed to send report: " + str(e)) |
Jeremy Ronquillo | eff2e6d | 2021-12-06 10:39:37 -0800 | [diff] [blame] | 492 | c.close() |
Jeremy Ronquillo | 8d10865 | 2021-11-22 17:34:58 -0800 | [diff] [blame] | 493 | |
Don Newton | bd91ae2 | 2021-05-11 14:58:18 -0700 | [diff] [blame] | 494 | def reset_usb(): |
Jeremy Ronquillo | 82a1461 | 2021-10-08 12:08:20 -0700 | [diff] [blame] | 495 | try: |
| 496 | # Attempt to run uhubctl |
| 497 | if (int(subprocess.call("which uhubctl",shell=True)) == 0): |
| 498 | cmd = "/usr/sbin/uhubctl -a 0 -l 2" # -a 0 = action is shutdown -l 2 location = bus 2 on pi controls power to all hubs |
| 499 | ret = subprocess.call(cmd,shell=True) |
| 500 | logging.info("Shutting down usb hub 2 results %s" , ret) |
| 501 | time.sleep(10)# let power down process settle out |
| 502 | cmd = "/usr/sbin/uhubctl -a 1 -l 2" # -a 1 = action is start -l 2 location = bus 2 on pi controls power to all hubs |
| 503 | ret = subprocess.call(cmd,shell=True) |
| 504 | logging.info("Starting up usb hub 2 results %s" , ret) |
| 505 | time.sleep(10) #allow dbus to finish |
| 506 | global cycles |
| 507 | cycles = 0 |
| 508 | else: |
| 509 | reboot(120) |
| 510 | except Exception as e: |
| 511 | logging.error("Failed to run uhubctl: %s", e) |
| 512 | reboot(120) |
| 513 | |
| 514 | def reboot(delay): |
| 515 | logging.error("Failed to run uhubctl. Reboot system in " + str(delay) + " second(s).") |
| 516 | time.sleep(delay) |
| 517 | subprocess.check_output("sudo shutdown -r now", shell=True) |
Don Newton | bd91ae2 | 2021-05-11 14:58:18 -0700 | [diff] [blame] | 518 | |
Hyunsun Moon | 53097ea | 2020-09-04 17:20:29 -0700 | [diff] [blame] | 519 | def main(): |
Don Newton | bd91ae2 | 2021-05-11 14:58:18 -0700 | [diff] [blame] | 520 | global cycles |
Jeremy Ronquillo | ef17e36 | 2021-11-08 10:56:42 -0800 | [diff] [blame] | 521 | global hour_iperf_scheduled_time_last_ran |
Don Newton | bd91ae2 | 2021-05-11 14:58:18 -0700 | [diff] [blame] | 522 | cycles = 0 |
Jeremy Ronquillo | ef17e36 | 2021-11-08 10:56:42 -0800 | [diff] [blame] | 523 | hour_iperf_scheduled_time_last_ran = -1 |
Jeremy Ronquillo | 8d10865 | 2021-11-22 17:34:58 -0800 | [diff] [blame] | 524 | |
| 525 | try: |
| 526 | if "report_in_band" in CONF._fields and \ |
| 527 | "iface" in CONF.modem._fields and CONF.modem.iface: |
| 528 | if CONF.report_in_band: # need to add default gateway if reporting in-band |
| 529 | subprocess.check_output("sudo route add default gw " + CONF.modem.ip_addr + " " + CONF.modem.iface + " || true", shell=True) |
| 530 | else: |
| 531 | subprocess.check_output("sudo route del default gw " + CONF.modem.ip_addr + " " + CONF.modem.iface + " || true", shell=True) |
| 532 | except Exception as e: |
| 533 | logging.error("Failed to change default route for modem: " + str(e)) |
| 534 | |
Don Newton | bd91ae2 | 2021-05-11 14:58:18 -0700 | [diff] [blame] | 535 | for ip in CONF.ips: |
| 536 | if not ip: |
| 537 | continue |
| 538 | try: |
| 539 | subprocess.check_output("sudo ip route replace {}/32 via {}".format( |
| 540 | ip, CONF.modem.ip_addr), shell=True) |
| 541 | except subprocess.CalledProcessError as e: |
Jeremy Ronquillo | ef17e36 | 2021-11-08 10:56:42 -0800 | [diff] [blame] | 542 | logging.error("Failed to add routes: " + str(e.returncode) + str(e.output)) |
Jeremy Ronquillo | 82a1461 | 2021-10-08 12:08:20 -0700 | [diff] [blame] | 543 | time.sleep(10) # Sleep for 10 seconds before retry |
Don Newton | bd91ae2 | 2021-05-11 14:58:18 -0700 | [diff] [blame] | 544 | sys.exit(1) |
| 545 | |
Shad Ansari | 341a1c9 | 2022-03-02 09:14:40 -0800 | [diff] [blame] | 546 | if USE_MODEM_CMDS: |
| 547 | modem = Modem(CONF.modem.port, CONF.modem.baud) |
| 548 | try: |
| 549 | modem.connect() |
| 550 | except serial.serialutil.SerialException as e: |
| 551 | logging.error("Failed to connect the modem for %s", e) |
Hyunsun Moon | f424237 | 2020-10-04 23:32:38 -0700 | [diff] [blame] | 552 | sys.exit(1) |
Shad Ansari | 341a1c9 | 2022-03-02 09:14:40 -0800 | [diff] [blame] | 553 | else: |
| 554 | modem = None |
Hyunsun Moon | 53097ea | 2020-09-04 17:20:29 -0700 | [diff] [blame] | 555 | |
Shad Ansari | 341a1c9 | 2022-03-02 09:14:40 -0800 | [diff] [blame] | 556 | connect_retries = 0 |
| 557 | while True: |
| 558 | dongle_retries = 0 |
| 559 | dongle_stats = get_dongle_stats() |
| 560 | while not dongle_stats['SuccessfulFetch']: |
| 561 | log.error("Dongle error") |
| 562 | dongle_retries += 1 |
| 563 | if dongle_retries > 10: |
| 564 | logging.warn("Rebooting Pi") |
| 565 | os.system("shutdown /r /t 0") |
| 566 | sys.exit(1) |
| 567 | dongle_stats = get_dongle_stats() |
| 568 | |
| 569 | cp_state = get_control_plane_state(modem, dongle_stats) |
| 570 | |
| 571 | if cp_state != State.connected: |
| 572 | logging.error("Dongle not connected") |
| 573 | connect_retries += 1 |
| 574 | if connect_retries > 10: |
| 575 | os.system("shutdown /r /t 0") |
| 576 | sys.exit(1) |
| 577 | |
| 578 | signal_quality = get_signal_quality(modem, dongle_stats) |
| 579 | up_state, dry_run_latency = get_user_plane_state() |
Hyunsun Moon | 5cd1eec | 2021-04-02 22:33:42 -0700 | [diff] [blame] | 580 | if up_state is State.disconnected: |
Shad Ansari | 341a1c9 | 2022-03-02 09:14:40 -0800 | [diff] [blame] | 581 | logging.error("Dry run ping failed") |
Hyunsun Moon | 5cd1eec | 2021-04-02 22:33:42 -0700 | [diff] [blame] | 582 | |
Jeremy Ronquillo | 56d23b1 | 2021-12-02 14:57:42 -0800 | [diff] [blame] | 583 | speedtest_ping, speedtest_status = get_ping_test(modem, dry_run_latency) |
Shad Ansari | 341a1c9 | 2022-03-02 09:14:40 -0800 | [diff] [blame] | 584 | if not speedtest_status: |
| 585 | logging.error("Ping tests failed") |
| 586 | |
| 587 | speedtest_iperf = get_iperf_test(modem) |
Jeremy Ronquillo | 677c883 | 2021-04-06 13:53:36 -0700 | [diff] [blame] | 588 | |
Jeremy Ronquillo | c45955a | 2021-11-09 12:04:57 -0800 | [diff] [blame] | 589 | report_status(signal_quality, dongle_stats, cp_state, up_state, speedtest_ping, speedtest_iperf) |
Shad Ansari | 341a1c9 | 2022-03-02 09:14:40 -0800 | [diff] [blame] | 590 | time.sleep(CONF.report_interval) |
Hyunsun Moon | 53097ea | 2020-09-04 17:20:29 -0700 | [diff] [blame] | 591 | |
| 592 | modem.close() |
| 593 | |
| 594 | |
| 595 | if __name__ == "__main__": |
| 596 | main() |