2024-12-20T18:51:36.183Z,1734720696.183 [DataOverHttps](INFO): Received command: restart logs 2024-12-20T18:51:36.186Z,1734720696.186 [CommandExec](IMPORTANT): got command restart logs 2024-12-20T18:53:36.534Z,1734720816.534 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-20T18:53:36.534Z,1734720816.534 [Default:CheckIn:C.Wait] Stopped 2024-12-20T18:53:36.534Z,1734720816.534 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-20T18:53:36.534Z,1734720816.534 [Default:CheckIn:D] Running Loop=1 2024-12-20T18:53:36.946Z,1734720816.946 [Default:CheckIn:D] Stopped 2024-12-20T18:53:36.946Z,1734720816.946 [Default:CheckIn:E] Running Loop=1 2024-12-20T18:53:37.337Z,1734720817.337 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 17.513007 min 2024-12-20T18:53:37.337Z,1734720817.337 [Default:CheckIn:E] Stopped 2024-12-20T18:53:37.337Z,1734720817.337 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-20T18:53:37.337Z,1734720817.337 [Default:CheckIn] Stopped 2024-12-20T18:53:37.337Z,1734720817.337 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-20T18:53:37.337Z,1734720817.337 [Default:CheckIn](INFO): Running loop #4 2024-12-20T18:53:37.337Z,1734720817.337 [Default:CheckIn] Running Loop=4 2024-12-20T18:53:37.337Z,1734720817.337 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-20T18:53:37.337Z,1734720817.337 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-20T18:53:39.322Z,1734720819.322 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,185338.00,A,3648.58428,N,12149.44613,W,4.374,100.70,201224,,,D*79 2024-12-20T18:53:39.325Z,1734720819.325 [NAL9602](INFO): GPS fix at 20241220T185338: (36.809738, -121.824102) 2024-12-20T18:53:39.360Z,1734720819.360 [Default:CheckIn:Read_GPS] Stopped 2024-12-20T18:53:39.360Z,1734720819.360 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-20T18:53:48.663Z,1734720828.663 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20241220T062330/Courier0081.lzma 2024-12-20T18:53:49.666Z,1734720829.666 [DataOverHttps](INFO): Moved sent file to Logs/20241220T062330/Courier0081.lzma.bak 2024-12-20T18:53:49.666Z,1734720829.666 [DataOverHttps](INFO): SBD MOMSN=23850237 2024-12-20T18:53:52.718Z,1734720832.718 [NAL9602](INFO): SBD MO Status=0, MOMSN=11692, MT Status=0, MTMSN=0 2024-12-20T18:53:52.718Z,1734720832.718 [NAL9602](INFO): No messages in MT queue 2024-12-20T18:54:06.079Z,1734720846.079 [DataOverHttps](INFO): Sending 267 bytes from file Logs/20241220T185136/Courier0000.lzma 2024-12-20T18:54:07.081Z,1734720847.081 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Courier0000.lzma.bak 2024-12-20T18:54:07.082Z,1734720847.082 [DataOverHttps](INFO): SBD MOMSN=23850244 2024-12-20T18:54:23.388Z,1734720863.388 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-20T18:54:24.055Z,1734720864.055 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20241220T185136/Courier0003.lzma 2024-12-20T18:54:25.057Z,1734720865.057 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Courier0003.lzma.bak 2024-12-20T18:54:25.057Z,1734720865.057 [DataOverHttps](INFO): SBD MOMSN=23850248 2024-12-20T18:54:43.320Z,1734720883.320 [DataOverHttps](INFO): Sending 105 bytes from file Logs/20241220T062330/Express0082.lzma 2024-12-20T18:54:44.322Z,1734720884.322 [DataOverHttps](INFO): Moved sent file to Logs/20241220T062330/Express0082.lzma.bak 2024-12-20T18:54:44.322Z,1734720884.322 [DataOverHttps](INFO): SBD MOMSN=23850251 2024-12-20T18:55:03.756Z,1734720903.756 [DataOverHttps](INFO): Sending 383 bytes from file Logs/20241220T185136/Express0001.lzma 2024-12-20T18:55:04.758Z,1734720904.758 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Express0001.lzma.bak 2024-12-20T18:55:04.758Z,1734720904.758 [DataOverHttps](INFO): SBD MOMSN=23850255 2024-12-20T18:55:28.929Z,1734720928.929 [DataOverHttps](INFO): Sending 61 bytes from file Logs/20241220T185136/Express0004.lzma 2024-12-20T18:55:29.930Z,1734720929.930 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Express0004.lzma.bak 2024-12-20T18:55:29.930Z,1734720929.930 [DataOverHttps](INFO): SBD MOMSN=23850263 2024-12-20T18:55:33.361Z,1734720933.361 [Default:CheckIn:Read_Iridium] Stopped 2024-12-20T18:55:33.362Z,1734720933.362 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-20T18:55:33.362Z,1734720933.362 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-20T19:00:34.049Z,1734721234.049 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-20T19:00:34.049Z,1734721234.049 [Default:CheckIn:C.Wait] Stopped 2024-12-20T19:00:34.049Z,1734721234.049 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-20T19:00:34.050Z,1734721234.050 [Default:CheckIn:D] Running Loop=1 2024-12-20T19:00:34.459Z,1734721234.459 [Default:CheckIn:D] Stopped 2024-12-20T19:00:34.459Z,1734721234.459 [Default:CheckIn:E] Running Loop=1 2024-12-20T19:00:34.868Z,1734721234.868 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 24.471552 min 2024-12-20T19:00:34.868Z,1734721234.868 [Default:CheckIn:E] Stopped 2024-12-20T19:00:34.868Z,1734721234.868 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-20T19:00:34.868Z,1734721234.868 [Default:CheckIn] Stopped 2024-12-20T19:00:34.868Z,1734721234.868 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-20T19:00:34.868Z,1734721234.868 [Default:CheckIn](INFO): Running loop #5 2024-12-20T19:00:34.868Z,1734721234.868 [Default:CheckIn] Running Loop=5 2024-12-20T19:00:34.868Z,1734721234.868 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-20T19:00:34.868Z,1734721234.868 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-20T19:00:36.869Z,1734721236.869 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,190036.00,A,3648.18047,N,12147.74214,W,10.730,60.19,201224,,,D*7E 2024-12-20T19:00:36.872Z,1734721236.872 [NAL9602](INFO): GPS fix at 20241220T190036: (36.803008, -121.795702) 2024-12-20T19:00:36.906Z,1734721236.906 [Default:CheckIn:Read_GPS] Stopped 2024-12-20T19:00:36.906Z,1734721236.906 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-20T19:00:45.474Z,1734721245.474 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20241220T185136/Courier0006.lzma 2024-12-20T19:00:46.477Z,1734721246.477 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Courier0006.lzma.bak 2024-12-20T19:00:46.477Z,1734721246.477 [DataOverHttps](INFO): SBD MOMSN=23850283 2024-12-20T19:00:50.606Z,1734721250.606 [NAL9602](INFO): SBD MO Status=0, MOMSN=11693, MT Status=0, MTMSN=0 2024-12-20T19:00:50.606Z,1734721250.606 [NAL9602](INFO): No messages in MT queue 2024-12-20T19:01:07.275Z,1734721267.275 [DataOverHttps](INFO): Sending 146 bytes from file Logs/20241220T185136/Express0007.lzma 2024-12-20T19:01:08.277Z,1734721268.277 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Express0007.lzma.bak 2024-12-20T19:01:08.277Z,1734721268.277 [DataOverHttps](INFO): SBD MOMSN=23850286 2024-12-20T19:01:13.336Z,1734721273.336 [Default:CheckIn:Read_Iridium] Stopped 2024-12-20T19:01:13.337Z,1734721273.337 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-20T19:01:13.337Z,1734721273.337 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-20T19:01:21.364Z,1734721281.364 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-20T19:06:13.930Z,1734721573.930 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-20T19:06:13.930Z,1734721573.930 [Default:CheckIn:C.Wait] Stopped 2024-12-20T19:06:13.930Z,1734721573.930 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-20T19:06:13.930Z,1734721573.930 [Default:CheckIn:D] Running Loop=1 2024-12-20T19:06:14.322Z,1734721574.322 [Default:CheckIn:D] Stopped 2024-12-20T19:06:14.322Z,1734721574.322 [Default:CheckIn:E] Running Loop=1 2024-12-20T19:06:14.734Z,1734721574.734 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 30.135938 min 2024-12-20T19:06:14.734Z,1734721574.734 [Default:CheckIn:E] Stopped 2024-12-20T19:06:14.734Z,1734721574.734 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-20T19:06:14.734Z,1734721574.734 [Default:CheckIn] Stopped 2024-12-20T19:06:14.734Z,1734721574.734 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-20T19:06:14.735Z,1734721574.735 [Default:CheckIn](INFO): Running loop #6 2024-12-20T19:06:14.735Z,1734721574.735 [Default:CheckIn] Running Loop=6 2024-12-20T19:06:14.735Z,1734721574.735 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-20T19:06:14.735Z,1734721574.735 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-20T19:06:16.739Z,1734721576.739 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,190615.00,A,3648.47069,N,12147.12284,W,3.829,180.05,201224,,,D*71 2024-12-20T19:06:16.741Z,1734721576.741 [NAL9602](INFO): GPS fix at 20241220T190615: (36.807845, -121.785381) 2024-12-20T19:06:16.754Z,1734721576.754 [Default:CheckIn:Read_GPS] Stopped 2024-12-20T19:06:16.754Z,1734721576.754 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-20T19:06:23.273Z,1734721583.273 [NAL9602](INFO): SBD MO Status=0, MOMSN=11694, MT Status=0, MTMSN=0 2024-12-20T19:06:23.273Z,1734721583.273 [NAL9602](INFO): No messages in MT queue 2024-12-20T19:06:25.411Z,1734721585.411 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20241220T185136/Courier0009.lzma 2024-12-20T19:06:26.414Z,1734721586.414 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Courier0009.lzma.bak 2024-12-20T19:06:26.414Z,1734721586.414 [DataOverHttps](INFO): SBD MOMSN=23850303 2024-12-20T19:06:44.992Z,1734721604.992 [DataOverHttps](INFO): Sending 141 bytes from file Logs/20241220T185136/Express0010.lzma 2024-12-20T19:06:45.993Z,1734721605.993 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Express0010.lzma.bak 2024-12-20T19:06:45.993Z,1734721605.993 [DataOverHttps](INFO): SBD MOMSN=23850306 2024-12-20T19:06:49.155Z,1734721609.155 [Default:CheckIn:Read_Iridium] Stopped 2024-12-20T19:06:49.155Z,1734721609.155 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-20T19:06:49.155Z,1734721609.155 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-20T19:06:53.968Z,1734721613.968 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-20T19:08:56.168Z,1734721736.168 [CBIT](IMPORTANT): Beginning ground fault scan 2024-12-20T19:09:07.166Z,1734721747.166 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.003353 CHAN A1 (24V): 0.003056 CHAN A2 (12V): 0.002396 CHAN A3 (5V): -0.001324 CHAN B0 (3.3V): -0.000625 CHAN B1 (3.15aV): -0.001100 CHAN B2 (3.15bV): -0.000523 CHAN B3 (GND): -0.002466 OPEN: 0.004811 Full Scale: +/- 1 mA 2024-12-20T19:11:10.645Z,1734721870.645 [BPC1](ERROR): Battery stick #62 (s/n: 00CC) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0. 2024-12-20T19:11:10.646Z,1734721870.646 [BPC1](INFO): Calculating totals. Valid battery stick count: 27. Valid reserve battery stick count: 3. 2024-12-20T19:11:10.688Z,1734721870.688 [BPC1](FAULT): Failed to receive data from 32 sticks prior to timeout. Will not retry this scan cycle. Missing stick IDs are: 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30, 31, 62. 2024-12-20T19:11:49.810Z,1734721909.810 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-20T19:11:49.810Z,1734721909.810 [Default:CheckIn:C.Wait] Stopped 2024-12-20T19:11:49.811Z,1734721909.811 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-20T19:11:49.812Z,1734721909.812 [Default:CheckIn:D] Running Loop=1 2024-12-20T19:11:50.218Z,1734721910.218 [Default:CheckIn:D] Stopped 2024-12-20T19:11:50.218Z,1734721910.218 [Default:CheckIn:E] Running Loop=1 2024-12-20T19:11:50.653Z,1734721910.653 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 35.734204 min 2024-12-20T19:11:50.653Z,1734721910.653 [Default:CheckIn:E] Stopped 2024-12-20T19:11:50.653Z,1734721910.653 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-20T19:11:50.653Z,1734721910.653 [Default:CheckIn] Stopped 2024-12-20T19:11:50.653Z,1734721910.653 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-20T19:11:50.653Z,1734721910.653 [Default:CheckIn](INFO): Running loop #7 2024-12-20T19:11:50.653Z,1734721910.653 [Default:CheckIn] Running Loop=7 2024-12-20T19:11:50.653Z,1734721910.653 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-20T19:11:50.653Z,1734721910.653 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-20T19:11:52.630Z,1734721912.630 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,191151.00,A,3648.14518,N,12147.19161,W,0.583,185.20,201224,,,D*7D 2024-12-20T19:11:52.632Z,1734721912.632 [NAL9602](INFO): GPS fix at 20241220T191151: (36.802420, -121.786527) 2024-12-20T19:11:52.663Z,1734721912.663 [Default:CheckIn:Read_GPS] Stopped 2024-12-20T19:11:52.663Z,1734721912.663 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-20T19:12:04.938Z,1734721924.938 [DataOverHttps](INFO): Sending 202 bytes from file Logs/20241220T185136/Courier0012.lzma 2024-12-20T19:12:05.945Z,1734721925.945 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Courier0012.lzma.bak 2024-12-20T19:12:05.945Z,1734721925.945 [DataOverHttps](INFO): SBD MOMSN=23850310 2024-12-20T19:12:09.202Z,1734721929.202 [NAL9602](INFO): SBD MO Status=0, MOMSN=11695, MT Status=0, MTMSN=0 2024-12-20T19:12:09.202Z,1734721929.202 [NAL9602](INFO): No messages in MT queue 2024-12-20T19:12:24.455Z,1734721944.455 [DataOverHttps](INFO): Sending 488 bytes from file Logs/20241220T185136/Express0013.lzma 2024-12-20T19:12:25.457Z,1734721945.457 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Express0013.lzma.bak 2024-12-20T19:12:25.457Z,1734721945.457 [DataOverHttps](INFO): SBD MOMSN=23850313 2024-12-20T19:12:28.607Z,1734721948.607 [Default:CheckIn:Read_Iridium] Stopped 2024-12-20T19:12:28.607Z,1734721948.607 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-20T19:12:28.607Z,1734721948.607 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-20T19:12:39.891Z,1734721959.891 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-20T19:17:01.839Z,1734722221.839 [MassServo](ERROR): getPosition uart error serial timeout 2024-12-20T19:17:01.840Z,1734722221.840 [MassServo](FAULT): Invalid EZ Servo response:"\377" 2024-12-20T19:17:01.840Z,1734722221.840 [MassServo] Communications Fault, FailCount= 5 2024-12-20T19:17:01.840Z,1734722221.840 [MassServo](ERROR): Communications Fault 2024-12-20T19:17:01.844Z,1734722221.844 [CBIT](ERROR): Communications Fault in component: MassServo 2024-12-20T19:17:01.845Z,1734722221.845 [CBIT](CRITICAL): Communications Fault in component: MassServo 2024-12-20T19:17:02.175Z,1734722222.175 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-12-20T19:17:02.175Z,1734722222.175 [MassServo](INFO): Powering down 2024-12-20T19:17:02.177Z,1734722222.177 [CommandExec](FAULT): Scheduling is paused 2024-12-20T19:17:02.178Z,1734722222.178 [CBIT](INFO): Critical error at 20241220T191701 2024-12-20T19:17:02.952Z,1734722222.952 [MassServo](DEBUG): Initializing EZServoServo. 2024-12-20T19:17:03.072Z,1734722223.072 [MassServo](DEBUG): Initializing MassServo. 2024-12-20T19:17:29.247Z,1734722249.247 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-20T19:17:29.247Z,1734722249.247 [Default:CheckIn:C.Wait] Stopped 2024-12-20T19:17:29.248Z,1734722249.248 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-20T19:17:29.248Z,1734722249.248 [Default:CheckIn:D] Running Loop=1 2024-12-20T19:17:29.648Z,1734722249.648 [Default:CheckIn:D] Stopped 2024-12-20T19:17:29.648Z,1734722249.648 [Default:CheckIn:E] Running Loop=1 2024-12-20T19:17:30.061Z,1734722250.061 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 41.391370 min 2024-12-20T19:17:30.061Z,1734722250.061 [Default:CheckIn:E] Stopped 2024-12-20T19:17:30.062Z,1734722250.062 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-20T19:17:30.062Z,1734722250.062 [Default:CheckIn] Stopped 2024-12-20T19:17:30.062Z,1734722250.062 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-20T19:17:30.062Z,1734722250.062 [Default:CheckIn](INFO): Running loop #8 2024-12-20T19:17:30.062Z,1734722250.062 [Default:CheckIn] Running Loop=8 2024-12-20T19:17:30.062Z,1734722250.062 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-20T19:17:30.062Z,1734722250.062 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-20T19:17:32.067Z,1734722252.067 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,191731.00,A,3648.13724,N,12147.20646,W,0.039,221.80,201224,,,D*7C 2024-12-20T19:17:32.070Z,1734722252.070 [NAL9602](INFO): GPS fix at 20241220T191731: (36.802287, -121.786774) 2024-12-20T19:17:32.100Z,1734722252.100 [Default:CheckIn:Read_GPS] Stopped 2024-12-20T19:17:32.100Z,1734722252.100 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-20T19:17:40.320Z,1734722260.320 [DataOverHttps](INFO): Sending 147 bytes from file Logs/20241220T185136/Courier0015.lzma 2024-12-20T19:17:41.325Z,1734722261.325 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Courier0015.lzma.bak 2024-12-20T19:17:41.326Z,1734722261.326 [DataOverHttps](INFO): SBD MOMSN=23850332 2024-12-20T19:17:58.367Z,1734722278.367 [NAL9602](INFO): SBD MO Status=2, MOMSN=11696, MT Status=2, MTMSN=0 2024-12-20T19:17:58.367Z,1734722278.367 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-12-20T19:17:59.593Z,1734722279.593 [DataOverHttps](INFO): Sending 216 bytes from file Logs/20241220T185136/Express0016.lzma 2024-12-20T19:18:00.594Z,1734722280.594 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Express0016.lzma.bak 2024-12-20T19:18:00.595Z,1734722280.595 [DataOverHttps](INFO): SBD MOMSN=23850336 2024-12-20T19:18:03.652Z,1734722283.652 [Default:CheckIn:Read_Iridium] Stopped 2024-12-20T19:18:03.652Z,1734722283.652 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-20T19:18:03.656Z,1734722283.656 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-20T19:18:20.191Z,1734722300.191 [NAL9602](INFO): SBD MO Status=0, MOMSN=11696, MT Status=0, MTMSN=0 2024-12-20T19:18:20.191Z,1734722300.191 [NAL9602](INFO): No messages in MT queue 2024-12-20T19:18:50.902Z,1734722330.902 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-20T19:22:02.105Z,1734722522.105 [CBIT](INFO): Clearing failed state for component MassServo 2024-12-20T19:22:02.105Z,1734722522.105 [MassServo] No Fault, FailCount= 5 2024-12-20T19:23:04.360Z,1734722584.360 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-20T19:23:04.361Z,1734722584.361 [Default:CheckIn:C.Wait] Stopped 2024-12-20T19:23:04.361Z,1734722584.361 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-20T19:23:04.361Z,1734722584.361 [Default:CheckIn:D] Running Loop=1 2024-12-20T19:23:04.736Z,1734722584.736 [Default:CheckIn:D] Stopped 2024-12-20T19:23:04.736Z,1734722584.736 [Default:CheckIn:E] Running Loop=1 2024-12-20T19:23:05.149Z,1734722585.149 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 46.976168 min 2024-12-20T19:23:05.150Z,1734722585.150 [Default:CheckIn:E] Stopped 2024-12-20T19:23:05.150Z,1734722585.150 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-20T19:23:05.150Z,1734722585.150 [Default:CheckIn] Stopped 2024-12-20T19:23:05.150Z,1734722585.150 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-20T19:23:05.151Z,1734722585.151 [Default:CheckIn](INFO): Running loop #9 2024-12-20T19:23:05.151Z,1734722585.151 [Default:CheckIn] Running Loop=9 2024-12-20T19:23:05.152Z,1734722585.152 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-20T19:23:05.152Z,1734722585.152 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-20T19:23:07.196Z,1734722587.196 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,192306.00,A,3648.13787,N,12147.20678,W,0.292,143.67,201224,,,D*76 2024-12-20T19:23:07.202Z,1734722587.202 [NAL9602](INFO): GPS fix at 20241220T192306: (36.802298, -121.786780) 2024-12-20T19:23:07.271Z,1734722587.271 [Default:CheckIn:Read_GPS] Stopped 2024-12-20T19:23:07.271Z,1734722587.271 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-20T19:23:21.279Z,1734722601.279 [NAL9602](INFO): SBD MO Status=0, MOMSN=11697, MT Status=0, MTMSN=0 2024-12-20T19:23:21.279Z,1734722601.279 [NAL9602](INFO): No messages in MT queue 2024-12-20T19:23:21.560Z,1734722601.560 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20241220T185136/Courier0018.lzma 2024-12-20T19:23:22.562Z,1734722602.562 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Courier0018.lzma.bak 2024-12-20T19:23:22.562Z,1734722602.562 [DataOverHttps](INFO): SBD MOMSN=23850342 2024-12-20T19:23:44.673Z,1734722624.673 [DataOverHttps](INFO): Sending 129 bytes from file Logs/20241220T185136/Express0019.lzma 2024-12-20T19:23:45.680Z,1734722625.680 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Express0019.lzma.bak 2024-12-20T19:23:45.680Z,1734722625.680 [DataOverHttps](INFO): SBD MOMSN=23850346 2024-12-20T19:23:51.997Z,1734722631.997 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-20T19:23:52.429Z,1734722632.429 [Default:CheckIn:Read_Iridium] Stopped 2024-12-20T19:23:52.430Z,1734722632.430 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-20T19:23:52.430Z,1734722632.430 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-20T19:27:30.061Z,1734722850.061 [MassServo](ERROR): getPosition uart error serial timeout 2024-12-20T19:27:30.433Z,1734722850.433 [MassServo](FAULT): Overload Error 2024-12-20T19:27:30.433Z,1734722850.433 [MassServo] Hardware Fault, FailCount= 1 2024-12-20T19:27:30.433Z,1734722850.433 [MassServo](ERROR): Hardware Fault 2024-12-20T19:27:30.441Z,1734722850.441 [CBIT](ERROR): Hardware Fault in component: MassServo 2024-12-20T19:27:30.768Z,1734722850.768 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-12-20T19:27:30.768Z,1734722850.768 [MassServo](INFO): Powering down 2024-12-20T19:27:31.497Z,1734722851.497 [MassServo](DEBUG): Initializing EZServoServo. 2024-12-20T19:27:31.633Z,1734722851.633 [MassServo](DEBUG): Initializing MassServo. 2024-12-20T19:27:31.637Z,1734722851.637 [CBIT](INFO): Clearing failed state for component MassServo 2024-12-20T19:27:31.637Z,1734722851.637 [MassServo] No Fault, FailCount= 1 2024-12-20T19:28:53.098Z,1734722933.098 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-20T19:28:53.098Z,1734722933.098 [Default:CheckIn:C.Wait] Stopped 2024-12-20T19:28:53.098Z,1734722933.098 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-20T19:28:53.098Z,1734722933.098 [Default:CheckIn:D] Running Loop=1 2024-12-20T19:28:53.491Z,1734722933.491 [Default:CheckIn:D] Stopped 2024-12-20T19:28:53.492Z,1734722933.492 [Default:CheckIn:E] Running Loop=1 2024-12-20T19:28:53.892Z,1734722933.892 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 52.788765 min 2024-12-20T19:28:53.892Z,1734722933.892 [Default:CheckIn:E] Stopped 2024-12-20T19:28:53.892Z,1734722933.892 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-20T19:28:53.892Z,1734722933.892 [Default:CheckIn] Stopped 2024-12-20T19:28:53.892Z,1734722933.892 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-20T19:28:53.892Z,1734722933.892 [Default:CheckIn](INFO): Running loop #10 2024-12-20T19:28:53.892Z,1734722933.892 [Default:CheckIn] Running Loop=10 2024-12-20T19:28:53.892Z,1734722933.892 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-20T19:28:53.893Z,1734722933.893 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-20T19:28:55.904Z,1734722935.904 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,192854.00,A,3648.13779,N,12147.20994,W,0.019,357.63,201224,,,D*74 2024-12-20T19:28:55.907Z,1734722935.907 [NAL9602](INFO): GPS fix at 20241220T192854: (36.802296, -121.786832) 2024-12-20T19:28:55.918Z,1734722935.918 [Default:CheckIn:Read_GPS] Stopped 2024-12-20T19:28:55.918Z,1734722935.918 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-20T19:29:05.656Z,1734722945.656 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20241220T185136/Courier0021.lzma 2024-12-20T19:29:06.619Z,1734722946.619 [NAL9602](INFO): SBD MO Status=0, MOMSN=11698, MT Status=0, MTMSN=0 2024-12-20T19:29:06.619Z,1734722946.619 [NAL9602](INFO): No messages in MT queue 2024-12-20T19:29:06.659Z,1734722946.659 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Courier0021.lzma.bak 2024-12-20T19:29:06.659Z,1734722946.659 [DataOverHttps](INFO): SBD MOMSN=23850362 2024-12-20T19:29:37.038Z,1734722977.038 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-20T19:29:42.017Z,1734722982.017 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20241220T185136/Express0022.lzma 2024-12-20T19:29:43.019Z,1734722983.019 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Express0022.lzma.bak 2024-12-20T19:29:43.019Z,1734722983.019 [DataOverHttps](INFO): SBD MOMSN=23850366 2024-12-20T19:29:46.151Z,1734722986.151 [Default:CheckIn:Read_Iridium] Stopped 2024-12-20T19:29:46.151Z,1734722986.151 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-20T19:29:46.151Z,1734722986.151 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-20T19:34:46.928Z,1734723286.928 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-20T19:34:46.928Z,1734723286.928 [Default:CheckIn:C.Wait] Stopped 2024-12-20T19:34:46.928Z,1734723286.928 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-20T19:34:46.937Z,1734723286.937 [Default:CheckIn:D] Running Loop=1 2024-12-20T19:34:47.344Z,1734723287.344 [Default:CheckIn:D] Stopped 2024-12-20T19:34:47.344Z,1734723287.344 [Default:CheckIn:E] Running Loop=1 2024-12-20T19:34:47.718Z,1734723287.718 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 58.686308 min 2024-12-20T19:34:47.718Z,1734723287.718 [Default:CheckIn:E] Stopped 2024-12-20T19:34:47.718Z,1734723287.718 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-20T19:34:47.718Z,1734723287.718 [Default:CheckIn] Stopped 2024-12-20T19:34:47.718Z,1734723287.718 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-20T19:34:47.718Z,1734723287.718 [Default:CheckIn](INFO): Running loop #11 2024-12-20T19:34:47.718Z,1734723287.718 [Default:CheckIn] Running Loop=11 2024-12-20T19:34:47.718Z,1734723287.718 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-20T19:34:47.719Z,1734723287.718 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-20T19:34:49.708Z,1734723289.708 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,193448.00,A,3648.13830,N,12147.20898,W,0.019,357.63,201224,,,D*7B 2024-12-20T19:34:49.710Z,1734723289.710 [NAL9602](INFO): GPS fix at 20241220T193448: (36.802305, -121.786816) 2024-12-20T19:34:49.721Z,1734723289.721 [Default:CheckIn:Read_GPS] Stopped 2024-12-20T19:34:49.721Z,1734723289.721 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-20T19:34:59.487Z,1734723299.487 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20241220T185136/Courier0024.lzma 2024-12-20T19:35:00.487Z,1734723300.487 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Courier0024.lzma.bak 2024-12-20T19:35:00.487Z,1734723300.487 [DataOverHttps](INFO): SBD MOMSN=23850370 2024-12-20T19:35:01.439Z,1734723301.439 [NAL9602](INFO): SBD MO Status=0, MOMSN=11699, MT Status=0, MTMSN=0 2024-12-20T19:35:01.440Z,1734723301.440 [NAL9602](INFO): No messages in MT queue 2024-12-20T19:35:29.005Z,1734723329.005 [DataOverHttps](INFO): Sending 129 bytes from file Logs/20241220T185136/Express0025.lzma 2024-12-20T19:35:30.003Z,1734723330.003 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Express0025.lzma.bak 2024-12-20T19:35:30.003Z,1734723330.003 [DataOverHttps](INFO): SBD MOMSN=23850374 2024-12-20T19:35:31.949Z,1734723331.949 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-20T19:35:36.537Z,1734723336.537 [Default:CheckIn:Read_Iridium] Stopped 2024-12-20T19:35:36.537Z,1734723336.537 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-20T19:35:36.537Z,1734723336.537 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-20T19:38:18.729Z,1734723498.729 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting. 2024-12-20T19:40:37.115Z,1734723637.115 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-20T19:40:37.115Z,1734723637.115 [Default:CheckIn:C.Wait] Stopped 2024-12-20T19:40:37.115Z,1734723637.115 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-20T19:40:37.116Z,1734723637.116 [Default:CheckIn:D] Running Loop=1 2024-12-20T19:40:37.503Z,1734723637.503 [Default:CheckIn:D] Stopped 2024-12-20T19:40:37.503Z,1734723637.503 [Default:CheckIn:E] Running Loop=1 2024-12-20T19:40:37.900Z,1734723637.900 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 64.522298 min 2024-12-20T19:40:37.900Z,1734723637.900 [Default:CheckIn:E] Stopped 2024-12-20T19:40:37.900Z,1734723637.900 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-20T19:40:37.900Z,1734723637.900 [Default:CheckIn] Stopped 2024-12-20T19:40:37.900Z,1734723637.900 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-20T19:40:37.901Z,1734723637.901 [Default:CheckIn](INFO): Running loop #12 2024-12-20T19:40:37.901Z,1734723637.901 [Default:CheckIn] Running Loop=12 2024-12-20T19:40:37.901Z,1734723637.901 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-20T19:40:37.901Z,1734723637.901 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-20T19:40:39.908Z,1734723639.908 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,194038.00,A,3648.17199,N,12147.27822,W,0.058,284.66,201224,,,D*78 2024-12-20T19:40:39.910Z,1734723639.910 [NAL9602](INFO): GPS fix at 20241220T194038: (36.802867, -121.787970) 2024-12-20T19:40:39.921Z,1734723639.921 [Default:CheckIn:Read_GPS] Stopped 2024-12-20T19:40:39.921Z,1734723639.921 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-20T19:40:50.688Z,1734723650.688 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20241220T185136/Courier0027.lzma 2024-12-20T19:40:51.690Z,1734723651.690 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Courier0027.lzma.bak 2024-12-20T19:40:51.691Z,1734723651.691 [DataOverHttps](INFO): SBD MOMSN=23850389 2024-12-20T19:41:19.762Z,1734723679.762 [DataOverHttps](INFO): Sending 129 bytes from file Logs/20241220T185136/Express0028.lzma 2024-12-20T19:41:20.762Z,1734723680.762 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Express0028.lzma.bak 2024-12-20T19:41:20.763Z,1734723680.763 [DataOverHttps](INFO): SBD MOMSN=23850393 2024-12-20T19:41:24.074Z,1734723684.074 [Default:CheckIn:Read_Iridium] Stopped 2024-12-20T19:41:24.075Z,1734723684.075 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-20T19:41:24.075Z,1734723684.075 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-20T19:41:45.850Z,1734723705.850 [NAL9602](INFO): SBD MO Status=0, MOMSN=11700, MT Status=0, MTMSN=0 2024-12-20T19:41:45.851Z,1734723705.851 [NAL9602](INFO): No messages in MT queue 2024-12-20T19:42:16.517Z,1734723736.517 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-20T19:42:46.125Z,1734723766.125 [MassServo](ERROR): getPosition uart error serial timeout 2024-12-20T19:42:46.125Z,1734723766.125 [MassServo](FAULT): Invalid EZ Servo response:"\377" 2024-12-20T19:42:46.125Z,1734723766.125 [MassServo] Communications Fault, FailCount= 2 2024-12-20T19:42:46.125Z,1734723766.125 [MassServo](ERROR): Communications Fault 2024-12-20T19:42:46.135Z,1734723766.135 [CBIT](ERROR): Communications Fault in component: MassServo 2024-12-20T19:42:46.441Z,1734723766.441 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-12-20T19:42:46.441Z,1734723766.441 [MassServo](INFO): Powering down 2024-12-20T19:42:47.254Z,1734723767.254 [MassServo](DEBUG): Initializing EZServoServo. 2024-12-20T19:42:47.370Z,1734723767.370 [MassServo](DEBUG): Initializing MassServo. 2024-12-20T19:42:47.374Z,1734723767.374 [CBIT](INFO): Clearing failed state for component MassServo 2024-12-20T19:42:47.374Z,1734723767.374 [MassServo] No Fault, FailCount= 2 2024-12-20T19:46:24.773Z,1734723984.773 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-20T19:46:24.773Z,1734723984.773 [Default:CheckIn:C.Wait] Stopped 2024-12-20T19:46:24.773Z,1734723984.773 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-20T19:46:24.773Z,1734723984.773 [Default:CheckIn:D] Running Loop=1 2024-12-20T19:46:25.121Z,1734723985.121 [Default:CheckIn:D] Stopped 2024-12-20T19:46:25.121Z,1734723985.121 [Default:CheckIn:E] Running Loop=1 2024-12-20T19:46:25.556Z,1734723985.556 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 70.315934 min 2024-12-20T19:46:25.556Z,1734723985.556 [Default:CheckIn:E] Stopped 2024-12-20T19:46:25.556Z,1734723985.556 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-20T19:46:25.556Z,1734723985.556 [Default:CheckIn] Stopped 2024-12-20T19:46:25.556Z,1734723985.556 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-20T19:46:25.556Z,1734723985.556 [Default:CheckIn](INFO): Running loop #13 2024-12-20T19:46:25.556Z,1734723985.556 [Default:CheckIn] Running Loop=13 2024-12-20T19:46:25.557Z,1734723985.557 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-20T19:46:25.557Z,1734723985.557 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-20T19:46:27.533Z,1734723987.533 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,194626.00,A,3648.17191,N,12147.27956,W,0.039,284.66,201224,,,A*79 2024-12-20T19:46:27.535Z,1734723987.535 [NAL9602](INFO): GPS fix at 20241220T194626: (36.802865, -121.787993) 2024-12-20T19:46:27.547Z,1734723987.547 [Default:CheckIn:Read_GPS] Stopped 2024-12-20T19:46:27.547Z,1734723987.547 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-20T19:46:35.530Z,1734723995.530 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20241220T185136/Courier0030.lzma 2024-12-20T19:46:36.533Z,1734723996.533 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Courier0030.lzma.bak 2024-12-20T19:46:36.533Z,1734723996.533 [DataOverHttps](INFO): SBD MOMSN=23850403 2024-12-20T19:46:58.722Z,1734724018.722 [DataOverHttps](INFO): Sending 167 bytes from file Logs/20241220T185136/Express0031.lzma 2024-12-20T19:46:59.725Z,1734724019.725 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Express0031.lzma.bak 2024-12-20T19:46:59.725Z,1734724019.725 [DataOverHttps](INFO): SBD MOMSN=23850411 2024-12-20T19:47:10.324Z,1734724030.324 [Default:CheckIn:Read_Iridium] Stopped 2024-12-20T19:47:10.324Z,1734724030.324 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-20T19:47:10.324Z,1734724030.324 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-20T19:47:25.833Z,1734724045.833 [NAL9602](INFO): SBD MO Status=2, MOMSN=11701, MT Status=2, MTMSN=0 2024-12-20T19:47:25.833Z,1734724045.833 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-12-20T19:48:00.189Z,1734724080.189 [NAL9602](INFO): SBD MO Status=2, MOMSN=11701, MT Status=2, MTMSN=0 2024-12-20T19:48:00.189Z,1734724080.189 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-12-20T19:48:43.048Z,1734724123.048 [NAL9602](INFO): SBD MO Status=2, MOMSN=11701, MT Status=2, MTMSN=0 2024-12-20T19:48:43.049Z,1734724123.049 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-12-20T19:51:29.516Z,1734724289.516 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-12-20T19:52:00.231Z,1734724320.231 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-20T19:52:10.853Z,1734724330.853 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-20T19:52:10.853Z,1734724330.853 [Default:CheckIn:C.Wait] Stopped 2024-12-20T19:52:10.854Z,1734724330.854 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-20T19:52:10.854Z,1734724330.854 [Default:CheckIn:D] Running Loop=1 2024-12-20T19:52:11.258Z,1734724331.258 [Default:CheckIn:D] Stopped 2024-12-20T19:52:11.258Z,1734724331.258 [Default:CheckIn:E] Running Loop=1 2024-12-20T19:52:11.639Z,1734724331.639 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 76.084465 min 2024-12-20T19:52:11.639Z,1734724331.639 [Default:CheckIn:E] Stopped 2024-12-20T19:52:11.639Z,1734724331.639 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-20T19:52:11.639Z,1734724331.639 [Default:CheckIn] Stopped 2024-12-20T19:52:11.639Z,1734724331.639 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-20T19:52:11.639Z,1734724331.639 [Default:CheckIn](INFO): Running loop #14 2024-12-20T19:52:11.639Z,1734724331.639 [Default:CheckIn] Running Loop=14 2024-12-20T19:52:11.639Z,1734724331.639 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-20T19:52:11.639Z,1734724331.639 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-20T19:52:12.435Z,1734724332.435 [BPC1](ERROR): Battery stick #62 (s/n: 00CC) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0. 2024-12-20T19:52:12.435Z,1734724332.435 [BPC1](INFO): Calculating totals. Valid battery stick count: 27. Valid reserve battery stick count: 3. 2024-12-20T19:52:12.441Z,1734724332.441 [BPC1](FAULT): Failed to receive data from 32 sticks prior to timeout. Will not retry this scan cycle. Missing stick IDs are: 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30, 31, 62. 2024-12-20T19:52:13.657Z,1734724333.657 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,195212.00,A,3648.17414,N,12147.27900,W,0.097,284.66,201224,,,A*74 2024-12-20T19:52:13.669Z,1734724333.669 [NAL9602](INFO): GPS fix at 20241220T195212: (36.802902, -121.787983) 2024-12-20T19:52:13.680Z,1734724333.680 [Default:CheckIn:Read_GPS] Stopped 2024-12-20T19:52:13.680Z,1734724333.680 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-20T19:52:23.462Z,1734724343.462 [DataOverHttps](INFO): Sending 82 bytes from file Logs/20241220T185136/Courier0033.lzma 2024-12-20T19:52:24.464Z,1734724344.464 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Courier0033.lzma.bak 2024-12-20T19:52:24.465Z,1734724344.465 [DataOverHttps](INFO): SBD MOMSN=23850421 2024-12-20T19:52:44.368Z,1734724364.368 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2024-12-20T19:52:44.463Z,1734724364.463 [NAL9602](ERROR): received: +CSQ:0 OK701, 2, 0, 0, 0 OK 2024-12-20T19:52:46.818Z,1734724366.818 [DataOverHttps](INFO): Sending 355 bytes from file Logs/20241220T185136/Express0034.lzma 2024-12-20T19:52:47.817Z,1734724367.817 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Express0034.lzma.bak 2024-12-20T19:52:47.817Z,1734724367.817 [DataOverHttps](INFO): SBD MOMSN=23850424 2024-12-20T19:52:50.949Z,1734724370.949 [Default:CheckIn:Read_Iridium] Stopped 2024-12-20T19:52:50.950Z,1734724370.950 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-20T19:52:50.950Z,1734724370.950 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-20T19:53:05.885Z,1734724385.885 [NAL9602](INFO): SBD MO Status=2, MOMSN=11701, MT Status=2, MTMSN=0 2024-12-20T19:53:05.886Z,1734724385.886 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-12-20T19:53:51.169Z,1734724431.169 [NAL9602](INFO): SBD MO Status=2, MOMSN=11701, MT Status=2, MTMSN=0 2024-12-20T19:53:51.169Z,1734724431.169 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-12-20T19:53:54.138Z,1734724434.138 [MassServo](ERROR): getPosition uart error serial timeout 2024-12-20T19:54:10.166Z,1734724450.166 [NAL9602](INFO): SBD MO Status=2, MOMSN=11701, MT Status=2, MTMSN=0 2024-12-20T19:54:10.167Z,1734724450.167 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-12-20T19:54:43.741Z,1734724483.741 [NAL9602](INFO): SBD MO Status=0, MOMSN=11701, MT Status=0, MTMSN=0 2024-12-20T19:54:43.741Z,1734724483.741 [NAL9602](INFO): No messages in MT queue 2024-12-20T19:55:14.573Z,1734724514.573 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-20T19:57:51.622Z,1734724671.622 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-20T19:57:51.622Z,1734724671.622 [Default:CheckIn:C.Wait] Stopped 2024-12-20T19:57:51.622Z,1734724671.622 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-20T19:57:51.623Z,1734724671.623 [Default:CheckIn:D] Running Loop=1 2024-12-20T19:57:52.036Z,1734724672.036 [Default:CheckIn:D] Stopped 2024-12-20T19:57:52.036Z,1734724672.036 [Default:CheckIn:E] Running Loop=1 2024-12-20T19:57:52.460Z,1734724672.460 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 81.764510 min 2024-12-20T19:57:52.460Z,1734724672.460 [Default:CheckIn:E] Stopped 2024-12-20T19:57:52.460Z,1734724672.460 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-20T19:57:52.460Z,1734724672.460 [Default:CheckIn] Stopped 2024-12-20T19:57:52.460Z,1734724672.460 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-20T19:57:52.460Z,1734724672.460 [Default:CheckIn](INFO): Running loop #15 2024-12-20T19:57:52.460Z,1734724672.460 [Default:CheckIn] Running Loop=15 2024-12-20T19:57:52.461Z,1734724672.461 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-20T19:57:52.461Z,1734724672.461 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-20T19:57:54.495Z,1734724674.495 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,195753.00,A,3648.17968,N,12147.27888,W,0.564,196.12,201224,,,A*79 2024-12-20T19:57:54.498Z,1734724674.498 [NAL9602](INFO): GPS fix at 20241220T195753: (36.802995, -121.787981) 2024-12-20T19:57:54.576Z,1734724674.576 [Default:CheckIn:Read_GPS] Stopped 2024-12-20T19:57:54.576Z,1734724674.576 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-20T19:58:09.350Z,1734724689.350 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20241220T185136/Courier0036.lzma 2024-12-20T19:58:10.352Z,1734724690.352 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Courier0036.lzma.bak 2024-12-20T19:58:10.352Z,1734724690.352 [DataOverHttps](INFO): SBD MOMSN=23850456 2024-12-20T19:58:33.482Z,1734724713.482 [DataOverHttps](INFO): Sending 129 bytes from file Logs/20241220T185136/Express0037.lzma 2024-12-20T19:58:34.484Z,1734724714.484 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Express0037.lzma.bak 2024-12-20T19:58:34.485Z,1734724714.485 [DataOverHttps](INFO): SBD MOMSN=23850459 2024-12-20T19:58:37.954Z,1734724717.954 [Default:CheckIn:Read_Iridium] Stopped 2024-12-20T19:58:37.974Z,1734724717.974 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-20T19:58:37.975Z,1734724717.975 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-20T19:59:15.222Z,1734724755.222 [NAL9602](INFO): SBD MO Status=2, MOMSN=11702, MT Status=2, MTMSN=0 2024-12-20T19:59:15.222Z,1734724755.222 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-12-20T19:59:35.243Z,1734724775.243 [NAL9602](INFO): SBD MO Status=2, MOMSN=11702, MT Status=2, MTMSN=0 2024-12-20T19:59:35.243Z,1734724775.243 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-12-20T19:59:46.268Z,1734724786.268 [MassServo](ERROR): getPosition uart error serial timeout 2024-12-20T19:59:46.588Z,1734724786.588 [MassServo](FAULT): Not Initialized Error 2024-12-20T19:59:46.589Z,1734724786.589 [MassServo] Hardware Fault, FailCount= 3 2024-12-20T19:59:46.589Z,1734724786.589 [MassServo](ERROR): Hardware Fault 2024-12-20T19:59:46.643Z,1734724786.643 [CBIT](ERROR): Hardware Fault in component: MassServo 2024-12-20T19:59:47.009Z,1734724787.009 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-12-20T19:59:47.009Z,1734724787.009 [MassServo](INFO): Powering down 2024-12-20T19:59:47.874Z,1734724787.874 [MassServo](DEBUG): Initializing EZServoServo. 2024-12-20T19:59:47.987Z,1734724787.987 [MassServo](DEBUG): Initializing MassServo. 2024-12-20T19:59:47.995Z,1734724787.995 [CBIT](INFO): Clearing failed state for component MassServo 2024-12-20T19:59:47.995Z,1734724787.995 [MassServo] No Fault, FailCount= 3 2024-12-20T20:02:57.043Z,1734724977.043 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-12-20T20:03:27.755Z,1734725007.755 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-20T20:03:38.676Z,1734725018.676 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-20T20:03:38.676Z,1734725018.676 [Default:CheckIn:C.Wait] Stopped 2024-12-20T20:03:38.676Z,1734725018.676 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-20T20:03:38.676Z,1734725018.676 [Default:CheckIn:D] Running Loop=1 2024-12-20T20:03:39.098Z,1734725019.098 [Default:CheckIn:D] Stopped 2024-12-20T20:03:39.098Z,1734725019.098 [Default:CheckIn:E] Running Loop=1 2024-12-20T20:03:39.504Z,1734725019.504 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 87.548869 min 2024-12-20T20:03:39.504Z,1734725019.504 [Default:CheckIn:E] Stopped 2024-12-20T20:03:39.505Z,1734725019.505 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-20T20:03:39.505Z,1734725019.505 [Default:CheckIn] Stopped 2024-12-20T20:03:39.505Z,1734725019.505 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-20T20:03:39.505Z,1734725019.505 [Default:CheckIn](INFO): Running loop #16 2024-12-20T20:03:39.505Z,1734725019.505 [Default:CheckIn] Running Loop=16 2024-12-20T20:03:39.505Z,1734725019.505 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-20T20:03:39.505Z,1734725019.505 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-20T20:03:41.500Z,1734725021.500 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,200340.00,A,3648.16892,N,12147.27972,W,0.233,145.44,201224,,,A*79 2024-12-20T20:03:41.502Z,1734725021.502 [NAL9602](INFO): GPS fix at 20241220T200340: (36.802815, -121.787995) 2024-12-20T20:03:41.515Z,1734725021.515 [Default:CheckIn:Read_GPS] Stopped 2024-12-20T20:03:41.515Z,1734725021.515 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-20T20:03:47.451Z,1734725027.451 [MassServo](ERROR): getPosition uart error serial timeout 2024-12-20T20:03:47.455Z,1734725027.455 [MassServo](FAULT): Invalid EZ Servo response:"\377" 2024-12-20T20:03:47.455Z,1734725027.455 [MassServo] Communications Fault, FailCount= 4 2024-12-20T20:03:47.455Z,1734725027.455 [MassServo](ERROR): Communications Fault 2024-12-20T20:03:47.503Z,1734725027.503 [CBIT](ERROR): Communications Fault in component: MassServo 2024-12-20T20:03:47.724Z,1734725027.724 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-12-20T20:03:47.724Z,1734725027.724 [MassServo](INFO): Powering down 2024-12-20T20:03:48.577Z,1734725028.577 [MassServo](DEBUG): Initializing EZServoServo. 2024-12-20T20:03:48.691Z,1734725028.691 [MassServo](DEBUG): Initializing MassServo. 2024-12-20T20:03:48.696Z,1734725028.696 [CBIT](INFO): Clearing failed state for component MassServo 2024-12-20T20:03:48.696Z,1734725028.696 [MassServo] No Fault, FailCount= 4 2024-12-20T20:03:55.342Z,1734725035.342 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20241220T185136/Courier0039.lzma 2024-12-20T20:03:56.344Z,1734725036.344 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Courier0039.lzma.bak 2024-12-20T20:03:56.344Z,1734725036.344 [DataOverHttps](INFO): SBD MOMSN=23850484 2024-12-20T20:04:12.309Z,1734725052.309 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2024-12-20T20:04:12.391Z,1734725052.391 [NAL9602](ERROR): received: +CSQ:0 OK702, 2, 0, 0, 0 OK 2024-12-20T20:04:17.564Z,1734725057.564 [DataOverHttps](INFO): Sending 233 bytes from file Logs/20241220T185136/Express0040.lzma 2024-12-20T20:04:18.570Z,1734725058.570 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Express0040.lzma.bak 2024-12-20T20:04:18.570Z,1734725058.570 [DataOverHttps](INFO): SBD MOMSN=23850490 2024-12-20T20:04:22.904Z,1734725062.904 [Default:CheckIn:Read_Iridium] Stopped 2024-12-20T20:04:22.904Z,1734725062.904 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-20T20:04:22.904Z,1734725062.904 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-20T20:05:39.779Z,1734725139.779 [NAL9602](INFO): SBD MO Status=2, MOMSN=11702, MT Status=2, MTMSN=0 2024-12-20T20:05:39.779Z,1734725139.779 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-12-20T20:06:30.325Z,1734725190.325 [NAL9602](INFO): SBD MO Status=2, MOMSN=11702, MT Status=2, MTMSN=0 2024-12-20T20:06:30.325Z,1734725190.325 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-12-20T20:07:41.999Z,1734725261.999 [NAL9602](INFO): SBD MO Status=0, MOMSN=11702, MT Status=0, MTMSN=0 2024-12-20T20:07:41.999Z,1734725261.999 [NAL9602](INFO): No messages in MT queue 2024-12-20T20:08:12.789Z,1734725292.789 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-20T20:09:23.550Z,1734725363.550 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-20T20:09:23.550Z,1734725363.550 [Default:CheckIn:C.Wait] Stopped 2024-12-20T20:09:23.550Z,1734725363.550 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-20T20:09:23.551Z,1734725363.551 [Default:CheckIn:D] Running Loop=1 2024-12-20T20:09:23.939Z,1734725363.939 [Default:CheckIn:D] Stopped 2024-12-20T20:09:23.939Z,1734725363.939 [Default:CheckIn:E] Running Loop=1 2024-12-20T20:09:24.365Z,1734725364.365 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 93.296224 min 2024-12-20T20:09:24.365Z,1734725364.365 [Default:CheckIn:E] Stopped 2024-12-20T20:09:24.365Z,1734725364.365 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-20T20:09:24.365Z,1734725364.365 [Default:CheckIn] Stopped 2024-12-20T20:09:24.365Z,1734725364.365 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-20T20:09:24.365Z,1734725364.365 [Default:CheckIn](INFO): Running loop #17 2024-12-20T20:09:24.365Z,1734725364.365 [Default:CheckIn] Running Loop=17 2024-12-20T20:09:24.365Z,1734725364.365 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-20T20:09:24.365Z,1734725364.365 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-20T20:09:26.342Z,1734725366.342 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,200925.00,A,3648.17533,N,12147.28373,W,0.253,294.57,201224,,,A*78 2024-12-20T20:09:26.344Z,1734725366.344 [NAL9602](INFO): GPS fix at 20241220T200925: (36.802922, -121.788062) 2024-12-20T20:09:26.364Z,1734725366.364 [Default:CheckIn:Read_GPS] Stopped 2024-12-20T20:09:26.364Z,1734725366.364 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-20T20:09:38.303Z,1734725378.303 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20241220T185136/Courier0042.lzma 2024-12-20T20:09:39.307Z,1734725379.307 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Courier0042.lzma.bak 2024-12-20T20:09:39.307Z,1734725379.307 [DataOverHttps](INFO): SBD MOMSN=23850532 2024-12-20T20:09:59.432Z,1734725399.432 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20241220T185136/Express0043.lzma 2024-12-20T20:10:00.434Z,1734725400.434 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Express0043.lzma.bak 2024-12-20T20:10:00.434Z,1734725400.434 [DataOverHttps](INFO): SBD MOMSN=23850534 2024-12-20T20:10:04.647Z,1734725404.647 [Default:CheckIn:Read_Iridium] Stopped 2024-12-20T20:10:04.647Z,1734725404.647 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-20T20:10:04.647Z,1734725404.647 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-20T20:14:28.987Z,1734725668.987 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-12-20T20:14:59.744Z,1734725699.744 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-20T20:15:05.415Z,1734725705.415 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-20T20:15:05.415Z,1734725705.415 [Default:CheckIn:C.Wait] Stopped 2024-12-20T20:15:05.415Z,1734725705.415 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-20T20:15:05.415Z,1734725705.415 [Default:CheckIn:D] Running Loop=1 2024-12-20T20:15:05.816Z,1734725705.816 [Default:CheckIn:D] Stopped 2024-12-20T20:15:05.816Z,1734725705.816 [Default:CheckIn:E] Running Loop=1 2024-12-20T20:15:06.212Z,1734725706.212 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 98.994173 min 2024-12-20T20:15:06.212Z,1734725706.212 [Default:CheckIn:E] Stopped 2024-12-20T20:15:06.212Z,1734725706.212 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-20T20:15:06.212Z,1734725706.212 [Default:CheckIn] Stopped 2024-12-20T20:15:06.212Z,1734725706.212 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-20T20:15:06.212Z,1734725706.212 [Default:CheckIn](INFO): Running loop #18 2024-12-20T20:15:06.212Z,1734725706.212 [Default:CheckIn] Running Loop=18 2024-12-20T20:15:06.213Z,1734725706.213 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-20T20:15:06.213Z,1734725706.213 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-20T20:15:08.229Z,1734725708.229 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,201507.00,A,3648.17269,N,12147.28000,W,0.097,352.21,201224,,,A*7A 2024-12-20T20:15:08.231Z,1734725708.231 [NAL9602](INFO): GPS fix at 20241220T201507: (36.802878, -121.788000) 2024-12-20T20:15:08.251Z,1734725708.251 [Default:CheckIn:Read_GPS] Stopped 2024-12-20T20:15:08.251Z,1734725708.251 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-20T20:15:22.686Z,1734725722.686 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20241220T185136/Courier0045.lzma 2024-12-20T20:15:23.688Z,1734725723.688 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Courier0045.lzma.bak 2024-12-20T20:15:23.688Z,1734725723.688 [DataOverHttps](INFO): SBD MOMSN=23850553 2024-12-20T20:15:38.740Z,1734725738.740 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2024-12-20T20:15:38.815Z,1734725738.815 [NAL9602](ERROR): received: +CSQ:1 OK702, 0, 0, 0, 0 OK 2024-12-20T20:15:43.898Z,1734725743.898 [DataOverHttps](INFO): Sending 205 bytes from file Logs/20241220T185136/Express0046.lzma 2024-12-20T20:15:48.197Z,1734725748.197 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Express0046.lzma.bak 2024-12-20T20:15:48.197Z,1734725748.197 [DataOverHttps](INFO): SBD MOMSN=23850556 2024-12-20T20:15:50.425Z,1734725750.425 [Default:CheckIn:Read_Iridium] Stopped 2024-12-20T20:15:50.427Z,1734725750.427 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-20T20:15:50.427Z,1734725750.427 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-20T20:15:54.101Z,1734725754.101 [NAL9602](INFO): SBD MO Status=0, MOMSN=11703, MT Status=0, MTMSN=0 2024-12-20T20:15:54.101Z,1734725754.101 [NAL9602](INFO): No messages in MT queue 2024-12-20T20:16:24.859Z,1734725784.859 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-20T20:18:06.442Z,1734725886.442 [MassServo](ERROR): getPosition uart error serial timeout 2024-12-20T20:18:06.443Z,1734725886.443 [MassServo](FAULT): Invalid EZ Servo response:"\377" 2024-12-20T20:18:06.443Z,1734725886.443 [MassServo] Communications Fault, FailCount= 5 2024-12-20T20:18:06.443Z,1734725886.443 [MassServo](ERROR): Communications Fault 2024-12-20T20:18:06.455Z,1734725886.455 [CBIT](ERROR): Communications Fault in component: MassServo 2024-12-20T20:18:06.455Z,1734725886.455 [CBIT](CRITICAL): Communications Fault in component: MassServo 2024-12-20T20:18:06.793Z,1734725886.793 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-12-20T20:18:06.793Z,1734725886.793 [MassServo](INFO): Powering down 2024-12-20T20:18:06.796Z,1734725886.796 [CBIT](INFO): Critical error at 20241220T201806 2024-12-20T20:18:07.653Z,1734725887.653 [MassServo](DEBUG): Initializing EZServoServo. 2024-12-20T20:18:07.783Z,1734725887.783 [MassServo](DEBUG): Initializing MassServo. 2024-12-20T20:20:51.235Z,1734726051.235 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-20T20:20:51.235Z,1734726051.235 [Default:CheckIn:C.Wait] Stopped 2024-12-20T20:20:51.235Z,1734726051.235 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-20T20:20:51.236Z,1734726051.236 [Default:CheckIn:D] Running Loop=1 2024-12-20T20:20:51.623Z,1734726051.623 [Default:CheckIn:D] Stopped 2024-12-20T20:20:51.623Z,1734726051.623 [Default:CheckIn:E] Running Loop=1 2024-12-20T20:20:52.020Z,1734726052.020 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 104.757625 min 2024-12-20T20:20:52.020Z,1734726052.020 [Default:CheckIn:E] Stopped 2024-12-20T20:20:52.020Z,1734726052.020 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-20T20:20:52.020Z,1734726052.020 [Default:CheckIn] Stopped 2024-12-20T20:20:52.020Z,1734726052.020 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-20T20:20:52.021Z,1734726052.021 [Default:CheckIn](INFO): Running loop #19 2024-12-20T20:20:52.021Z,1734726052.021 [Default:CheckIn] Running Loop=19 2024-12-20T20:20:52.021Z,1734726052.021 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-20T20:20:52.021Z,1734726052.021 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-20T20:20:54.021Z,1734726054.021 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,202052.00,A,3648.16956,N,12147.28244,W,0.194,139.27,201224,,,A*73 2024-12-20T20:20:54.023Z,1734726054.023 [NAL9602](INFO): GPS fix at 20241220T202052: (36.802826, -121.788041) 2024-12-20T20:20:54.054Z,1734726054.054 [Default:CheckIn:Read_GPS] Stopped 2024-12-20T20:20:54.054Z,1734726054.054 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-20T20:21:06.680Z,1734726066.680 [DataOverHttps](INFO): Sending 124 bytes from file Logs/20241220T185136/Courier0048.lzma 2024-12-20T20:21:07.681Z,1734726067.681 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Courier0048.lzma.bak 2024-12-20T20:21:07.682Z,1734726067.682 [DataOverHttps](INFO): SBD MOMSN=23850587 2024-12-20T20:21:30.150Z,1734726090.150 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20241220T185136/Express0049.lzma 2024-12-20T20:21:31.152Z,1734726091.152 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Express0049.lzma.bak 2024-12-20T20:21:31.152Z,1734726091.152 [DataOverHttps](INFO): SBD MOMSN=23850595 2024-12-20T20:21:34.227Z,1734726094.227 [Default:CheckIn:Read_Iridium] Stopped 2024-12-20T20:21:34.227Z,1734726094.227 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-20T20:21:34.228Z,1734726094.228 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-20T20:23:06.783Z,1734726186.783 [CBIT](INFO): Clearing failed state for component MassServo 2024-12-20T20:23:06.783Z,1734726186.783 [MassServo] No Fault, FailCount= 5 2024-12-20T20:24:17.425Z,1734726257.425 [NAL9602](INFO): SBD MO Status=2, MOMSN=11704, MT Status=2, MTMSN=0 2024-12-20T20:24:17.426Z,1734726257.426 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-12-20T20:24:52.169Z,1734726292.169 [NAL9602](INFO): SBD MO Status=2, MOMSN=11704, MT Status=2, MTMSN=0 2024-12-20T20:24:52.169Z,1734726292.169 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-12-20T20:25:10.763Z,1734726310.763 [NAL9602](INFO): SBD MO Status=2, MOMSN=11704, MT Status=2, MTMSN=0 2024-12-20T20:25:10.764Z,1734726310.764 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-12-20T20:25:17.625Z,1734726317.625 [NAL9602](INFO): SBD MO Status=0, MOMSN=11704, MT Status=0, MTMSN=0 2024-12-20T20:25:17.625Z,1734726317.625 [NAL9602](INFO): No messages in MT queue 2024-12-20T20:25:48.331Z,1734726348.331 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-20T20:26:34.819Z,1734726394.819 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-20T20:26:34.819Z,1734726394.819 [Default:CheckIn:C.Wait] Stopped 2024-12-20T20:26:34.819Z,1734726394.819 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-20T20:26:34.819Z,1734726394.819 [Default:CheckIn:D] Running Loop=1 2024-12-20T20:26:35.225Z,1734726395.225 [Default:CheckIn:D] Stopped 2024-12-20T20:26:35.225Z,1734726395.225 [Default:CheckIn:E] Running Loop=1 2024-12-20T20:26:35.637Z,1734726395.637 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 110.484326 min 2024-12-20T20:26:35.637Z,1734726395.637 [Default:CheckIn:E] Stopped 2024-12-20T20:26:35.637Z,1734726395.637 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-20T20:26:35.638Z,1734726395.638 [Default:CheckIn] Stopped 2024-12-20T20:26:35.638Z,1734726395.638 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-20T20:26:35.638Z,1734726395.638 [Default:CheckIn](INFO): Running loop #20 2024-12-20T20:26:35.638Z,1734726395.638 [Default:CheckIn] Running Loop=20 2024-12-20T20:26:35.638Z,1734726395.638 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-20T20:26:35.638Z,1734726395.638 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-20T20:26:37.625Z,1734726397.625 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,202636.00,A,3648.16891,N,12147.27593,W,0.525,147.26,201224,,,A*79 2024-12-20T20:26:37.627Z,1734726397.627 [NAL9602](INFO): GPS fix at 20241220T202636: (36.802815, -121.787932) 2024-12-20T20:26:37.638Z,1734726397.638 [Default:CheckIn:Read_GPS] Stopped 2024-12-20T20:26:37.638Z,1734726397.638 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-20T20:26:48.323Z,1734726408.323 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20241220T185136/Courier0051.lzma 2024-12-20T20:26:49.328Z,1734726409.328 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Courier0051.lzma.bak 2024-12-20T20:26:49.328Z,1734726409.328 [DataOverHttps](INFO): SBD MOMSN=23850614 2024-12-20T20:26:52.569Z,1734726412.569 [NAL9602](INFO): SBD MO Status=0, MOMSN=11705, MT Status=0, MTMSN=0 2024-12-20T20:26:52.569Z,1734726412.569 [NAL9602](INFO): No messages in MT queue 2024-12-20T20:27:13.315Z,1734726433.315 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20241220T185136/Express0052.lzma 2024-12-20T20:27:14.316Z,1734726434.316 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Express0052.lzma.bak 2024-12-20T20:27:14.316Z,1734726434.316 [DataOverHttps](INFO): SBD MOMSN=23850621 2024-12-20T20:27:17.264Z,1734726437.264 [Default:CheckIn:Read_Iridium] Stopped 2024-12-20T20:27:17.264Z,1734726437.264 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-20T20:27:17.264Z,1734726437.264 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-20T20:27:23.307Z,1734726443.307 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-20T20:30:34.630Z,1734726634.630 [MassServo](ERROR): getPosition uart error serial timeout 2024-12-20T20:32:16.676Z,1734726736.676 [BPC1](ERROR): BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file). 2024-12-20T20:32:17.904Z,1734726737.904 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-20T20:32:17.904Z,1734726737.904 [Default:CheckIn:C.Wait] Stopped 2024-12-20T20:32:17.905Z,1734726737.905 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-20T20:32:17.905Z,1734726737.905 [Default:CheckIn:D] Running Loop=1 2024-12-20T20:32:18.338Z,1734726738.338 [Default:CheckIn:D] Stopped 2024-12-20T20:32:18.338Z,1734726738.338 [Default:CheckIn:E] Running Loop=1 2024-12-20T20:32:18.726Z,1734726738.726 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 116.202873 min 2024-12-20T20:32:18.726Z,1734726738.726 [Default:CheckIn:E] Stopped 2024-12-20T20:32:18.726Z,1734726738.726 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-20T20:32:18.726Z,1734726738.726 [Default:CheckIn] Stopped 2024-12-20T20:32:18.726Z,1734726738.726 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-20T20:32:18.726Z,1734726738.726 [Default:CheckIn](INFO): Running loop #21 2024-12-20T20:32:18.727Z,1734726738.727 [Default:CheckIn] Running Loop=21 2024-12-20T20:32:18.727Z,1734726738.727 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-20T20:32:18.727Z,1734726738.727 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-20T20:32:20.717Z,1734726740.717 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,203219.00,A,3648.16577,N,12147.27909,W,0.292,135.12,201224,,,A*72 2024-12-20T20:32:20.719Z,1734726740.719 [NAL9602](INFO): GPS fix at 20241220T203219: (36.802763, -121.787985) 2024-12-20T20:32:20.747Z,1734726740.747 [Default:CheckIn:Read_GPS] Stopped 2024-12-20T20:32:20.747Z,1734726740.747 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-20T20:32:29.840Z,1734726749.840 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20241220T185136/Courier0054.lzma 2024-12-20T20:32:30.842Z,1734726750.842 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Courier0054.lzma.bak 2024-12-20T20:32:30.842Z,1734726750.842 [DataOverHttps](INFO): SBD MOMSN=23850652 2024-12-20T20:32:49.360Z,1734726769.360 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20241220T185136/Express0055.lzma 2024-12-20T20:32:50.362Z,1734726770.362 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Express0055.lzma.bak 2024-12-20T20:32:50.362Z,1734726770.362 [DataOverHttps](INFO): SBD MOMSN=23850658 2024-12-20T20:32:53.884Z,1734726773.884 [Default:CheckIn:Read_Iridium] Stopped 2024-12-20T20:32:53.885Z,1734726773.885 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-20T20:32:53.885Z,1734726773.885 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-20T20:33:14.116Z,1734726794.116 [BPC1](ERROR): Battery stick #62 (s/n: 00CC) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0. 2024-12-20T20:33:14.117Z,1734726794.117 [BPC1](INFO): Calculating totals. Valid battery stick count: 27. Valid reserve battery stick count: 3. 2024-12-20T20:33:14.123Z,1734726794.123 [BPC1](FAULT): Failed to receive data from 32 sticks prior to timeout. Will not retry this scan cycle. Missing stick IDs are: 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30, 31, 62. 2024-12-20T20:34:27.242Z,1734726867.242 [NAL9602](INFO): SBD MO Status=0, MOMSN=11706, MT Status=0, MTMSN=0 2024-12-20T20:34:27.243Z,1734726867.243 [NAL9602](INFO): No messages in MT queue 2024-12-20T20:34:57.944Z,1734726897.944 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-20T20:37:54.315Z,1734727074.315 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-20T20:37:54.315Z,1734727074.315 [Default:CheckIn:C.Wait] Stopped 2024-12-20T20:37:54.315Z,1734727074.315 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-20T20:37:54.315Z,1734727074.315 [Default:CheckIn:D] Running Loop=1 2024-12-20T20:37:54.705Z,1734727074.705 [Default:CheckIn:D] Stopped 2024-12-20T20:37:54.705Z,1734727074.705 [Default:CheckIn:E] Running Loop=1 2024-12-20T20:37:55.109Z,1734727075.109 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 121.808993 min 2024-12-20T20:37:55.110Z,1734727075.110 [Default:CheckIn:E] Stopped 2024-12-20T20:37:55.110Z,1734727075.110 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-20T20:37:55.110Z,1734727075.110 [Default:CheckIn] Stopped 2024-12-20T20:37:55.110Z,1734727075.110 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-20T20:37:55.110Z,1734727075.110 [Default:CheckIn](INFO): Running loop #22 2024-12-20T20:37:55.110Z,1734727075.110 [Default:CheckIn] Running Loop=22 2024-12-20T20:37:55.110Z,1734727075.110 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-20T20:37:55.110Z,1734727075.110 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-20T20:37:57.128Z,1734727077.128 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,203756.00,A,3648.17502,N,12147.27972,W,0.292,335.57,201224,,,A*70 2024-12-20T20:37:57.130Z,1734727077.130 [NAL9602](INFO): GPS fix at 20241220T203756: (36.802917, -121.787995) 2024-12-20T20:37:57.141Z,1734727077.141 [Default:CheckIn:Read_GPS] Stopped 2024-12-20T20:37:57.142Z,1734727077.142 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-20T20:38:05.953Z,1734727085.953 [DataOverHttps](INFO): Sending 83 bytes from file Logs/20241220T185136/Courier0057.lzma 2024-12-20T20:38:06.955Z,1734727086.955 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Courier0057.lzma.bak 2024-12-20T20:38:06.955Z,1734727086.955 [DataOverHttps](INFO): SBD MOMSN=23850676 2024-12-20T20:38:25.550Z,1734727105.550 [DataOverHttps](INFO): Sending 285 bytes from file Logs/20241220T185136/Express0058.lzma 2024-12-20T20:38:26.551Z,1734727106.551 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Express0058.lzma.bak 2024-12-20T20:38:26.551Z,1734727106.551 [DataOverHttps](INFO): SBD MOMSN=23850682 2024-12-20T20:38:29.897Z,1734727109.897 [Default:CheckIn:Read_Iridium] Stopped 2024-12-20T20:38:29.897Z,1734727109.897 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-20T20:38:29.897Z,1734727109.897 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-20T20:42:59.351Z,1734727379.351 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-12-20T20:43:30.050Z,1734727410.050 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-20T20:43:30.464Z,1734727410.464 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-20T20:43:30.465Z,1734727410.465 [Default:CheckIn:C.Wait] Stopped 2024-12-20T20:43:30.465Z,1734727410.465 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-20T20:43:30.466Z,1734727410.466 [Default:CheckIn:D] Running Loop=1 2024-12-20T20:43:30.864Z,1734727410.864 [Default:CheckIn:D] Stopped 2024-12-20T20:43:30.864Z,1734727410.864 [Default:CheckIn:E] Running Loop=1 2024-12-20T20:43:31.277Z,1734727411.277 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 127.411646 min 2024-12-20T20:43:31.277Z,1734727411.277 [Default:CheckIn:E] Stopped 2024-12-20T20:43:31.277Z,1734727411.277 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-20T20:43:31.277Z,1734727411.277 [Default:CheckIn] Stopped 2024-12-20T20:43:31.277Z,1734727411.277 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-20T20:43:31.277Z,1734727411.277 [Default:CheckIn](INFO): Running loop #23 2024-12-20T20:43:31.277Z,1734727411.277 [Default:CheckIn] Running Loop=23 2024-12-20T20:43:31.278Z,1734727411.278 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-20T20:43:31.278Z,1734727411.278 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-20T20:43:33.286Z,1734727413.286 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,204332.00,A,3648.17476,N,12147.27668,W,0.214,335.57,201224,,,A*79 2024-12-20T20:43:33.288Z,1734727413.288 [NAL9602](INFO): GPS fix at 20241220T204332: (36.802913, -121.787945) 2024-12-20T20:43:33.299Z,1734727413.299 [Default:CheckIn:Read_GPS] Stopped 2024-12-20T20:43:33.299Z,1734727413.299 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-20T20:43:42.342Z,1734727422.342 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20241220T185136/Courier0060.lzma 2024-12-20T20:43:44.029Z,1734727424.029 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Courier0060.lzma.bak 2024-12-20T20:43:44.029Z,1734727424.029 [DataOverHttps](INFO): SBD MOMSN=23850724 2024-12-20T20:44:03.982Z,1734727443.982 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2024-12-20T20:44:04.066Z,1734727444.066 [NAL9602](ERROR): received: +CSQ:0 OK706, 0, 0, 0, 0 OK 2024-12-20T20:44:06.039Z,1734727446.039 [DataOverHttps](INFO): Sending 208 bytes from file Logs/20241220T185136/Express0061.lzma 2024-12-20T20:44:07.040Z,1734727447.040 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Express0061.lzma.bak 2024-12-20T20:44:07.040Z,1734727447.040 [DataOverHttps](INFO): SBD MOMSN=23850728 2024-12-20T20:44:10.082Z,1734727450.082 [Default:CheckIn:Read_Iridium] Stopped 2024-12-20T20:44:10.083Z,1734727450.083 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-20T20:44:10.083Z,1734727450.083 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-20T20:44:16.916Z,1734727456.916 [NAL9602](INFO): SBD MO Status=0, MOMSN=11707, MT Status=0, MTMSN=0 2024-12-20T20:44:16.916Z,1734727456.916 [NAL9602](INFO): No messages in MT queue 2024-12-20T20:44:47.618Z,1734727487.618 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-20T20:49:10.647Z,1734727750.647 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-20T20:49:10.647Z,1734727750.647 [Default:CheckIn:C.Wait] Stopped 2024-12-20T20:49:10.647Z,1734727750.647 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-20T20:49:10.648Z,1734727750.648 [Default:CheckIn:D] Running Loop=1 2024-12-20T20:49:11.040Z,1734727751.040 [Default:CheckIn:D] Stopped 2024-12-20T20:49:11.040Z,1734727751.040 [Default:CheckIn:E] Running Loop=1 2024-12-20T20:49:11.438Z,1734727751.438 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 133.081242 min 2024-12-20T20:49:11.438Z,1734727751.438 [Default:CheckIn:E] Stopped 2024-12-20T20:49:11.438Z,1734727751.438 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-20T20:49:11.438Z,1734727751.438 [Default:CheckIn] Stopped 2024-12-20T20:49:11.438Z,1734727751.438 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-20T20:49:11.438Z,1734727751.438 [Default:CheckIn](INFO): Running loop #24 2024-12-20T20:49:11.438Z,1734727751.438 [Default:CheckIn] Running Loop=24 2024-12-20T20:49:11.438Z,1734727751.438 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-20T20:49:11.438Z,1734727751.438 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-20T20:49:13.455Z,1734727753.455 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,204912.00,A,3648.17204,N,12147.28275,W,0.739,338.00,201224,,,A*70 2024-12-20T20:49:13.457Z,1734727753.457 [NAL9602](INFO): GPS fix at 20241220T204912: (36.802867, -121.788046) 2024-12-20T20:49:13.469Z,1734727753.469 [Default:CheckIn:Read_GPS] Stopped 2024-12-20T20:49:13.469Z,1734727753.469 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-20T20:49:25.405Z,1734727765.405 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20241220T185136/Courier0063.lzma 2024-12-20T20:49:26.407Z,1734727766.407 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Courier0063.lzma.bak 2024-12-20T20:49:26.407Z,1734727766.407 [DataOverHttps](INFO): SBD MOMSN=23850757 2024-12-20T20:49:46.929Z,1734727786.929 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20241220T185136/Express0064.lzma 2024-12-20T20:49:47.927Z,1734727787.927 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Express0064.lzma.bak 2024-12-20T20:49:47.928Z,1734727787.928 [DataOverHttps](INFO): SBD MOMSN=23850760 2024-12-20T20:49:56.508Z,1734727796.508 [Default:CheckIn:Read_Iridium] Stopped 2024-12-20T20:49:56.509Z,1734727796.509 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-20T20:49:56.513Z,1734727796.513 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-20T20:51:19.332Z,1734727879.332 [NAL9602](INFO): SBD MO Status=2, MOMSN=11708, MT Status=2, MTMSN=0 2024-12-20T20:51:19.332Z,1734727879.332 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-12-20T20:52:21.150Z,1734727941.150 [NAL9602](INFO): SBD MO Status=2, MOMSN=11708, MT Status=2, MTMSN=0 2024-12-20T20:52:21.150Z,1734727941.150 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-12-20T20:52:37.323Z,1734727957.323 [NAL9602](INFO): SBD MO Status=2, MOMSN=11708, MT Status=2, MTMSN=0 2024-12-20T20:52:37.323Z,1734727957.323 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-12-20T20:52:56.296Z,1734727976.296 [NAL9602](INFO): SBD MO Status=0, MOMSN=11708, MT Status=0, MTMSN=0 2024-12-20T20:52:56.297Z,1734727976.297 [NAL9602](INFO): No messages in MT queue 2024-12-20T20:53:27.006Z,1734728007.006 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-20T20:54:57.104Z,1734728097.104 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-20T20:54:57.104Z,1734728097.104 [Default:CheckIn:C.Wait] Stopped 2024-12-20T20:54:57.104Z,1734728097.104 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-20T20:54:57.104Z,1734728097.104 [Default:CheckIn:D] Running Loop=1 2024-12-20T20:54:57.505Z,1734728097.505 [Default:CheckIn:D] Stopped 2024-12-20T20:54:57.505Z,1734728097.505 [Default:CheckIn:E] Running Loop=1 2024-12-20T20:54:57.914Z,1734728097.914 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 138.855648 min 2024-12-20T20:54:57.914Z,1734728097.914 [Default:CheckIn:E] Stopped 2024-12-20T20:54:57.914Z,1734728097.914 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-20T20:54:57.914Z,1734728097.914 [Default:CheckIn] Stopped 2024-12-20T20:54:57.914Z,1734728097.914 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-20T20:54:57.915Z,1734728097.915 [Default:CheckIn](INFO): Running loop #25 2024-12-20T20:54:57.915Z,1734728097.915 [Default:CheckIn] Running Loop=25 2024-12-20T20:54:57.915Z,1734728097.915 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-20T20:54:57.915Z,1734728097.915 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-20T20:54:59.940Z,1734728099.940 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,205458.00,A,3648.17332,N,12147.27747,W,0.700,318.77,201224,,,A*75 2024-12-20T20:54:59.943Z,1734728099.943 [NAL9602](INFO): GPS fix at 20241220T205458: (36.802889, -121.787958) 2024-12-20T20:54:59.958Z,1734728099.958 [Default:CheckIn:Read_GPS] Stopped 2024-12-20T20:54:59.958Z,1734728099.958 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-20T20:55:12.953Z,1734728112.953 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20241220T185136/Courier0066.lzma 2024-12-20T20:55:13.955Z,1734728113.955 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Courier0066.lzma.bak 2024-12-20T20:55:13.955Z,1734728113.955 [DataOverHttps](INFO): SBD MOMSN=23850790 2024-12-20T20:55:31.927Z,1734728131.927 [NAL9602](INFO): SBD MO Status=0, MOMSN=11709, MT Status=0, MTMSN=0 2024-12-20T20:55:31.927Z,1734728131.927 [NAL9602](INFO): No messages in MT queue 2024-12-20T20:55:37.477Z,1734728137.477 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20241220T185136/Express0067.lzma 2024-12-20T20:55:38.483Z,1734728138.483 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Express0067.lzma.bak 2024-12-20T20:55:38.483Z,1734728138.483 [DataOverHttps](INFO): SBD MOMSN=23850793 2024-12-20T20:55:41.649Z,1734728141.649 [Default:CheckIn:Read_Iridium] Stopped 2024-12-20T20:55:41.649Z,1734728141.649 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-20T20:55:41.649Z,1734728141.649 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-20T20:56:02.626Z,1734728162.626 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-20T21:00:42.413Z,1734728442.413 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-20T21:00:42.413Z,1734728442.413 [Default:CheckIn:C.Wait] Stopped 2024-12-20T21:00:42.414Z,1734728442.414 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-20T21:00:42.414Z,1734728442.414 [Default:CheckIn:D] Running Loop=1 2024-12-20T21:00:42.804Z,1734728442.804 [Default:CheckIn:D] Stopped 2024-12-20T21:00:42.804Z,1734728442.804 [Default:CheckIn:E] Running Loop=1 2024-12-20T21:00:43.209Z,1734728443.209 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 144.610645 min 2024-12-20T21:00:43.209Z,1734728443.209 [Default:CheckIn:E] Stopped 2024-12-20T21:00:43.209Z,1734728443.209 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-20T21:00:43.209Z,1734728443.209 [Default:CheckIn] Stopped 2024-12-20T21:00:43.210Z,1734728443.210 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-20T21:00:43.210Z,1734728443.210 [Default:CheckIn](INFO): Running loop #26 2024-12-20T21:00:43.210Z,1734728443.210 [Default:CheckIn] Running Loop=26 2024-12-20T21:00:43.210Z,1734728443.210 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-20T21:00:43.210Z,1734728443.210 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-20T21:00:45.221Z,1734728445.221 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,210044.00,A,3648.17841,N,12147.27609,W,0.292,167.00,201224,,,A*78 2024-12-20T21:00:45.224Z,1734728445.224 [NAL9602](INFO): GPS fix at 20241220T210044: (36.802974, -121.787935) 2024-12-20T21:00:45.234Z,1734728445.234 [Default:CheckIn:Read_GPS] Stopped 2024-12-20T21:00:45.234Z,1734728445.234 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-20T21:00:53.369Z,1734728453.369 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20241220T185136/Courier0069.lzma 2024-12-20T21:00:54.372Z,1734728454.372 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Courier0069.lzma.bak 2024-12-20T21:00:54.372Z,1734728454.372 [DataOverHttps](INFO): SBD MOMSN=23850815 2024-12-20T21:01:19.287Z,1734728479.287 [NAL9602](INFO): SBD MO Status=2, MOMSN=11710, MT Status=2, MTMSN=0 2024-12-20T21:01:19.288Z,1734728479.288 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-12-20T21:01:20.006Z,1734728480.006 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20241220T185136/Express0070.lzma 2024-12-20T21:01:21.008Z,1734728481.008 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Express0070.lzma.bak 2024-12-20T21:01:21.008Z,1734728481.008 [DataOverHttps](INFO): SBD MOMSN=23850822 2024-12-20T21:01:24.179Z,1734728484.179 [Default:CheckIn:Read_Iridium] Stopped 2024-12-20T21:01:24.180Z,1734728484.180 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-20T21:01:24.180Z,1734728484.180 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-20T21:01:35.858Z,1734728495.858 [NAL9602](INFO): SBD MO Status=2, MOMSN=11710, MT Status=2, MTMSN=0 2024-12-20T21:01:35.858Z,1734728495.858 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-12-20T21:01:52.067Z,1734728512.067 [NAL9602](INFO): SBD MO Status=0, MOMSN=11710, MT Status=0, MTMSN=0 2024-12-20T21:01:52.067Z,1734728512.067 [NAL9602](INFO): No messages in MT queue 2024-12-20T21:02:22.714Z,1734728542.714 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-20T21:06:24.702Z,1734728784.702 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-20T21:06:24.702Z,1734728784.702 [Default:CheckIn:C.Wait] Stopped 2024-12-20T21:06:24.702Z,1734728784.702 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-20T21:06:24.702Z,1734728784.702 [Default:CheckIn:D] Running Loop=1 2024-12-20T21:06:25.084Z,1734728785.084 [Default:CheckIn:D] Stopped 2024-12-20T21:06:25.085Z,1734728785.085 [Default:CheckIn:E] Running Loop=1 2024-12-20T21:06:25.488Z,1734728785.488 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 150.315316 min 2024-12-20T21:06:25.488Z,1734728785.488 [Default:CheckIn:E] Stopped 2024-12-20T21:06:25.488Z,1734728785.488 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-20T21:06:25.489Z,1734728785.489 [Default:CheckIn] Stopped 2024-12-20T21:06:25.489Z,1734728785.489 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-20T21:06:25.489Z,1734728785.489 [Default:CheckIn](INFO): Running loop #27 2024-12-20T21:06:25.489Z,1734728785.489 [Default:CheckIn] Running Loop=27 2024-12-20T21:06:25.489Z,1734728785.489 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-20T21:06:25.489Z,1734728785.489 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-20T21:06:27.511Z,1734728787.511 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,210626.00,A,3648.17075,N,12147.27743,W,0.544,141.59,201224,,,A*7E 2024-12-20T21:06:27.513Z,1734728787.513 [NAL9602](INFO): GPS fix at 20241220T210626: (36.802846, -121.787957) 2024-12-20T21:06:27.524Z,1734728787.524 [Default:CheckIn:Read_GPS] Stopped 2024-12-20T21:06:27.524Z,1734728787.524 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-20T21:06:36.402Z,1734728796.402 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20241220T185136/Courier0072.lzma 2024-12-20T21:06:37.403Z,1734728797.403 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Courier0072.lzma.bak 2024-12-20T21:06:37.403Z,1734728797.403 [DataOverHttps](INFO): SBD MOMSN=23850846 2024-12-20T21:06:56.124Z,1734728816.124 [DataOverHttps](INFO): Sending 129 bytes from file Logs/20241220T185136/Express0073.lzma 2024-12-20T21:06:57.126Z,1734728817.126 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Express0073.lzma.bak 2024-12-20T21:06:57.126Z,1734728817.126 [DataOverHttps](INFO): SBD MOMSN=23850849 2024-12-20T21:07:07.253Z,1734728827.253 [Default:CheckIn:Read_Iridium] Stopped 2024-12-20T21:07:07.254Z,1734728827.254 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-20T21:07:07.254Z,1734728827.254 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-20T21:08:27.223Z,1734728907.223 [NAL9602](INFO): SBD MO Status=0, MOMSN=11711, MT Status=0, MTMSN=0 2024-12-20T21:08:27.223Z,1734728907.223 [NAL9602](INFO): No messages in MT queue 2024-12-20T21:08:57.913Z,1734728937.913 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-20T21:10:13.153Z,1734729013.153 [MassServo](ERROR): getPosition uart error serial timeout 2024-12-20T21:10:13.154Z,1734729013.154 [MassServo](FAULT): Invalid EZ Servo response:"\377" 2024-12-20T21:10:13.154Z,1734729013.154 [MassServo] Communications Fault, FailCount= 1 2024-12-20T21:10:13.154Z,1734729013.154 [MassServo](ERROR): Communications Fault 2024-12-20T21:10:13.159Z,1734729013.159 [CBIT](ERROR): Communications Fault in component: MassServo 2024-12-20T21:10:13.492Z,1734729013.492 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-12-20T21:10:13.492Z,1734729013.492 [MassServo](INFO): Powering down 2024-12-20T21:10:14.287Z,1734729014.287 [MassServo](DEBUG): Initializing EZServoServo. 2024-12-20T21:10:14.403Z,1734729014.403 [MassServo](DEBUG): Initializing MassServo. 2024-12-20T21:10:14.409Z,1734729014.409 [CBIT](INFO): Clearing failed state for component MassServo 2024-12-20T21:10:14.409Z,1734729014.409 [MassServo] No Fault, FailCount= 1 2024-12-20T21:12:07.847Z,1734729127.847 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-20T21:12:07.847Z,1734729127.847 [Default:CheckIn:C.Wait] Stopped 2024-12-20T21:12:07.848Z,1734729127.848 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-20T21:12:07.848Z,1734729127.848 [Default:CheckIn:D] Running Loop=1 2024-12-20T21:12:08.239Z,1734729128.239 [Default:CheckIn:D] Stopped 2024-12-20T21:12:08.239Z,1734729128.239 [Default:CheckIn:E] Running Loop=1 2024-12-20T21:12:08.683Z,1734729128.683 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 156.034570 min 2024-12-20T21:12:08.683Z,1734729128.683 [Default:CheckIn:E] Stopped 2024-12-20T21:12:08.683Z,1734729128.683 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-20T21:12:08.683Z,1734729128.683 [Default:CheckIn] Stopped 2024-12-20T21:12:08.683Z,1734729128.683 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-20T21:12:08.684Z,1734729128.684 [Default:CheckIn](INFO): Running loop #28 2024-12-20T21:12:08.684Z,1734729128.684 [Default:CheckIn] Running Loop=28 2024-12-20T21:12:08.684Z,1734729128.684 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-20T21:12:08.684Z,1734729128.684 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-20T21:12:10.662Z,1734729130.662 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,211209.00,A,3648.17341,N,12147.27953,W,0.233,141.59,201224,,,A*7A 2024-12-20T21:12:10.665Z,1734729130.665 [NAL9602](INFO): GPS fix at 20241220T211209: (36.802890, -121.787992) 2024-12-20T21:12:10.680Z,1734729130.680 [Default:CheckIn:Read_GPS] Stopped 2024-12-20T21:12:10.680Z,1734729130.680 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-20T21:12:19.424Z,1734729139.424 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20241220T185136/Courier0075.lzma 2024-12-20T21:12:20.426Z,1734729140.426 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Courier0075.lzma.bak 2024-12-20T21:12:20.426Z,1734729140.426 [DataOverHttps](INFO): SBD MOMSN=23850876 2024-12-20T21:12:22.871Z,1734729142.871 [NAL9602](INFO): SBD MO Status=0, MOMSN=11712, MT Status=0, MTMSN=0 2024-12-20T21:12:22.871Z,1734729142.871 [NAL9602](INFO): No messages in MT queue 2024-12-20T21:12:41.926Z,1734729161.926 [DataOverHttps](INFO): Sending 170 bytes from file Logs/20241220T185136/Express0076.lzma 2024-12-20T21:12:42.946Z,1734729162.946 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Express0076.lzma.bak 2024-12-20T21:12:42.946Z,1734729162.946 [DataOverHttps](INFO): SBD MOMSN=23850879 2024-12-20T21:12:46.239Z,1734729166.239 [Default:CheckIn:Read_Iridium] Stopped 2024-12-20T21:12:46.239Z,1734729166.239 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-20T21:12:46.239Z,1734729166.239 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-20T21:12:53.480Z,1734729173.480 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-20T21:14:15.920Z,1734729255.920 [BPC1](ERROR): Battery stick #62 (s/n: 00CC) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0. 2024-12-20T21:14:15.920Z,1734729255.920 [BPC1](INFO): Calculating totals. Valid battery stick count: 27. Valid reserve battery stick count: 3. 2024-12-20T21:14:15.941Z,1734729255.941 [BPC1](FAULT): Failed to receive data from 32 sticks prior to timeout. Will not retry this scan cycle. Missing stick IDs are: 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30, 31, 62. 2024-12-20T21:17:46.900Z,1734729466.900 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-20T21:17:46.900Z,1734729466.900 [Default:CheckIn:C.Wait] Stopped 2024-12-20T21:17:46.900Z,1734729466.900 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-20T21:17:46.900Z,1734729466.900 [Default:CheckIn:D] Running Loop=1 2024-12-20T21:17:47.303Z,1734729467.303 [Default:CheckIn:D] Stopped 2024-12-20T21:17:47.303Z,1734729467.303 [Default:CheckIn:E] Running Loop=1 2024-12-20T21:17:47.707Z,1734729467.707 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 161.685612 min 2024-12-20T21:17:47.707Z,1734729467.707 [Default:CheckIn:E] Stopped 2024-12-20T21:17:47.707Z,1734729467.707 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-20T21:17:47.707Z,1734729467.707 [Default:CheckIn] Stopped 2024-12-20T21:17:47.707Z,1734729467.707 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-20T21:17:47.707Z,1734729467.707 [Default:CheckIn](INFO): Running loop #29 2024-12-20T21:17:47.707Z,1734729467.707 [Default:CheckIn] Running Loop=29 2024-12-20T21:17:47.708Z,1734729467.708 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-20T21:17:47.708Z,1734729467.708 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-20T21:17:49.727Z,1734729469.727 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,211748.00,A,3648.18435,N,12147.28059,W,0.467,123.94,201224,,,A*7F 2024-12-20T21:17:49.729Z,1734729469.729 [NAL9602](INFO): GPS fix at 20241220T211748: (36.803072, -121.788010) 2024-12-20T21:17:49.740Z,1734729469.740 [Default:CheckIn:Read_GPS] Stopped 2024-12-20T21:17:49.740Z,1734729469.740 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-20T21:17:58.896Z,1734729478.896 [DataOverHttps](INFO): Sending 83 bytes from file Logs/20241220T185136/Courier0078.lzma 2024-12-20T21:17:59.898Z,1734729479.898 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Courier0078.lzma.bak 2024-12-20T21:17:59.898Z,1734729479.898 [DataOverHttps](INFO): SBD MOMSN=23850906 2024-12-20T21:18:22.717Z,1734729502.717 [DataOverHttps](INFO): Sending 284 bytes from file Logs/20241220T185136/Express0079.lzma 2024-12-20T21:18:24.792Z,1734729504.792 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Express0079.lzma.bak 2024-12-20T21:18:24.793Z,1734729504.793 [DataOverHttps](INFO): SBD MOMSN=23850909 2024-12-20T21:18:26.928Z,1734729506.928 [Default:CheckIn:Read_Iridium] Stopped 2024-12-20T21:18:26.928Z,1734729506.928 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-20T21:18:26.928Z,1734729506.928 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-20T21:18:31.351Z,1734729511.351 [NAL9602](INFO): SBD MO Status=2, MOMSN=11713, MT Status=2, MTMSN=0 2024-12-20T21:18:31.351Z,1734729511.351 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-12-20T21:18:51.546Z,1734729531.546 [NAL9602](INFO): SBD MO Status=0, MOMSN=11713, MT Status=0, MTMSN=0 2024-12-20T21:18:51.546Z,1734729531.546 [NAL9602](INFO): No messages in MT queue 2024-12-20T21:19:22.349Z,1734729562.349 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-20T21:23:27.593Z,1734729807.593 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-20T21:23:27.593Z,1734729807.593 [Default:CheckIn:C.Wait] Stopped 2024-12-20T21:23:27.593Z,1734729807.593 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-20T21:23:27.593Z,1734729807.593 [Default:CheckIn:D] Running Loop=1 2024-12-20T21:23:28.010Z,1734729808.010 [Default:CheckIn:D] Stopped 2024-12-20T21:23:28.010Z,1734729808.010 [Default:CheckIn:E] Running Loop=1 2024-12-20T21:23:28.413Z,1734729808.413 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 167.364079 min 2024-12-20T21:23:28.414Z,1734729808.414 [Default:CheckIn:E] Stopped 2024-12-20T21:23:28.414Z,1734729808.414 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-20T21:23:28.414Z,1734729808.414 [Default:CheckIn] Stopped 2024-12-20T21:23:28.414Z,1734729808.414 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-20T21:23:28.414Z,1734729808.414 [Default:CheckIn](INFO): Running loop #30 2024-12-20T21:23:28.414Z,1734729808.414 [Default:CheckIn] Running Loop=30 2024-12-20T21:23:28.414Z,1734729808.414 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-20T21:23:28.414Z,1734729808.414 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-20T21:23:30.415Z,1734729810.415 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,212329.00,A,3648.17164,N,12147.27762,W,0.778,184.26,201224,,,A*78 2024-12-20T21:23:30.417Z,1734729810.417 [NAL9602](INFO): GPS fix at 20241220T212329: (36.802861, -121.787960) 2024-12-20T21:23:30.453Z,1734729810.453 [Default:CheckIn:Read_GPS] Stopped 2024-12-20T21:23:30.453Z,1734729810.453 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-20T21:23:41.781Z,1734729821.781 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20241220T185136/Courier0081.lzma 2024-12-20T21:23:42.786Z,1734729822.786 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Courier0081.lzma.bak 2024-12-20T21:23:42.786Z,1734729822.786 [DataOverHttps](INFO): SBD MOMSN=23850937 2024-12-20T21:24:02.612Z,1734729842.612 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20241220T185136/Express0082.lzma 2024-12-20T21:24:03.617Z,1734729843.617 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Express0082.lzma.bak 2024-12-20T21:24:03.617Z,1734729843.617 [DataOverHttps](INFO): SBD MOMSN=23850940 2024-12-20T21:24:06.861Z,1734729846.861 [Default:CheckIn:Read_Iridium] Stopped 2024-12-20T21:24:06.861Z,1734729846.861 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-20T21:24:06.861Z,1734729846.861 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-20T21:24:26.206Z,1734729866.206 [NAL9602](INFO): SBD MO Status=2, MOMSN=11714, MT Status=2, MTMSN=0 2024-12-20T21:24:26.207Z,1734729866.207 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-12-20T21:25:35.303Z,1734729935.303 [NAL9602](INFO): SBD MO Status=2, MOMSN=11714, MT Status=2, MTMSN=0 2024-12-20T21:25:35.303Z,1734729935.303 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-12-20T21:26:10.855Z,1734729970.855 [NAL9602](INFO): SBD MO Status=2, MOMSN=11714, MT Status=2, MTMSN=0 2024-12-20T21:26:10.855Z,1734729970.855 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-12-20T21:26:47.643Z,1734730007.643 [NAL9602](INFO): SBD MO Status=2, MOMSN=11714, MT Status=2, MTMSN=0 2024-12-20T21:26:47.643Z,1734730007.643 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-12-20T21:27:02.587Z,1734730022.587 [NAL9602](INFO): SBD MO Status=2, MOMSN=11714, MT Status=2, MTMSN=0 2024-12-20T21:27:02.587Z,1734730022.587 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-12-20T21:27:45.006Z,1734730065.006 [NAL9602](INFO): SBD MO Status=0, MOMSN=11714, MT Status=0, MTMSN=0 2024-12-20T21:27:45.007Z,1734730065.007 [NAL9602](INFO): No messages in MT queue 2024-12-20T21:28:15.709Z,1734730095.709 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-20T21:29:07.456Z,1734730147.456 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-20T21:29:07.456Z,1734730147.456 [Default:CheckIn:C.Wait] Stopped 2024-12-20T21:29:07.456Z,1734730147.456 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-20T21:29:07.457Z,1734730147.457 [Default:CheckIn:D] Running Loop=1 2024-12-20T21:29:07.867Z,1734730147.867 [Default:CheckIn:D] Stopped 2024-12-20T21:29:07.867Z,1734730147.867 [Default:CheckIn:E] Running Loop=1 2024-12-20T21:29:08.259Z,1734730148.259 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 173.028353 min 2024-12-20T21:29:08.259Z,1734730148.259 [Default:CheckIn:E] Stopped 2024-12-20T21:29:08.260Z,1734730148.260 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-20T21:29:08.260Z,1734730148.260 [Default:CheckIn] Stopped 2024-12-20T21:29:08.260Z,1734730148.260 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-20T21:29:08.260Z,1734730148.260 [Default:CheckIn](INFO): Running loop #31 2024-12-20T21:29:08.260Z,1734730148.260 [Default:CheckIn] Running Loop=31 2024-12-20T21:29:08.261Z,1734730148.261 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-20T21:29:08.261Z,1734730148.261 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-20T21:29:10.277Z,1734730150.277 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,212908.00,A,3648.17729,N,12147.27766,W,0.894,184.26,201224,,,A*77 2024-12-20T21:29:10.279Z,1734730150.279 [NAL9602](INFO): GPS fix at 20241220T212908: (36.802955, -121.787961) 2024-12-20T21:29:10.318Z,1734730150.318 [Default:CheckIn:Read_GPS] Stopped 2024-12-20T21:29:10.318Z,1734730150.318 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-20T21:29:20.932Z,1734730160.932 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20241220T185136/Courier0084.lzma 2024-12-20T21:29:21.950Z,1734730161.950 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Courier0084.lzma.bak 2024-12-20T21:29:21.950Z,1734730161.950 [DataOverHttps](INFO): SBD MOMSN=23850965 2024-12-20T21:29:33.629Z,1734730173.629 [NAL9602](INFO): SBD MO Status=0, MOMSN=11715, MT Status=0, MTMSN=0 2024-12-20T21:29:33.629Z,1734730173.629 [NAL9602](INFO): No messages in MT queue 2024-12-20T21:29:41.156Z,1734730181.156 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20241220T185136/Express0085.lzma 2024-12-20T21:29:42.158Z,1734730182.158 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Express0085.lzma.bak 2024-12-20T21:29:42.158Z,1734730182.158 [DataOverHttps](INFO): SBD MOMSN=23850968 2024-12-20T21:29:45.384Z,1734730185.384 [Default:CheckIn:Read_Iridium] Stopped 2024-12-20T21:29:45.388Z,1734730185.388 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-20T21:29:45.388Z,1734730185.388 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-20T21:30:04.330Z,1734730204.330 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-20T21:34:45.819Z,1734730485.819 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-20T21:34:45.819Z,1734730485.819 [Default:CheckIn:C.Wait] Stopped 2024-12-20T21:34:45.819Z,1734730485.819 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-20T21:34:45.820Z,1734730485.820 [Default:CheckIn:D] Running Loop=1 2024-12-20T21:34:46.212Z,1734730486.212 [Default:CheckIn:D] Stopped 2024-12-20T21:34:46.212Z,1734730486.212 [Default:CheckIn:E] Running Loop=1 2024-12-20T21:34:46.621Z,1734730486.621 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 178.667432 min 2024-12-20T21:34:46.621Z,1734730486.621 [Default:CheckIn:E] Stopped 2024-12-20T21:34:46.621Z,1734730486.621 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-20T21:34:46.621Z,1734730486.621 [Default:CheckIn] Stopped 2024-12-20T21:34:46.621Z,1734730486.621 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-20T21:34:46.621Z,1734730486.621 [Default:CheckIn](INFO): Running loop #32 2024-12-20T21:34:46.622Z,1734730486.622 [Default:CheckIn] Running Loop=32 2024-12-20T21:34:46.622Z,1734730486.622 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-20T21:34:46.622Z,1734730486.622 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-20T21:34:48.635Z,1734730488.635 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,213447.00,A,3648.17180,N,12147.27782,W,0.389,184.26,201224,,,A*78 2024-12-20T21:34:48.637Z,1734730488.637 [NAL9602](INFO): GPS fix at 20241220T213447: (36.802863, -121.787964) 2024-12-20T21:34:48.698Z,1734730488.698 [Default:CheckIn:Read_GPS] Stopped 2024-12-20T21:34:48.698Z,1734730488.698 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-20T21:34:59.856Z,1734730499.856 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20241220T185136/Courier0087.lzma 2024-12-20T21:35:00.859Z,1734730500.859 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Courier0087.lzma.bak 2024-12-20T21:35:00.859Z,1734730500.859 [DataOverHttps](INFO): SBD MOMSN=23850992 2024-12-20T21:35:25.936Z,1734730525.936 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20241220T185136/Express0088.lzma 2024-12-20T21:35:26.938Z,1734730526.938 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Express0088.lzma.bak 2024-12-20T21:35:26.938Z,1734730526.938 [DataOverHttps](INFO): SBD MOMSN=23850997 2024-12-20T21:35:30.791Z,1734730530.791 [Default:CheckIn:Read_Iridium] Stopped 2024-12-20T21:35:30.791Z,1734730530.791 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-20T21:35:30.791Z,1734730530.791 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-20T21:35:31.718Z,1734730531.718 [NAL9602](INFO): SBD MO Status=0, MOMSN=11716, MT Status=0, MTMSN=0 2024-12-20T21:35:31.719Z,1734730531.719 [NAL9602](INFO): No messages in MT queue 2024-12-20T21:36:02.336Z,1734730562.336 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-20T21:40:31.626Z,1734730831.626 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-20T21:40:31.626Z,1734730831.626 [Default:CheckIn:C.Wait] Stopped 2024-12-20T21:40:31.626Z,1734730831.626 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-20T21:40:31.626Z,1734730831.626 [Default:CheckIn:D] Running Loop=1 2024-12-20T21:40:32.032Z,1734730832.032 [Default:CheckIn:D] Stopped 2024-12-20T21:40:32.032Z,1734730832.032 [Default:CheckIn:E] Running Loop=1 2024-12-20T21:40:32.441Z,1734730832.441 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 184.431104 min 2024-12-20T21:40:32.442Z,1734730832.442 [Default:CheckIn:E] Stopped 2024-12-20T21:40:32.442Z,1734730832.442 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-20T21:40:32.442Z,1734730832.442 [Default:CheckIn] Stopped 2024-12-20T21:40:32.442Z,1734730832.442 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-20T21:40:32.442Z,1734730832.442 [Default:CheckIn](INFO): Running loop #33 2024-12-20T21:40:32.442Z,1734730832.442 [Default:CheckIn] Running Loop=33 2024-12-20T21:40:32.442Z,1734730832.442 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-20T21:40:32.442Z,1734730832.442 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-20T21:40:34.442Z,1734730834.442 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,214033.00,A,3648.17384,N,12147.27750,W,0.175,289.47,201224,,,A*79 2024-12-20T21:40:34.445Z,1734730834.445 [NAL9602](INFO): GPS fix at 20241220T214033: (36.802897, -121.787958) 2024-12-20T21:40:34.474Z,1734730834.474 [Default:CheckIn:Read_GPS] Stopped 2024-12-20T21:40:34.474Z,1734730834.474 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-20T21:40:43.292Z,1734730843.292 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20241220T185136/Courier0090.lzma 2024-12-20T21:40:47.282Z,1734730847.282 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Courier0090.lzma.bak 2024-12-20T21:40:47.282Z,1734730847.282 [DataOverHttps](INFO): SBD MOMSN=23851019 2024-12-20T21:41:10.793Z,1734730870.793 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20241220T185136/Express0091.lzma 2024-12-20T21:41:11.794Z,1734730871.794 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Express0091.lzma.bak 2024-12-20T21:41:11.795Z,1734730871.795 [DataOverHttps](INFO): SBD MOMSN=23851022 2024-12-20T21:41:16.999Z,1734730876.999 [Default:CheckIn:Read_Iridium] Stopped 2024-12-20T21:41:16.999Z,1734730876.999 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-20T21:41:16.999Z,1734730876.999 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-20T21:43:42.760Z,1734731022.760 [NAL9602](INFO): SBD MO Status=2, MOMSN=11717, MT Status=2, MTMSN=0 2024-12-20T21:43:42.760Z,1734731022.760 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-12-20T21:44:00.887Z,1734731040.887 [NAL9602](INFO): SBD MO Status=2, MOMSN=11717, MT Status=2, MTMSN=0 2024-12-20T21:44:00.887Z,1734731040.887 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-12-20T21:45:02.766Z,1734731102.766 [NAL9602](INFO): SBD MO Status=2, MOMSN=11717, MT Status=2, MTMSN=0 2024-12-20T21:45:02.767Z,1734731102.767 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-12-20T21:45:36.905Z,1734731136.905 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-12-20T21:46:07.597Z,1734731167.597 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-20T21:46:17.710Z,1734731177.710 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-20T21:46:17.710Z,1734731177.710 [Default:CheckIn:C.Wait] Stopped 2024-12-20T21:46:17.710Z,1734731177.710 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-20T21:46:17.710Z,1734731177.710 [Default:CheckIn:D] Running Loop=1 2024-12-20T21:46:18.122Z,1734731178.122 [Default:CheckIn:D] Stopped 2024-12-20T21:46:18.122Z,1734731178.122 [Default:CheckIn:E] Running Loop=1 2024-12-20T21:46:18.515Z,1734731178.515 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 190.199284 min 2024-12-20T21:46:18.516Z,1734731178.516 [Default:CheckIn:E] Stopped 2024-12-20T21:46:18.516Z,1734731178.516 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-20T21:46:18.516Z,1734731178.516 [Default:CheckIn] Stopped 2024-12-20T21:46:18.516Z,1734731178.516 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-20T21:46:18.516Z,1734731178.516 [Default:CheckIn](INFO): Running loop #34 2024-12-20T21:46:18.516Z,1734731178.516 [Default:CheckIn] Running Loop=34 2024-12-20T21:46:18.516Z,1734731178.516 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-20T21:46:18.517Z,1734731178.517 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-20T21:46:20.526Z,1734731180.526 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,214619.00,A,3648.15529,N,12147.28285,W,1.380,298.27,201224,,,A*79 2024-12-20T21:46:20.529Z,1734731180.529 [NAL9602](INFO): GPS fix at 20241220T214619: (36.802588, -121.788048) 2024-12-20T21:46:20.568Z,1734731180.568 [Default:CheckIn:Read_GPS] Stopped 2024-12-20T21:46:20.568Z,1734731180.568 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-20T21:46:32.164Z,1734731192.164 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20241220T185136/Courier0093.lzma 2024-12-20T21:46:33.166Z,1734731193.166 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Courier0093.lzma.bak 2024-12-20T21:46:33.167Z,1734731193.167 [DataOverHttps](INFO): SBD MOMSN=23851045 2024-12-20T21:46:50.982Z,1734731210.982 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2024-12-20T21:46:51.065Z,1734731211.065 [NAL9602](ERROR): received: +CSQ:0 OK717, 2, 0, 0, 0 OK 2024-12-20T21:46:52.307Z,1734731212.307 [DataOverHttps](INFO): Sending 208 bytes from file Logs/20241220T185136/Express0094.lzma 2024-12-20T21:46:53.306Z,1734731213.306 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Express0094.lzma.bak 2024-12-20T21:46:53.306Z,1734731213.306 [DataOverHttps](INFO): SBD MOMSN=23851048 2024-12-20T21:46:57.391Z,1734731217.391 [Default:CheckIn:Read_Iridium] Stopped 2024-12-20T21:46:57.392Z,1734731217.392 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-20T21:46:57.396Z,1734731217.396 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-20T21:51:22.752Z,1734731482.752 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-12-20T21:51:53.489Z,1734731513.489 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-20T21:51:57.943Z,1734731517.943 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-20T21:51:57.943Z,1734731517.943 [Default:CheckIn:C.Wait] Stopped 2024-12-20T21:51:57.943Z,1734731517.943 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-20T21:51:57.943Z,1734731517.943 [Default:CheckIn:D] Running Loop=1 2024-12-20T21:51:58.341Z,1734731518.341 [Default:CheckIn:D] Stopped 2024-12-20T21:51:58.341Z,1734731518.341 [Default:CheckIn:E] Running Loop=1 2024-12-20T21:51:58.749Z,1734731518.749 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 195.869580 min 2024-12-20T21:51:58.749Z,1734731518.749 [Default:CheckIn:E] Stopped 2024-12-20T21:51:58.750Z,1734731518.750 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-20T21:51:58.750Z,1734731518.750 [Default:CheckIn] Stopped 2024-12-20T21:51:58.750Z,1734731518.750 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-20T21:51:58.750Z,1734731518.750 [Default:CheckIn](INFO): Running loop #35 2024-12-20T21:51:58.750Z,1734731518.750 [Default:CheckIn] Running Loop=35 2024-12-20T21:51:58.750Z,1734731518.750 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-20T21:51:58.750Z,1734731518.750 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-20T21:52:00.758Z,1734731520.758 [NAL9602](FAULT): LCB fault: Invalid Command. Hardware Overcurrent Shutdown. Current Limiter Activated. 2024-12-20T21:52:00.758Z,1734731520.758 [NAL9602] Hardware Fault, FailCount= 1 2024-12-20T21:52:00.758Z,1734731520.758 [NAL9602](ERROR): Hardware Fault 2024-12-20T21:52:00.952Z,1734731520.952 [CBIT](ERROR): Hardware Fault in component: NAL9602 2024-12-20T21:52:01.223Z,1734731521.223 [NAL9602](INFO): Powering down 2024-12-20T21:52:02.145Z,1734731522.145 [CBIT](INFO): Clearing failed state for component NAL9602 2024-12-20T21:52:02.145Z,1734731522.145 [NAL9602] No Fault, FailCount= 1 2024-12-20T21:52:31.499Z,1734731551.499 [NAL9602](INFO): Powering up NAL9602 2024-12-20T21:52:42.413Z,1734731562.413 [NAL9602](INFO): NAL9602 initialized 2024-12-20T21:55:17.753Z,1734731717.753 [BPC1](ERROR): Battery stick #62 (s/n: 00CC) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0. 2024-12-20T21:55:17.754Z,1734731717.754 [BPC1](INFO): Calculating totals. Valid battery stick count: 27. Valid reserve battery stick count: 3. 2024-12-20T21:55:17.767Z,1734731717.767 [BPC1](FAULT): Failed to receive data from 32 sticks prior to timeout. Will not retry this scan cycle. Missing stick IDs are: 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30, 31, 62. 2024-12-20T21:56:58.894Z,1734731818.894 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-12-20T21:51:58.8Z 2024-12-20T21:56:58.894Z,1734731818.894 [Default:CheckIn:Read_GPS] Stopped 2024-12-20T21:56:58.895Z,1734731818.895 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-20T21:57:05.842Z,1734731825.842 [DataOverHttps](INFO): Sending 51 bytes from file Logs/20241220T185136/Courier0096.lzma 2024-12-20T21:57:06.850Z,1734731826.850 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Courier0096.lzma.bak 2024-12-20T21:57:06.851Z,1734731826.851 [DataOverHttps](INFO): SBD MOMSN=23851090 2024-12-20T21:57:17.800Z,1734731837.800 [MassServo](FAULT): Invalid EZ Servo response:"7\r" 2024-12-20T21:57:17.801Z,1734731837.801 [MassServo] Communications Fault, FailCount= 2 2024-12-20T21:57:17.801Z,1734731837.801 [MassServo](ERROR): Communications Fault 2024-12-20T21:57:17.822Z,1734731837.822 [CBIT](ERROR): Communications Fault in component: MassServo 2024-12-20T21:57:18.180Z,1734731838.180 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-12-20T21:57:18.181Z,1734731838.181 [MassServo](INFO): Powering down 2024-12-20T21:57:18.925Z,1734731838.925 [MassServo](DEBUG): Initializing EZServoServo. 2024-12-20T21:57:19.045Z,1734731839.045 [MassServo](DEBUG): Initializing MassServo. 2024-12-20T21:57:19.050Z,1734731839.050 [CBIT](INFO): Clearing failed state for component MassServo 2024-12-20T21:57:19.050Z,1734731839.050 [MassServo] No Fault, FailCount= 2 2024-12-20T21:57:28.637Z,1734731848.637 [DataOverHttps](INFO): Sending 404 bytes from file Logs/20241220T185136/Express0097.lzma 2024-12-20T21:57:29.638Z,1734731849.638 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Express0097.lzma.bak 2024-12-20T21:57:29.638Z,1734731849.638 [DataOverHttps](INFO): SBD MOMSN=23851092 2024-12-20T21:57:34.335Z,1734731854.335 [Default:CheckIn:Read_Iridium] Stopped 2024-12-20T21:57:34.335Z,1734731854.335 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-20T21:57:34.336Z,1734731854.336 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-20T21:57:44.794Z,1734731864.794 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-12-20T21:58:07.359Z,1734731887.359 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging 2024-12-20T21:58:15.441Z,1734731895.441 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-20T22:02:34.871Z,1734732154.871 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-12-20T22:02:34.871Z,1734732154.871 [Default:CheckIn:C.Wait] Stopped 2024-12-20T22:02:34.871Z,1734732154.871 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-20T22:02:34.872Z,1734732154.872 [Default:CheckIn:D] Running Loop=1 2024-12-20T22:02:35.315Z,1734732155.315 [Default:CheckIn:D] Stopped 2024-12-20T22:02:35.315Z,1734732155.315 [Default:CheckIn:E] Running Loop=1 2024-12-20T22:02:35.694Z,1734732155.694 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 206.485824 min 2024-12-20T22:02:35.694Z,1734732155.694 [Default:CheckIn:E] Stopped 2024-12-20T22:02:35.694Z,1734732155.694 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-12-20T22:02:35.694Z,1734732155.694 [Default:CheckIn] Stopped 2024-12-20T22:02:35.694Z,1734732155.694 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-20T22:02:35.694Z,1734732155.694 [Default:CheckIn](INFO): Running loop #36 2024-12-20T22:02:35.695Z,1734732155.695 [Default:CheckIn] Running Loop=36 2024-12-20T22:02:35.695Z,1734732155.695 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-12-20T22:02:35.695Z,1734732155.695 [Default:CheckIn:Read_GPS] Running Loop=1 2024-12-20T22:02:37.291Z,1734732157.291 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-12-20T22:02:37.291Z,1734732157.291 [NAL9602] Data Fault, FailCount= 2 2024-12-20T22:02:37.291Z,1734732157.291 [NAL9602](ERROR): Data Fault 2024-12-20T22:02:37.457Z,1734732157.457 [CBIT](ERROR): Data Fault in component: NAL9602 2024-12-20T22:02:37.690Z,1734732157.690 [NAL9602](INFO): Powering down 2024-12-20T22:02:38.658Z,1734732158.658 [CBIT](INFO): Clearing failed state for component NAL9602 2024-12-20T22:02:38.658Z,1734732158.658 [NAL9602] No Fault, FailCount= 2 2024-12-20T22:03:08.014Z,1734732188.014 [NAL9602](INFO): Powering up NAL9602 2024-12-20T22:03:18.914Z,1734732198.914 [NAL9602](INFO): NAL9602 initialized 2024-12-20T22:07:35.763Z,1734732455.763 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-12-20T22:02:35.7Z 2024-12-20T22:07:35.764Z,1734732455.764 [Default:CheckIn:Read_GPS] Stopped 2024-12-20T22:07:35.764Z,1734732455.764 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-12-20T22:07:40.180Z,1734732460.180 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20241220T185136/Courier0099.lzma 2024-12-20T22:07:41.187Z,1734732461.187 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Courier0099.lzma.bak 2024-12-20T22:07:41.188Z,1734732461.188 [DataOverHttps](INFO): SBD MOMSN=23851146 2024-12-20T22:08:08.882Z,1734732488.882 [DataOverHttps](INFO): Sending 262 bytes from file Logs/20241220T185136/Express0100.lzma 2024-12-20T22:08:09.883Z,1734732489.883 [DataOverHttps](INFO): Moved sent file to Logs/20241220T185136/Express0100.lzma.bak 2024-12-20T22:08:09.883Z,1734732489.883 [DataOverHttps](INFO): SBD MOMSN=23851148 2024-12-20T22:08:15.127Z,1734732495.127 [Default:CheckIn:Read_Iridium] Stopped 2024-12-20T22:08:15.127Z,1734732495.127 [Default:CheckIn:C.Wait] Running Loop=1 2024-12-20T22:08:15.127Z,1734732495.127 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-12-20T22:08:22.227Z,1734732502.227 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-12-20T22:08:52.918Z,1734732532.918 [NAL9602](INFO): Not Powering down - fast GPS 2024-12-20T22:12:21.725Z,1734732741.725 [CommandExec](IMPORTANT): got command quit 2024-12-20T22:12:22.733Z,1734732742.733 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-12-20T22:12:22.733Z,1734732742.733 [CommandExec](INFO): Uninitializing the command executive. 2024-12-20T22:12:22.733Z,1734732742.733 [CommandExec](INFO): Uninitializing the command scheduler. 2024-12-20T22:12:22.734Z,1734732742.734 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-12-20T22:12:22.913Z,1734732742.913 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-12-20T22:12:22.913Z,1734732742.913 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-12-20T22:12:22.913Z,1734732742.913 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-12-20T22:12:22.914Z,1734732742.914 [NavChartDb](INFO): Join timeout helper Thread ID is 1149 2024-12-20T22:12:23.221Z,1734732743.221 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-12-20T22:12:23.221Z,1734732743.221 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-12-20T22:12:23.241Z,1734732743.241 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-12-20T22:12:23.241Z,1734732743.241 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-12-20T22:12:23.241Z,1734732743.241 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1150 2024-12-20T22:12:23.645Z,1734732743.645 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-12-20T22:12:23.645Z,1734732743.645 [WetLabsBB2FL](INFO): Powering down 2024-12-20T22:12:23.646Z,1734732743.646 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-12-20T22:12:23.665Z,1734732743.665 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2024-12-20T22:12:23.665Z,1734732743.665 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-12-20T22:12:23.665Z,1734732743.665 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1152 2024-12-20T22:12:24.593Z,1734732744.593 [CTD_Seabird](INFO): Powering down 2024-12-20T22:12:24.605Z,1734732744.605 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2024-12-20T22:12:24.610Z,1734732744.610 [CTD_Seabird](INFO): Powering down 2024-12-20T22:12:24.625Z,1734732744.625 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-12-20T22:12:24.636Z,1734732744.636 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-12-20T22:12:24.636Z,1734732744.636 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-12-20T22:12:24.636Z,1734732744.636 [Radio_Surface](INFO): Join timeout helper Thread ID is 1153 2024-12-20T22:12:24.969Z,1734732744.969 [Radio_Surface](INFO): Powering down 2024-12-20T22:12:24.970Z,1734732744.970 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-12-20T22:12:24.970Z,1734732744.970 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-12-20T22:12:24.979Z,1734732744.979 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-12-20T22:12:24.979Z,1734732744.979 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-12-20T22:12:24.980Z,1734732744.980 [Onboard](INFO): Join timeout helper Thread ID is 1154 2024-12-20T22:12:25.457Z,1734732745.457 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2024-12-20T22:12:25.813Z,1734732745.813 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-12-20T22:12:25.813Z,1734732745.813 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-12-20T22:12:25.823Z,1734732745.823 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-12-20T22:12:25.823Z,1734732745.823 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-12-20T22:12:25.823Z,1734732745.823 [DataOverHttps](INFO): Join timeout helper Thread ID is 1155 2024-12-20T22:12:26.461Z,1734732746.461 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-12-20T22:12:26.461Z,1734732746.461 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-12-20T22:12:26.469Z,1734732746.469 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2024-12-20T22:12:26.470Z,1734732746.470 [DAT ThreadHandler](INFO): Thread cancelled. 2024-12-20T22:12:26.470Z,1734732746.470 [DAT](INFO): Join timeout helper Thread ID is 1156 2024-12-20T22:12:26.605Z,1734732746.605 [DAT](INFO): Powering down 2024-12-20T22:12:26.673Z,1734732746.673 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2024-12-20T22:12:26.674Z,1734732746.674 [DAT](INFO): Powering down 2024-12-20T22:12:26.674Z,1734732746.674 [DAT ThreadHandler](INFO): Thread cancelled. 2024-12-20T22:12:26.678Z,1734732746.678 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2024-12-20T22:12:26.678Z,1734732746.678 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-12-20T22:12:26.678Z,1734732746.678 [BackseatComponent](INFO): Join timeout helper Thread ID is 1157 2024-12-20T22:12:26.741Z,1734732746.741 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2024-12-20T22:12:26.741Z,1734732746.741 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-12-20T22:12:26.746Z,1734732746.746 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-12-20T22:12:26.746Z,1734732746.746 [logger ThreadHandler](INFO): Thread cancelled. 2024-12-20T22:12:26.746Z,1734732746.746 [logger](INFO): Join timeout helper Thread ID is 1158 2024-12-20T22:12:26.753Z,1734732746.753 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-12-20T22:12:26.754Z,1734732746.754 [logger ThreadHandler](INFO): Thread cancelled. 2024-12-20T22:12:26.774Z,1734732746.774 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-12-20T22:12:26.774Z,1734732746.774 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-12-20T22:12:26.774Z,1734732746.774 [CommandLine](INFO): Join timeout helper Thread ID is 1159 2024-12-20T22:12:26.789Z,1734732746.789 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-12-20T22:12:26.789Z,1734732746.789 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-12-20T22:12:26.799Z,1734732746.799 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-12-20T22:12:26.800Z,1734732746.800 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-12-20T22:12:26.800Z,1734732746.800 [CommandExec](INFO): Join timeout helper Thread ID is 1160 2024-12-20T22:12:26.801Z,1734732746.801 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-12-20T22:12:26.802Z,1734732746.802 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-12-20T22:12:26.802Z,1734732746.802 [controlThread](INFO): Join timeout helper Thread ID is 1161 2024-12-20T22:12:26.823Z,1734732746.823 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-12-20T22:12:26.823Z,1734732746.823 [controlThread](DEBUG): Uninitializing ControlThread 2024-12-20T22:12:26.824Z,1734732746.824 [AHRS_M2](INFO): Powering down 2024-12-20T22:12:26.894Z,1734732746.894 [NAL9602](INFO): Powering down 2024-12-20T22:12:26.895Z,1734732746.895 [Sonardyne_Nano](INFO): Powering down 2024-12-20T22:12:27.014Z,1734732747.014 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-12-20T22:12:27.015Z,1734732747.015 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-12-20T22:12:27.015Z,1734732747.015 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-12-20T22:12:27.015Z,1734732747.015 [MissionManager](INFO): Uninitializing Mission Default 2024-12-20T22:12:27.016Z,1734732747.016 [Default] Stopped 2024-12-20T22:12:27.016Z,1734732747.016 [Default](DEBUG): Aggregate::uninitialize Default 2024-12-20T22:12:27.016Z,1734732747.016 [Default:B.GoToSurface] Stopped 2024-12-20T22:12:27.016Z,1734732747.016 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-12-20T22:12:27.016Z,1734732747.016 [Default:CheckIn] Stopped 2024-12-20T22:12:27.016Z,1734732747.016 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-12-20T22:12:27.016Z,1734732747.016 [Default:CheckIn:C.Wait] Stopped 2024-12-20T22:12:27.016Z,1734732747.016 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-12-20T22:12:27.019Z,1734732747.019 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-12-20T22:12:27.019Z,1734732747.019 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-12-20T22:12:27.019Z,1734732747.019 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-12-20T22:12:27.020Z,1734732747.020 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-12-20T22:12:27.020Z,1734732747.020 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-12-20T22:12:27.020Z,1734732747.020 [BuoyancyServo](INFO): Powering down 2024-12-20T22:12:27.033Z,1734732747.033 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-12-20T22:12:27.033Z,1734732747.033 [ElevatorServo](INFO): Powering down 2024-12-20T22:12:27.034Z,1734732747.034 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-12-20T22:12:27.034Z,1734732747.034 [MassServo](INFO): Powering down 2024-12-20T22:12:27.035Z,1734732747.035 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-12-20T22:12:27.035Z,1734732747.035 [RudderServo](INFO): Powering down 2024-12-20T22:12:27.036Z,1734732747.036 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2024-12-20T22:12:27.036Z,1734732747.036 [ThrusterHE](INFO): Powering down 2024-12-20T22:12:27.037Z,1734732747.037 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-12-20T22:12:27.037Z,1734732747.037 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-12-20T22:12:27.037Z,1734732747.037 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-12-20T22:12:27.037Z,1734732747.037 [CBIT](DEBUG): Powering off loads. 2024-12-20T22:12:27.049Z,1734732747.049 [CBIT](DEBUG): Disabling WDT. 2024-12-20T22:12:27.061Z,1734732747.061 [CBIT](DEBUG): Opening all GF detection circuits. 2024-12-20T22:12:27.062Z,1734732747.062 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-12-20T22:12:27.112Z,1734732747.112 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-12-20T22:12:27.115Z,1734732747.115 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-12-20T22:12:27.121Z,1734732747.121 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-12-20T22:12:27.128Z,1734732747.128 [DAT ThreadHandler](INFO): Thread cancelled. 2024-12-20T22:12:27.169Z,1734732747.169 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-12-20T22:12:27.373Z,1734732747.373 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-12-20T22:12:27.377Z,1734732747.377 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-12-20T22:12:27.396Z,1734732747.396 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-12-20T22:12:27.475Z,1734732747.475 [logger ThreadHandler](INFO): Thread cancelled.