2025-01-22T21:37:15.990Z,1737581835.990 [CommandExec](IMPORTANT): got command restart logs
2025-01-22T21:37:50.883Z,1737581870.883 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-01-22T21:37:50.883Z,1737581870.883 [Default:CheckIn:C.Wait] Stopped
2025-01-22T21:37:50.884Z,1737581870.884 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-01-22T21:37:50.884Z,1737581870.884 [Default:CheckIn:D] Running Loop=1
2025-01-22T21:37:51.292Z,1737581871.292 [Default:CheckIn:D] Stopped
2025-01-22T21:37:51.292Z,1737581871.292 [Default:CheckIn:E] Running Loop=1
2025-01-22T21:37:51.693Z,1737581871.693 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  17.505760 min 
2025-01-22T21:37:51.693Z,1737581871.693 [Default:CheckIn:E] Stopped
2025-01-22T21:37:51.693Z,1737581871.693 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-01-22T21:37:51.693Z,1737581871.693 [Default:CheckIn] Stopped
2025-01-22T21:37:51.693Z,1737581871.693 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-01-22T21:37:51.693Z,1737581871.693 [Default:CheckIn](INFO): Running loop #4
2025-01-22T21:37:51.694Z,1737581871.694 [Default:CheckIn] Running Loop=4
2025-01-22T21:37:51.694Z,1737581871.694 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-01-22T21:37:51.694Z,1737581871.694 [Default:CheckIn:Read_GPS] Running Loop=1
2025-01-22T21:37:53.712Z,1737581873.712 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,213753.00,A,3648.21404,N,12148.46429,W,32.248,87.22,220125,,,D*77
2025-01-22T21:37:53.714Z,1737581873.714 [NAL9602](INFO): GPS fix at 20250122T213753: (36.803567, -121.807738)
2025-01-22T21:37:53.726Z,1737581873.726 [Default:CheckIn:Read_GPS] Stopped
2025-01-22T21:37:53.726Z,1737581873.726 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-01-22T21:38:02.449Z,1737581882.449 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250122T183449/Courier0043.lzma
2025-01-22T21:38:04.455Z,1737581884.455 [DataOverHttps](INFO): Moved sent file to Logs/20250122T183449/Courier0043.lzma.bak
2025-01-22T21:38:04.455Z,1737581884.455 [DataOverHttps](INFO): SBD MOMSN=23924595
2025-01-22T21:38:08.252Z,1737581888.252 [NAL9602](INFO): SBD MO Status=1, MOMSN=12477, MT Status=0, MTMSN=0
2025-01-22T21:38:08.252Z,1737581888.252 [NAL9602](INFO): No messages in MT queue
2025-01-22T21:38:23.898Z,1737581903.898 [DataOverHttps](INFO): Sending 268 bytes from file Logs/20250122T213715/Courier0000.lzma
2025-01-22T21:38:24.899Z,1737581904.899 [DataOverHttps](INFO): Moved sent file to Logs/20250122T213715/Courier0000.lzma.bak
2025-01-22T21:38:24.899Z,1737581904.899 [DataOverHttps](INFO): SBD MOMSN=23924598
2025-01-22T21:38:38.682Z,1737581918.682 [NAL9602](INFO): Not Powering down - fast GPS
2025-01-22T21:38:41.760Z,1737581921.760 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250122T213715/Courier0003.lzma
2025-01-22T21:38:42.763Z,1737581922.763 [DataOverHttps](INFO): Moved sent file to Logs/20250122T213715/Courier0003.lzma.bak
2025-01-22T21:38:42.763Z,1737581922.763 [DataOverHttps](INFO): SBD MOMSN=23924604
2025-01-22T21:38:58.893Z,1737581938.893 [DataOverHttps](INFO): Sending 105 bytes from file Logs/20250122T183449/Express0044.lzma
2025-01-22T21:38:59.895Z,1737581939.895 [DataOverHttps](INFO): Moved sent file to Logs/20250122T183449/Express0044.lzma.bak
2025-01-22T21:38:59.895Z,1737581939.895 [DataOverHttps](INFO): SBD MOMSN=23924606
2025-01-22T21:39:19.209Z,1737581959.209 [DataOverHttps](INFO): Sending 393 bytes from file Logs/20250122T213715/Express0001.lzma
2025-01-22T21:39:20.207Z,1737581960.207 [DataOverHttps](INFO): Moved sent file to Logs/20250122T213715/Express0001.lzma.bak
2025-01-22T21:39:20.207Z,1737581960.207 [DataOverHttps](INFO): SBD MOMSN=23924609
2025-01-22T21:39:36.525Z,1737581976.525 [DataOverHttps](INFO): Sending 61 bytes from file Logs/20250122T213715/Express0004.lzma
2025-01-22T21:39:37.761Z,1737581977.761 [DataOverHttps](INFO): Moved sent file to Logs/20250122T213715/Express0004.lzma.bak
2025-01-22T21:39:37.762Z,1737581977.762 [DataOverHttps](INFO): SBD MOMSN=23924613
2025-01-22T21:39:38.867Z,1737581978.867 [Default:CheckIn:Read_Iridium] Stopped
2025-01-22T21:39:38.867Z,1737581978.867 [Default:CheckIn:C.Wait] Running Loop=1
2025-01-22T21:39:38.867Z,1737581978.867 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-01-22T21:44:39.488Z,1737582279.488 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-01-22T21:44:39.488Z,1737582279.488 [Default:CheckIn:C.Wait] Stopped
2025-01-22T21:44:39.488Z,1737582279.488 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-01-22T21:44:39.488Z,1737582279.488 [Default:CheckIn:D] Running Loop=1
2025-01-22T21:44:39.910Z,1737582279.910 [Default:CheckIn:D] Stopped
2025-01-22T21:44:39.910Z,1737582279.910 [Default:CheckIn:E] Running Loop=1
2025-01-22T21:44:40.317Z,1737582280.317 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  24.316050 min 
2025-01-22T21:44:40.317Z,1737582280.317 [Default:CheckIn:E] Stopped
2025-01-22T21:44:40.318Z,1737582280.318 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-01-22T21:44:40.318Z,1737582280.318 [Default:CheckIn] Stopped
2025-01-22T21:44:40.318Z,1737582280.318 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-01-22T21:44:40.318Z,1737582280.318 [Default:CheckIn](INFO): Running loop #5
2025-01-22T21:44:40.318Z,1737582280.318 [Default:CheckIn] Running Loop=5
2025-01-22T21:44:40.318Z,1737582280.318 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-01-22T21:44:40.318Z,1737582280.318 [Default:CheckIn:Read_GPS] Running Loop=1
2025-01-22T21:44:42.303Z,1737582282.303 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,214441.00,A,3648.21064,N,12147.17453,W,5.346,209.05,220125,,,D*7E
2025-01-22T21:44:42.305Z,1737582282.305 [NAL9602](INFO): GPS fix at 20250122T214441: (36.803511, -121.786242)
2025-01-22T21:44:42.316Z,1737582282.316 [Default:CheckIn:Read_GPS] Stopped
2025-01-22T21:44:42.316Z,1737582282.316 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-01-22T21:44:50.537Z,1737582290.537 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250122T213715/Courier0006.lzma
2025-01-22T21:44:51.539Z,1737582291.539 [DataOverHttps](INFO): Moved sent file to Logs/20250122T213715/Courier0006.lzma.bak
2025-01-22T21:44:51.539Z,1737582291.539 [DataOverHttps](INFO): SBD MOMSN=23924615
2025-01-22T21:45:00.880Z,1737582300.880 [NAL9602](INFO): SBD MO Status=1, MOMSN=12478, MT Status=0, MTMSN=0
2025-01-22T21:45:00.880Z,1737582300.880 [NAL9602](INFO): No messages in MT queue
2025-01-22T21:45:11.142Z,1737582311.142 [DataOverHttps](INFO): Sending 140 bytes from file Logs/20250122T213715/Express0007.lzma
2025-01-22T21:45:12.143Z,1737582312.143 [DataOverHttps](INFO): Moved sent file to Logs/20250122T213715/Express0007.lzma.bak
2025-01-22T21:45:12.144Z,1737582312.144 [DataOverHttps](INFO): SBD MOMSN=23924618
2025-01-22T21:45:13.867Z,1737582313.867 [Default:CheckIn:Read_Iridium] Stopped
2025-01-22T21:45:13.867Z,1737582313.867 [Default:CheckIn:C.Wait] Running Loop=1
2025-01-22T21:45:13.867Z,1737582313.867 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-01-22T21:45:31.614Z,1737582331.614 [NAL9602](INFO): Not Powering down - fast GPS
2025-01-22T21:50:14.555Z,1737582614.555 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-01-22T21:50:14.555Z,1737582614.555 [Default:CheckIn:C.Wait] Stopped
2025-01-22T21:50:14.555Z,1737582614.555 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-01-22T21:50:14.555Z,1737582614.555 [Default:CheckIn:D] Running Loop=1
2025-01-22T21:50:14.949Z,1737582614.949 [Default:CheckIn:D] Stopped
2025-01-22T21:50:14.949Z,1737582614.949 [Default:CheckIn:E] Running Loop=1
2025-01-22T21:50:15.353Z,1737582615.353 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  29.900028 min 
2025-01-22T21:50:15.354Z,1737582615.354 [Default:CheckIn:E] Stopped
2025-01-22T21:50:15.354Z,1737582615.354 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-01-22T21:50:15.354Z,1737582615.354 [Default:CheckIn] Stopped
2025-01-22T21:50:15.354Z,1737582615.354 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-01-22T21:50:15.354Z,1737582615.354 [Default:CheckIn](INFO): Running loop #6
2025-01-22T21:50:15.354Z,1737582615.354 [Default:CheckIn] Running Loop=6
2025-01-22T21:50:15.354Z,1737582615.354 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-01-22T21:50:15.354Z,1737582615.354 [Default:CheckIn:Read_GPS] Running Loop=1
2025-01-22T21:50:17.368Z,1737582617.368 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,215016.00,A,3648.15059,N,12147.22664,W,0.000,256.74,220125,,,D*78
2025-01-22T21:50:17.370Z,1737582617.370 [NAL9602](INFO): GPS fix at 20250122T215016: (36.802510, -121.787111)
2025-01-22T21:50:17.382Z,1737582617.382 [Default:CheckIn:Read_GPS] Stopped
2025-01-22T21:50:17.383Z,1737582617.383 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-01-22T21:50:26.093Z,1737582626.093 [DataOverHttps](INFO): Sending 129 bytes from file Logs/20250122T213715/Express0010.lzma
2025-01-22T21:50:27.095Z,1737582627.095 [DataOverHttps](INFO): Moved sent file to Logs/20250122T213715/Express0010.lzma.bak
2025-01-22T21:50:27.095Z,1737582627.095 [DataOverHttps](INFO): SBD MOMSN=23924628
2025-01-22T21:50:33.396Z,1737582633.396 [NAL9602](INFO): SBD MO Status=1, MOMSN=12479, MT Status=0, MTMSN=0
2025-01-22T21:50:33.396Z,1737582633.396 [NAL9602](INFO): No messages in MT queue
2025-01-22T21:50:46.521Z,1737582646.521 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20250122T213715/Courier0009.lzma
2025-01-22T21:50:47.523Z,1737582647.523 [DataOverHttps](INFO): Moved sent file to Logs/20250122T213715/Courier0009.lzma.bak
2025-01-22T21:50:47.523Z,1737582647.523 [DataOverHttps](INFO): SBD MOMSN=23924631
2025-01-22T21:50:48.843Z,1737582648.843 [Default:CheckIn:Read_Iridium] Stopped
2025-01-22T21:50:48.844Z,1737582648.844 [Default:CheckIn:C.Wait] Running Loop=1
2025-01-22T21:50:48.844Z,1737582648.844 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-01-22T21:51:04.142Z,1737582664.142 [NAL9602](INFO): Not Powering down - fast GPS
2025-01-22T21:55:49.516Z,1737582949.516 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-01-22T21:55:49.516Z,1737582949.516 [Default:CheckIn:C.Wait] Stopped
2025-01-22T21:55:49.516Z,1737582949.516 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-01-22T21:55:49.517Z,1737582949.517 [Default:CheckIn:D] Running Loop=1
2025-01-22T21:55:49.918Z,1737582949.918 [Default:CheckIn:D] Stopped
2025-01-22T21:55:49.918Z,1737582949.918 [Default:CheckIn:E] Running Loop=1
2025-01-22T21:55:50.334Z,1737582950.334 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  35.482849 min 
2025-01-22T21:55:50.334Z,1737582950.334 [Default:CheckIn:E] Stopped
2025-01-22T21:55:50.334Z,1737582950.334 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-01-22T21:55:50.334Z,1737582950.334 [Default:CheckIn] Stopped
2025-01-22T21:55:50.334Z,1737582950.334 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-01-22T21:55:50.334Z,1737582950.334 [Default:CheckIn](INFO): Running loop #7
2025-01-22T21:55:50.335Z,1737582950.335 [Default:CheckIn] Running Loop=7
2025-01-22T21:55:50.335Z,1737582950.335 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-01-22T21:55:50.335Z,1737582950.335 [Default:CheckIn:Read_GPS] Running Loop=1
2025-01-22T21:55:52.341Z,1737582952.341 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,215551.00,A,3648.17932,N,12147.27671,W,0.486,194.73,220125,,,A*7C
2025-01-22T21:55:52.343Z,1737582952.343 [NAL9602](INFO): GPS fix at 20250122T215551: (36.802989, -121.787945)
2025-01-22T21:55:52.374Z,1737582952.374 [Default:CheckIn:Read_GPS] Stopped
2025-01-22T21:55:52.374Z,1737582952.374 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-01-22T21:56:00.411Z,1737582960.411 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250122T213715/Courier0012.lzma
2025-01-22T21:56:01.403Z,1737582961.403 [DataOverHttps](INFO): Moved sent file to Logs/20250122T213715/Courier0012.lzma.bak
2025-01-22T21:56:01.403Z,1737582961.403 [DataOverHttps](INFO): SBD MOMSN=23924635
2025-01-22T21:56:14.580Z,1737582974.580 [NAL9602](INFO): SBD MO Status=1, MOMSN=12480, MT Status=0, MTMSN=0
2025-01-22T21:56:14.580Z,1737582974.580 [NAL9602](INFO): No messages in MT queue
2025-01-22T21:56:19.995Z,1737582979.995 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20250122T213715/Express0013.lzma
2025-01-22T21:56:20.995Z,1737582980.995 [DataOverHttps](INFO): Moved sent file to Logs/20250122T213715/Express0013.lzma.bak
2025-01-22T21:56:20.995Z,1737582980.995 [DataOverHttps](INFO): SBD MOMSN=23924638
2025-01-22T21:56:22.656Z,1737582982.656 [Default:CheckIn:Read_Iridium] Stopped
2025-01-22T21:56:22.656Z,1737582982.656 [Default:CheckIn:C.Wait] Running Loop=1
2025-01-22T21:56:22.657Z,1737582982.657 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-01-22T21:56:45.295Z,1737583005.295 [NAL9602](INFO): Not Powering down - fast GPS
2025-01-22T22:00:44.829Z,1737583244.829 [MassServo](ERROR): getPosition uart error serial timeout
2025-01-22T22:00:44.830Z,1737583244.830 [MassServo](FAULT): Invalid EZ Servo response:"\377"
2025-01-22T22:00:44.830Z,1737583244.830 [MassServo] Communications Fault, FailCount= 1
2025-01-22T22:00:44.830Z,1737583244.830 [MassServo](ERROR): Communications Fault
2025-01-22T22:00:44.840Z,1737583244.840 [CBIT](ERROR): Communications Fault in component: MassServo
2025-01-22T22:00:45.097Z,1737583245.097 [MassServo](DEBUG): Uninitialize Mass Servo.
2025-01-22T22:00:45.097Z,1737583245.097 [MassServo](INFO): Powering down
2025-01-22T22:00:45.914Z,1737583245.914 [MassServo](DEBUG): Initializing EZServoServo.
2025-01-22T22:00:46.030Z,1737583246.030 [MassServo](DEBUG): Initializing MassServo.
2025-01-22T22:00:46.038Z,1737583246.038 [CBIT](INFO): Clearing failed state for component MassServo
2025-01-22T22:00:46.038Z,1737583246.038 [MassServo] No Fault, FailCount= 1
2025-01-22T22:01:23.070Z,1737583283.070 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-01-22T22:01:23.071Z,1737583283.071 [Default:CheckIn:C.Wait] Stopped
2025-01-22T22:01:23.071Z,1737583283.071 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-01-22T22:01:23.072Z,1737583283.072 [Default:CheckIn:D] Running Loop=1
2025-01-22T22:01:23.470Z,1737583283.470 [Default:CheckIn:D] Stopped
2025-01-22T22:01:23.470Z,1737583283.470 [Default:CheckIn:E] Running Loop=1
2025-01-22T22:01:23.866Z,1737583283.866 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  41.042049 min 
2025-01-22T22:01:23.866Z,1737583283.866 [Default:CheckIn:E] Stopped
2025-01-22T22:01:23.866Z,1737583283.866 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-01-22T22:01:23.866Z,1737583283.866 [Default:CheckIn] Stopped
2025-01-22T22:01:23.867Z,1737583283.867 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-01-22T22:01:23.867Z,1737583283.867 [Default:CheckIn](INFO): Running loop #8
2025-01-22T22:01:23.867Z,1737583283.867 [Default:CheckIn] Running Loop=8
2025-01-22T22:01:23.867Z,1737583283.867 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-01-22T22:01:23.867Z,1737583283.867 [Default:CheckIn:Read_GPS] Running Loop=1
2025-01-22T22:01:25.884Z,1737583285.884 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,220125.00,A,3648.17851,N,12147.27614,W,0.719,320.87,220125,,,A*79
2025-01-22T22:01:25.887Z,1737583285.887 [NAL9602](INFO): GPS fix at 20250122T220125: (36.802975, -121.787936)
2025-01-22T22:01:25.897Z,1737583285.897 [Default:CheckIn:Read_GPS] Stopped
2025-01-22T22:01:25.897Z,1737583285.897 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-01-22T22:01:33.617Z,1737583293.617 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20250122T213715/Courier0015.lzma
2025-01-22T22:01:34.620Z,1737583294.620 [DataOverHttps](INFO): Moved sent file to Logs/20250122T213715/Courier0015.lzma.bak
2025-01-22T22:01:34.620Z,1737583294.620 [DataOverHttps](INFO): SBD MOMSN=23924648
2025-01-22T22:01:51.753Z,1737583311.753 [DataOverHttps](INFO): Sending 191 bytes from file Logs/20250122T213715/Express0016.lzma
2025-01-22T22:01:52.755Z,1737583312.755 [DataOverHttps](INFO): Moved sent file to Logs/20250122T213715/Express0016.lzma.bak
2025-01-22T22:01:52.755Z,1737583312.755 [DataOverHttps](INFO): SBD MOMSN=23924651
2025-01-22T22:01:54.286Z,1737583314.286 [Default:CheckIn:Read_Iridium] Stopped
2025-01-22T22:01:54.286Z,1737583314.286 [Default:CheckIn:C.Wait] Running Loop=1
2025-01-22T22:01:54.286Z,1737583314.286 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-01-22T22:02:29.509Z,1737583349.509 [MassServo](FAULT): Unknown EZ Servo Error: 13
2025-01-22T22:02:29.509Z,1737583349.509 [MassServo] Hardware Fault, FailCount= 2
2025-01-22T22:02:29.509Z,1737583349.509 [MassServo](ERROR): Hardware Fault
2025-01-22T22:02:29.514Z,1737583349.514 [CBIT](ERROR): Hardware Fault in component: MassServo
2025-01-22T22:02:29.937Z,1737583349.937 [MassServo](DEBUG): Uninitialize Mass Servo.
2025-01-22T22:02:29.937Z,1737583349.937 [MassServo](INFO): Powering down
2025-01-22T22:02:30.748Z,1737583350.748 [MassServo](DEBUG): Initializing EZServoServo.
2025-01-22T22:02:30.873Z,1737583350.872 [MassServo](DEBUG): Initializing MassServo.
2025-01-22T22:02:30.903Z,1737583350.903 [CBIT](INFO): Clearing failed state for component MassServo
2025-01-22T22:02:30.903Z,1737583350.903 [MassServo] No Fault, FailCount= 2
2025-01-22T22:04:54.580Z,1737583494.580 [NAL9602](INFO): SBD MO Status=2, MOMSN=12481, MT Status=2, MTMSN=0
2025-01-22T22:04:54.580Z,1737583494.580 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-01-22T22:05:25.830Z,1737583525.830 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2025-01-22T22:05:25.830Z,1737583525.830 [DropWeight] Hardware Fault, FailCount= 1
2025-01-22T22:05:25.830Z,1737583525.830 [DropWeight](ERROR): Hardware Fault
2025-01-22T22:05:26.063Z,1737583526.063 [CommandExec](FAULT): Scheduling is paused
2025-01-22T22:05:26.063Z,1737583526.063 [CBIT](INFO): Critical error at 20250122T220525
2025-01-22T22:05:26.066Z,1737583526.066 [CBIT](ERROR): Hardware Fault in component: DropWeight
2025-01-22T22:05:26.066Z,1737583526.066 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2025-01-22T22:05:26.407Z,1737583526.407 [CBIT](INFO): Critical error at 20250122T220526
2025-01-22T22:06:28.056Z,1737583588.056 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-01-22T22:06:54.736Z,1737583614.736 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-01-22T22:06:54.736Z,1737583614.736 [Default:CheckIn:C.Wait] Stopped
2025-01-22T22:06:54.736Z,1737583614.736 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-01-22T22:06:54.737Z,1737583614.737 [Default:CheckIn:D] Running Loop=1
2025-01-22T22:06:55.144Z,1737583615.144 [Default:CheckIn:D] Stopped
2025-01-22T22:06:55.144Z,1737583615.144 [Default:CheckIn:E] Running Loop=1
2025-01-22T22:06:55.575Z,1737583615.575 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  46.569958 min 
2025-01-22T22:06:55.575Z,1737583615.575 [Default:CheckIn:E] Stopped
2025-01-22T22:06:55.575Z,1737583615.575 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-01-22T22:06:55.575Z,1737583615.575 [Default:CheckIn] Stopped
2025-01-22T22:06:55.575Z,1737583615.575 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-01-22T22:06:55.575Z,1737583615.575 [Default:CheckIn](INFO): Running loop #9
2025-01-22T22:06:55.575Z,1737583615.575 [Default:CheckIn] Running Loop=9
2025-01-22T22:06:55.575Z,1737583615.575 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-01-22T22:06:55.575Z,1737583615.575 [Default:CheckIn:Read_GPS] Running Loop=1
2025-01-22T22:06:57.556Z,1737583617.556 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,220657.00,A,3648.17024,N,12147.25352,W,0.894,1.36,220125,,,A*74
2025-01-22T22:06:57.567Z,1737583617.567 [NAL9602](INFO): GPS fix at 20250122T220657: (36.802837, -121.787559)
2025-01-22T22:06:57.580Z,1737583617.580 [Default:CheckIn:Read_GPS] Stopped
2025-01-22T22:06:57.580Z,1737583617.580 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-01-22T22:07:08.907Z,1737583628.907 [DataOverHttps](INFO): Sending 182 bytes from file Logs/20250122T213715/Courier0018.lzma
2025-01-22T22:07:09.907Z,1737583629.907 [DataOverHttps](INFO): Moved sent file to Logs/20250122T213715/Courier0018.lzma.bak
2025-01-22T22:07:09.907Z,1737583629.907 [DataOverHttps](INFO): SBD MOMSN=23924655
2025-01-22T22:07:26.454Z,1737583646.454 [DataOverHttps](INFO): Sending 285 bytes from file Logs/20250122T213715/Express0019.lzma
2025-01-22T22:07:27.430Z,1737583647.430 [CommandExec](IMPORTANT): got command quit
2025-01-22T22:07:27.457Z,1737583647.457 [DataOverHttps](INFO): Moved sent file to Logs/20250122T213715/Express0019.lzma.bak
2025-01-22T22:07:27.457Z,1737583647.457 [DataOverHttps](INFO): SBD MOMSN=23924660
2025-01-22T22:07:28.434Z,1737583648.434 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2025-01-22T22:07:28.434Z,1737583648.434 [CommandExec](INFO): Uninitializing the command executive.
2025-01-22T22:07:28.434Z,1737583648.434 [CommandExec](INFO): Uninitializing the command scheduler.
2025-01-22T22:07:28.434Z,1737583648.434 [CommandExec ThreadHandler](INFO): Thread cancelled.
2025-01-22T22:07:28.522Z,1737583648.522 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2025-01-22T22:07:28.522Z,1737583648.522 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2025-01-22T22:07:28.522Z,1737583648.522 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-01-22T22:07:28.522Z,1737583648.522 [NavChartDb](INFO): Join timeout helper Thread ID is 3865
2025-01-22T22:07:28.646Z,1737583648.646 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2025-01-22T22:07:28.647Z,1737583648.647 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-01-22T22:07:28.666Z,1737583648.666 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2025-01-22T22:07:28.667Z,1737583648.667 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-01-22T22:07:28.667Z,1737583648.667 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 3866
2025-01-22T22:07:28.990Z,1737583648.990 [Default:CheckIn:Read_Iridium] Stopped
2025-01-22T22:07:28.990Z,1737583648.990 [Default:CheckIn:C.Wait] Running Loop=1
2025-01-22T22:07:28.991Z,1737583648.991 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-01-22T22:07:29.138Z,1737583649.138 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2025-01-22T22:07:29.138Z,1737583649.138 [WetLabsBB2FL](INFO): Powering down
2025-01-22T22:07:29.139Z,1737583649.139 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-01-22T22:07:29.150Z,1737583649.150 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2025-01-22T22:07:29.150Z,1737583649.150 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-01-22T22:07:29.151Z,1737583649.151 [CTD_Seabird](INFO): Join timeout helper Thread ID is 3867
2025-01-22T22:07:29.690Z,1737583649.690 [CTD_Seabird](INFO): Powering down
2025-01-22T22:07:29.706Z,1737583649.706 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2025-01-22T22:07:29.706Z,1737583649.706 [CTD_Seabird](INFO): Powering down
2025-01-22T22:07:29.718Z,1737583649.718 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-01-22T22:07:29.734Z,1737583649.734 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2025-01-22T22:07:29.734Z,1737583649.734 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-01-22T22:07:29.734Z,1737583649.734 [Radio_Surface](INFO): Join timeout helper Thread ID is 3868
2025-01-22T22:07:29.878Z,1737583649.878 [Radio_Surface](INFO): Powering down
2025-01-22T22:07:29.879Z,1737583649.879 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2025-01-22T22:07:29.879Z,1737583649.879 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-01-22T22:07:29.894Z,1737583649.894 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2025-01-22T22:07:29.894Z,1737583649.894 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-01-22T22:07:29.894Z,1737583649.894 [Onboard](INFO): Join timeout helper Thread ID is 3869
2025-01-22T22:07:30.586Z,1737583650.586 [NAL9602](INFO): Not Powering down - fast GPS
2025-01-22T22:07:31.274Z,1737583651.274 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2025-01-22T22:07:31.275Z,1737583651.275 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-01-22T22:07:31.295Z,1737583651.295 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2025-01-22T22:07:31.295Z,1737583651.295 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-01-22T22:07:31.295Z,1737583651.295 [DataOverHttps](INFO): Join timeout helper Thread ID is 3870
2025-01-22T22:07:34.029Z,1737583654.029 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2025-01-22T22:07:34.032Z,1737583654.032 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-01-22T22:07:34.034Z,1737583654.034 [ComponentRegistry](INFO): Shutting down DATMMP ThreadHandler
2025-01-22T22:07:34.034Z,1737583654.034 [DATMMP ThreadHandler](INFO): Thread cancelled.
2025-01-22T22:07:34.035Z,1737583654.035 [DATMMP](INFO): Join timeout helper Thread ID is 3871
2025-01-22T22:07:34.138Z,1737583654.138 [DATMMP](INFO): Stop
2025-01-22T22:07:34.138Z,1737583654.138 [DATMMP](INFO): uninitialize
2025-01-22T22:07:34.138Z,1737583654.138 [DATMMP](INFO): Powering down
2025-01-22T22:07:34.226Z,1737583654.226 [DATMMP ThreadHandler](INFO): Uninitializing protected caller thread.
2025-01-22T22:07:34.226Z,1737583654.226 [DATMMP](INFO): uninitialize
2025-01-22T22:07:34.226Z,1737583654.226 [DATMMP](INFO): Powering down
2025-01-22T22:07:34.227Z,1737583654.227 [DATMMP ThreadHandler](INFO): Thread cancelled.
2025-01-22T22:07:34.228Z,1737583654.228 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2025-01-22T22:07:34.228Z,1737583654.228 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-01-22T22:07:34.229Z,1737583654.229 [BackseatComponent](INFO): Join timeout helper Thread ID is 3872
2025-01-22T22:07:34.254Z,1737583654.254 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2025-01-22T22:07:34.254Z,1737583654.254 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-01-22T22:07:34.258Z,1737583654.258 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2025-01-22T22:07:34.258Z,1737583654.258 [logger ThreadHandler](INFO): Thread cancelled.
2025-01-22T22:07:34.259Z,1737583654.259 [logger](INFO): Join timeout helper Thread ID is 3873
2025-01-22T22:07:34.301Z,1737583654.301 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2025-01-22T22:07:34.302Z,1737583654.302 [logger ThreadHandler](INFO): Thread cancelled.
2025-01-22T22:07:34.314Z,1737583654.314 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2025-01-22T22:07:34.314Z,1737583654.314 [CommandLine ThreadHandler](INFO): Thread cancelled.
2025-01-22T22:07:34.315Z,1737583654.315 [CommandLine](INFO): Join timeout helper Thread ID is 3874
2025-01-22T22:07:34.394Z,1737583654.394 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2025-01-22T22:07:34.395Z,1737583654.395 [CommandLine ThreadHandler](INFO): Thread cancelled.
2025-01-22T22:07:34.414Z,1737583654.414 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2025-01-22T22:07:34.414Z,1737583654.414 [CommandExec ThreadHandler](INFO): Thread cancelled.
2025-01-22T22:07:34.415Z,1737583654.415 [CommandExec](INFO): Join timeout helper Thread ID is 3875
2025-01-22T22:07:34.416Z,1737583654.416 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2025-01-22T22:07:34.416Z,1737583654.416 [controlThread ThreadHandler](INFO): Thread cancelled.
2025-01-22T22:07:34.417Z,1737583654.417 [controlThread](INFO): Join timeout helper Thread ID is 3876
2025-01-22T22:07:34.610Z,1737583654.610 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2025-01-22T22:07:34.610Z,1737583654.610 [controlThread](DEBUG): Uninitializing ControlThread
2025-01-22T22:07:34.610Z,1737583654.610 [AHRS_M2](INFO): Powering down
2025-01-22T22:07:34.683Z,1737583654.683 [NAL9602](INFO): Powering down
2025-01-22T22:07:34.684Z,1737583654.684 [Sonardyne_Nano](INFO): Powering down
2025-01-22T22:07:34.803Z,1737583654.803 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2025-01-22T22:07:34.803Z,1737583654.803 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2025-01-22T22:07:34.804Z,1737583654.804 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2025-01-22T22:07:34.804Z,1737583654.804 [MissionManager](INFO): Uninitializing Mission Default
2025-01-22T22:07:34.804Z,1737583654.804 [Default] Stopped
2025-01-22T22:07:34.805Z,1737583654.805 [Default](DEBUG): Aggregate::uninitialize Default
2025-01-22T22:07:34.805Z,1737583654.805 [Default:B.GoToSurface] Stopped
2025-01-22T22:07:34.805Z,1737583654.805 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-01-22T22:07:34.805Z,1737583654.805 [Default:CheckIn] Stopped
2025-01-22T22:07:34.805Z,1737583654.805 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-01-22T22:07:34.805Z,1737583654.805 [Default:CheckIn:C.Wait] Stopped
2025-01-22T22:07:34.805Z,1737583654.805 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-01-22T22:07:34.808Z,1737583654.808 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2025-01-22T22:07:34.808Z,1737583654.808 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2025-01-22T22:07:34.808Z,1737583654.808 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2025-01-22T22:07:34.809Z,1737583654.809 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2025-01-22T22:07:34.809Z,1737583654.809 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2025-01-22T22:07:34.809Z,1737583654.809 [BuoyancyServo](INFO): Powering down
2025-01-22T22:07:34.822Z,1737583654.822 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-01-22T22:07:34.822Z,1737583654.822 [ElevatorServo](INFO): Powering down
2025-01-22T22:07:34.823Z,1737583654.823 [MassServo](DEBUG): Uninitialize Mass Servo.
2025-01-22T22:07:34.823Z,1737583654.823 [MassServo](INFO): Powering down
2025-01-22T22:07:34.824Z,1737583654.824 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-01-22T22:07:34.824Z,1737583654.824 [RudderServo](INFO): Powering down
2025-01-22T22:07:34.824Z,1737583654.824 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2025-01-22T22:07:34.825Z,1737583654.825 [ThrusterHE](INFO): Powering down
2025-01-22T22:07:34.825Z,1737583654.825 [SBIT](DEBUG): Uninitialize SBIT Component.
2025-01-22T22:07:34.826Z,1737583654.826 [IBIT](DEBUG): Uninitialize IBIT Component.
2025-01-22T22:07:34.826Z,1737583654.826 [CBIT](DEBUG): Uninitialize CBIT Component.
2025-01-22T22:07:34.826Z,1737583654.826 [CBIT](DEBUG): Powering off loads.
2025-01-22T22:07:34.837Z,1737583654.837 [CBIT](DEBUG): Disabling WDT.
2025-01-22T22:07:34.849Z,1737583654.849 [CBIT](DEBUG): Opening all GF detection circuits.
2025-01-22T22:07:34.851Z,1737583654.851 [controlThread ThreadHandler](INFO): Thread cancelled.
2025-01-22T22:07:34.878Z,1737583654.878 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-01-22T22:07:34.881Z,1737583654.881 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-01-22T22:07:34.887Z,1737583654.887 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-01-22T22:07:34.894Z,1737583654.894 [DATMMP ThreadHandler](INFO): Thread cancelled.
2025-01-22T22:07:34.936Z,1737583654.936 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-01-22T22:07:35.142Z,1737583655.142 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-01-22T22:07:35.146Z,1737583655.146 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-01-22T22:07:35.165Z,1737583655.165 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-01-22T22:07:35.239Z,1737583655.239 [logger ThreadHandler](INFO): Thread cancelled.