2025-03-27T21:17:40.928Z,1743110260.928 [CommandExec](IMPORTANT): got command restart logs 2025-03-27T21:18:34.580Z,1743110314.580 [CommandLine](INFO): End of History 2025-03-27T21:18:34.584Z,1743110314.584 [CommandLine](INFO): End of History 2025-03-27T21:18:34.588Z,1743110314.588 [CommandLine](INFO): End of History 2025-03-27T21:18:34.590Z,1743110314.590 [CommandLine](INFO): End of History 2025-03-27T21:19:27.208Z,1743110367.208 [CommandExec](IMPORTANT): got command show stack 2025-03-27T21:19:27.208Z,1743110367.208 [CommandExec](IMPORTANT): Behavior Stack: 2025-03-27T21:19:27.208Z,1743110367.208 [Default](IMPORTANT): Priority 0: Default:B.GoToSurface 2025-03-27T21:19:27.208Z,1743110367.208 [Default:CheckIn](IMPORTANT): Priority 1: Default:CheckIn:Read_GPS 2025-03-27T21:19:38.100Z,1743110378.100 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-03-27T21:19:46.667Z,1743110386.667 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-03-27T21:19:57.510Z,1743110397.510 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2025-03-27T21:19:57.510Z,1743110397.510 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-03-27T21:19:57.521Z,1743110397.521 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-03-27T21:19:57.944Z,1743110397.944 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-03-27T21:19:57.944Z,1743110397.944 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2025-03-27T21:20:01.942Z,1743110401.942 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,212000.00,A,3648.13862,N,12147.26156,W,0.914,0.00,270325,,,A*70 2025-03-27T21:20:01.945Z,1743110401.945 [NAL9602](INFO): GPS fix at 20250327T212000: (36.802310, -121.787693) 2025-03-27T21:20:01.960Z,1743110401.960 [Default:CheckIn:Read_GPS] Stopped 2025-03-27T21:20:01.960Z,1743110401.960 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-03-27T21:20:02.379Z,1743110402.379 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2025-03-27T21:20:10.410Z,1743110410.410 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20250327T075707/Courier0214.lzma 2025-03-27T21:20:11.413Z,1743110411.413 [DataOverHttps](INFO): Moved sent file to Logs/20250327T075707/Courier0214.lzma.bak 2025-03-27T21:20:11.413Z,1743110411.413 [DataOverHttps](INFO): SBD MOMSN=24470558 2025-03-27T21:20:27.459Z,1743110427.459 [DataOverHttps](INFO): Sending 307 bytes from file Logs/20250327T211344/Courier0000.lzma 2025-03-27T21:20:28.460Z,1743110428.460 [DataOverHttps](INFO): Moved sent file to Logs/20250327T211344/Courier0000.lzma.bak 2025-03-27T21:20:28.460Z,1743110428.460 [DataOverHttps](INFO): SBD MOMSN=24470561 2025-03-27T21:20:34.266Z,1743110434.266 [NAL9602](INFO): Not Powering down - fast GPS 2025-03-27T21:20:44.926Z,1743110444.926 [DataOverHttps](INFO): Sending 38 bytes from file Logs/20250327T211344/Courier0004.lzma 2025-03-27T21:20:45.928Z,1743110445.928 [DataOverHttps](INFO): Moved sent file to Logs/20250327T211344/Courier0004.lzma.bak 2025-03-27T21:20:45.929Z,1743110445.929 [DataOverHttps](INFO): SBD MOMSN=24470568 2025-03-27T21:21:01.783Z,1743110461.783 [DataOverHttps](INFO): Sending 268 bytes from file Logs/20250327T211740/Courier0000.lzma 2025-03-27T21:21:02.784Z,1743110462.784 [DataOverHttps](INFO): Moved sent file to Logs/20250327T211740/Courier0000.lzma.bak 2025-03-27T21:21:02.784Z,1743110462.784 [DataOverHttps](INFO): SBD MOMSN=24470570 2025-03-27T21:21:18.790Z,1743110478.790 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20250327T075707/Express0215.lzma 2025-03-27T21:21:19.793Z,1743110479.793 [DataOverHttps](INFO): Moved sent file to Logs/20250327T075707/Express0215.lzma.bak 2025-03-27T21:21:19.793Z,1743110479.793 [DataOverHttps](INFO): SBD MOMSN=24470574 2025-03-27T21:21:35.659Z,1743110495.659 [DataOverHttps](INFO): Sending 549 bytes from file Logs/20250327T211344/Express0001.lzma 2025-03-27T21:21:36.660Z,1743110496.660 [DataOverHttps](INFO): Moved sent file to Logs/20250327T211344/Express0001.lzma.bak 2025-03-27T21:21:36.660Z,1743110496.660 [DataOverHttps](INFO): SBD MOMSN=24470576 2025-03-27T21:21:55.890Z,1743110515.890 [DataOverHttps](INFO): Sending 147 bytes from file Logs/20250327T211344/Express0005.lzma 2025-03-27T21:21:56.892Z,1743110516.892 [DataOverHttps](INFO): Moved sent file to Logs/20250327T211344/Express0005.lzma.bak 2025-03-27T21:21:56.892Z,1743110516.892 [DataOverHttps](INFO): SBD MOMSN=24470588 2025-03-27T21:22:20.970Z,1743110540.970 [BPC1](INFO): Calculating totals. Valid battery stick count: 54. Valid reserve battery stick count: 5. 2025-03-27T21:22:20.973Z,1743110540.973 [BPC1](INFO): Received data from all battery sticks. 2025-03-27T21:22:35.051Z,1743110555.051 [DataOverHttps](INFO): Sending 583 bytes from file Logs/20250327T211740/Express0001.lzma 2025-03-27T21:22:43.079Z,1743110563.079 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting. 2025-03-27T21:23:06.535Z,1743110586.535 [DataOverHttps](INFO): Sending 583 bytes from file Logs/20250327T211740/Express0001.lzma 2025-03-27T21:23:07.528Z,1743110587.528 [DataOverHttps](INFO): Moved sent file to Logs/20250327T211740/Express0001.lzma.bak 2025-03-27T21:23:07.528Z,1743110587.528 [DataOverHttps](INFO): SBD MOMSN=24470598 2025-03-27T21:23:23.866Z,1743110603.866 [DataOverHttps](INFO): Sending 61 bytes from file Logs/20250327T211740/Express0004.lzma 2025-03-27T21:23:24.870Z,1743110604.870 [DataOverHttps](INFO): Moved sent file to Logs/20250327T211740/Express0004.lzma.bak 2025-03-27T21:23:24.870Z,1743110604.870 [DataOverHttps](INFO): SBD MOMSN=24470606 2025-03-27T21:23:26.021Z,1743110606.021 [Default:CheckIn:Read_Iridium] Stopped 2025-03-27T21:23:26.021Z,1743110606.021 [Default:CheckIn:C.Wait] Running Loop=1 2025-03-27T21:23:26.021Z,1743110606.021 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-03-27T21:28:26.677Z,1743110906.677 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-03-27T21:28:26.677Z,1743110906.677 [Default:CheckIn:C.Wait] Stopped 2025-03-27T21:28:26.677Z,1743110906.677 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-03-27T21:28:26.678Z,1743110906.678 [Default:CheckIn:D] Running Loop=1 2025-03-27T21:28:27.090Z,1743110907.090 [Default:CheckIn:D] Stopped 2025-03-27T21:28:27.090Z,1743110907.090 [Default:CheckIn:E] Running Loop=1 2025-03-27T21:28:27.496Z,1743110907.496 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 11.105566 min 2025-03-27T21:28:27.496Z,1743110907.496 [Default:CheckIn:E] Stopped 2025-03-27T21:28:27.496Z,1743110907.496 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-03-27T21:28:27.496Z,1743110907.496 [Default:CheckIn] Stopped 2025-03-27T21:28:27.496Z,1743110907.496 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-03-27T21:28:27.496Z,1743110907.496 [Default:CheckIn](INFO): Running loop #2 2025-03-27T21:28:27.496Z,1743110907.496 [Default:CheckIn] Running Loop=2 2025-03-27T21:28:27.496Z,1743110907.496 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-03-27T21:28:27.497Z,1743110907.497 [Default:CheckIn:Read_GPS] Running Loop=1 2025-03-27T21:28:29.497Z,1743110909.497 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,212828.00,A,3648.17438,N,12147.27815,W,0.058,281.98,270325,,,A*71 2025-03-27T21:28:29.499Z,1743110909.499 [NAL9602](INFO): GPS fix at 20250327T212828: (36.802906, -121.787969) 2025-03-27T21:28:29.510Z,1743110909.510 [Default:CheckIn:Read_GPS] Stopped 2025-03-27T21:28:29.510Z,1743110909.510 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-03-27T21:28:36.479Z,1743110916.479 [DataOverHttps](INFO): Sending 203 bytes from file Logs/20250327T211740/Courier0006.lzma 2025-03-27T21:28:37.480Z,1743110917.480 [DataOverHttps](INFO): Moved sent file to Logs/20250327T211740/Courier0006.lzma.bak 2025-03-27T21:28:37.480Z,1743110917.480 [DataOverHttps](INFO): SBD MOMSN=24470652 2025-03-27T21:28:53.763Z,1743110933.763 [DataOverHttps](INFO): Sending 184 bytes from file Logs/20250327T211740/Express0007.lzma 2025-03-27T21:28:54.760Z,1743110934.760 [DataOverHttps](INFO): Moved sent file to Logs/20250327T211740/Express0007.lzma.bak 2025-03-27T21:28:54.760Z,1743110934.760 [DataOverHttps](INFO): SBD MOMSN=24470655 2025-03-27T21:28:56.181Z,1743110936.181 [Default:CheckIn:Read_Iridium] Stopped 2025-03-27T21:28:56.181Z,1743110936.181 [Default:CheckIn:C.Wait] Running Loop=1 2025-03-27T21:28:56.181Z,1743110936.181 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-03-27T21:28:57.864Z,1743110937.864 [CBIT](INFO): Clearing failed state for component DropWeight 2025-03-27T21:28:57.864Z,1743110937.864 [DropWeight] No Fault, FailCount= 1 2025-03-27T21:29:00.204Z,1743110940.204 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2025-03-27T21:29:00.286Z,1743110940.286 [NAL9602](ERROR): received: +CSQ:0 OK 2025-03-27T21:29:53.538Z,1743110993.538 [NAL9602](INFO): SBD MO Status=2, MOMSN=18769, MT Status=2, MTMSN=0 2025-03-27T21:29:53.539Z,1743110993.539 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-03-27T21:30:42.417Z,1743111042.417 [NAL9602](INFO): SBD MO Status=2, MOMSN=18769, MT Status=2, MTMSN=0 2025-03-27T21:30:42.417Z,1743111042.417 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-03-27T21:31:17.167Z,1743111077.167 [NAL9602](INFO): SBD MO Status=2, MOMSN=18769, MT Status=2, MTMSN=0 2025-03-27T21:31:17.168Z,1743111077.168 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-03-27T21:33:32.092Z,1743111212.092 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-03-27T21:33:56.791Z,1743111236.791 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-03-27T21:33:56.791Z,1743111236.791 [Default:CheckIn:C.Wait] Stopped 2025-03-27T21:33:56.791Z,1743111236.791 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-03-27T21:33:56.791Z,1743111236.791 [Default:CheckIn:D] Running Loop=1 2025-03-27T21:33:57.196Z,1743111237.196 [Default:CheckIn:D] Stopped 2025-03-27T21:33:57.196Z,1743111237.196 [Default:CheckIn:E] Running Loop=1 2025-03-27T21:33:57.607Z,1743111237.607 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 16.607337 min 2025-03-27T21:33:57.607Z,1743111237.607 [Default:CheckIn:E] Stopped 2025-03-27T21:33:57.607Z,1743111237.607 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-03-27T21:33:57.607Z,1743111237.607 [Default:CheckIn] Stopped 2025-03-27T21:33:57.607Z,1743111237.607 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-03-27T21:33:57.607Z,1743111237.607 [Default:CheckIn](INFO): Running loop #3 2025-03-27T21:33:57.608Z,1743111237.608 [Default:CheckIn] Running Loop=3 2025-03-27T21:33:57.608Z,1743111237.608 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-03-27T21:33:57.608Z,1743111237.608 [Default:CheckIn:Read_GPS] Running Loop=1 2025-03-27T21:33:59.610Z,1743111239.610 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,213359.00,A,3648.17420,N,12147.28009,W,0.039,281.98,270325,,,A*79 2025-03-27T21:33:59.612Z,1743111239.612 [NAL9602](INFO): GPS fix at 20250327T213359: (36.802903, -121.788002) 2025-03-27T21:33:59.622Z,1743111239.622 [Default:CheckIn:Read_GPS] Stopped 2025-03-27T21:33:59.622Z,1743111239.622 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-03-27T21:34:07.270Z,1743111247.270 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20250327T211740/Courier0009.lzma 2025-03-27T21:34:08.272Z,1743111248.272 [DataOverHttps](INFO): Moved sent file to Logs/20250327T211740/Courier0009.lzma.bak 2025-03-27T21:34:08.272Z,1743111248.272 [DataOverHttps](INFO): SBD MOMSN=24470664 2025-03-27T21:34:24.582Z,1743111264.582 [DataOverHttps](INFO): Sending 227 bytes from file Logs/20250327T211740/Express0010.lzma 2025-03-27T21:34:25.584Z,1743111265.584 [DataOverHttps](INFO): Moved sent file to Logs/20250327T211740/Express0010.lzma.bak 2025-03-27T21:34:25.584Z,1743111265.584 [DataOverHttps](INFO): SBD MOMSN=24470667 2025-03-27T21:34:27.101Z,1743111267.101 [Default:CheckIn:Read_Iridium] Stopped 2025-03-27T21:34:27.101Z,1743111267.101 [Default:CheckIn:C.Wait] Running Loop=1 2025-03-27T21:34:27.101Z,1743111267.101 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-03-27T21:34:32.337Z,1743111272.337 [NAL9602](INFO): Not Powering down - fast GPS 2025-03-27T21:39:27.702Z,1743111567.702 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-03-27T21:39:27.702Z,1743111567.702 [Default:CheckIn:C.Wait] Stopped 2025-03-27T21:39:27.702Z,1743111567.702 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-03-27T21:39:27.702Z,1743111567.702 [Default:CheckIn:D] Running Loop=1 2025-03-27T21:39:28.101Z,1743111568.101 [Default:CheckIn:D] Stopped 2025-03-27T21:39:28.101Z,1743111568.101 [Default:CheckIn:E] Running Loop=1 2025-03-27T21:39:28.509Z,1743111568.509 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 22.122424 min 2025-03-27T21:39:28.509Z,1743111568.509 [Default:CheckIn:E] Stopped 2025-03-27T21:39:28.509Z,1743111568.509 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-03-27T21:39:28.509Z,1743111568.509 [Default:CheckIn] Stopped 2025-03-27T21:39:28.509Z,1743111568.509 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-03-27T21:39:28.509Z,1743111568.509 [Default:CheckIn](INFO): Running loop #4 2025-03-27T21:39:28.509Z,1743111568.509 [Default:CheckIn] Running Loop=4 2025-03-27T21:39:28.509Z,1743111568.509 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-03-27T21:39:28.509Z,1743111568.509 [Default:CheckIn:Read_GPS] Running Loop=1 2025-03-27T21:39:30.527Z,1743111570.527 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,213930.00,A,3648.17410,N,12147.27897,W,0.058,281.98,270325,,,A*78 2025-03-27T21:39:30.529Z,1743111570.529 [NAL9602](INFO): GPS fix at 20250327T213930: (36.802902, -121.787983) 2025-03-27T21:39:30.540Z,1743111570.540 [Default:CheckIn:Read_GPS] Stopped 2025-03-27T21:39:30.540Z,1743111570.540 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-03-27T21:39:37.966Z,1743111577.966 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20250327T211740/Courier0012.lzma 2025-03-27T21:39:38.969Z,1743111578.969 [DataOverHttps](INFO): Moved sent file to Logs/20250327T211740/Courier0012.lzma.bak 2025-03-27T21:39:38.969Z,1743111578.969 [DataOverHttps](INFO): SBD MOMSN=24470715 2025-03-27T21:39:58.150Z,1743111598.150 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20250327T211740/Express0013.lzma 2025-03-27T21:39:59.152Z,1743111599.152 [DataOverHttps](INFO): Moved sent file to Logs/20250327T211740/Express0013.lzma.bak 2025-03-27T21:39:59.152Z,1743111599.152 [DataOverHttps](INFO): SBD MOMSN=24470718 2025-03-27T21:40:00.465Z,1743111600.465 [Default:CheckIn:Read_Iridium] Stopped 2025-03-27T21:40:00.466Z,1743111600.466 [Default:CheckIn:C.Wait] Running Loop=1 2025-03-27T21:40:00.466Z,1743111600.466 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-03-27T21:44:33.172Z,1743111873.172 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-03-27T21:45:01.058Z,1743111901.058 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-03-27T21:45:01.058Z,1743111901.058 [Default:CheckIn:C.Wait] Stopped 2025-03-27T21:45:01.058Z,1743111901.058 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-03-27T21:45:01.058Z,1743111901.058 [Default:CheckIn:D] Running Loop=1 2025-03-27T21:45:01.470Z,1743111901.470 [Default:CheckIn:D] Stopped 2025-03-27T21:45:01.470Z,1743111901.470 [Default:CheckIn:E] Running Loop=1 2025-03-27T21:45:01.882Z,1743111901.882 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 27.678569 min 2025-03-27T21:45:01.882Z,1743111901.882 [Default:CheckIn:E] Stopped 2025-03-27T21:45:01.882Z,1743111901.882 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-03-27T21:45:01.882Z,1743111901.882 [Default:CheckIn] Stopped 2025-03-27T21:45:01.882Z,1743111901.882 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-03-27T21:45:01.883Z,1743111901.883 [Default:CheckIn](INFO): Running loop #5 2025-03-27T21:45:01.883Z,1743111901.883 [Default:CheckIn] Running Loop=5 2025-03-27T21:45:01.883Z,1743111901.883 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-03-27T21:45:01.883Z,1743111901.883 [Default:CheckIn:Read_GPS] Running Loop=1 2025-03-27T21:45:03.881Z,1743111903.881 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,214503.00,A,3648.17098,N,12147.28817,W,0.408,25.38,270325,,,A*47 2025-03-27T21:45:03.884Z,1743111903.884 [NAL9602](INFO): GPS fix at 20250327T214503: (36.802850, -121.788136) 2025-03-27T21:45:03.894Z,1743111903.894 [Default:CheckIn:Read_GPS] Stopped 2025-03-27T21:45:03.894Z,1743111903.894 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-03-27T21:45:11.106Z,1743111911.106 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20250327T211740/Courier0015.lzma 2025-03-27T21:45:12.108Z,1743111912.108 [DataOverHttps](INFO): Moved sent file to Logs/20250327T211740/Courier0015.lzma.bak 2025-03-27T21:45:12.108Z,1743111912.108 [DataOverHttps](INFO): SBD MOMSN=24470730 2025-03-27T21:45:28.074Z,1743111928.074 [DataOverHttps](INFO): Sending 226 bytes from file Logs/20250327T211740/Express0016.lzma 2025-03-27T21:45:29.077Z,1743111929.077 [DataOverHttps](INFO): Moved sent file to Logs/20250327T211740/Express0016.lzma.bak 2025-03-27T21:45:29.077Z,1743111929.077 [DataOverHttps](INFO): SBD MOMSN=24470733 2025-03-27T21:45:30.589Z,1743111930.589 [Default:CheckIn:Read_Iridium] Stopped 2025-03-27T21:45:30.589Z,1743111930.589 [Default:CheckIn:C.Wait] Running Loop=1 2025-03-27T21:45:30.589Z,1743111930.589 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-03-27T21:45:36.223Z,1743111936.223 [NAL9602](INFO): Not Powering down - fast GPS 2025-03-27T21:50:31.160Z,1743112231.160 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-03-27T21:50:31.160Z,1743112231.160 [Default:CheckIn:C.Wait] Stopped 2025-03-27T21:50:31.160Z,1743112231.160 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-03-27T21:50:31.160Z,1743112231.160 [Default:CheckIn:D] Running Loop=1 2025-03-27T21:50:31.573Z,1743112231.573 [Default:CheckIn:D] Stopped 2025-03-27T21:50:31.573Z,1743112231.573 [Default:CheckIn:E] Running Loop=1 2025-03-27T21:50:31.970Z,1743112231.970 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 33.180280 min 2025-03-27T21:50:31.970Z,1743112231.970 [Default:CheckIn:E] Stopped 2025-03-27T21:50:31.971Z,1743112231.971 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-03-27T21:50:31.971Z,1743112231.971 [Default:CheckIn] Stopped 2025-03-27T21:50:31.971Z,1743112231.971 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-03-27T21:50:31.971Z,1743112231.971 [Default:CheckIn](INFO): Running loop #6 2025-03-27T21:50:31.971Z,1743112231.971 [Default:CheckIn] Running Loop=6 2025-03-27T21:50:31.971Z,1743112231.971 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-03-27T21:50:31.971Z,1743112231.971 [Default:CheckIn:Read_GPS] Running Loop=1 2025-03-27T21:50:33.978Z,1743112233.978 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,215033.00,A,3648.16958,N,12147.27745,W,2.022,145.58,270325,,,A*7C 2025-03-27T21:50:33.980Z,1743112233.980 [NAL9602](INFO): GPS fix at 20250327T215033: (36.802826, -121.787958) 2025-03-27T21:50:33.990Z,1743112233.990 [Default:CheckIn:Read_GPS] Stopped 2025-03-27T21:50:33.991Z,1743112233.991 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-03-27T21:50:41.318Z,1743112241.318 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20250327T211740/Courier0018.lzma 2025-03-27T21:50:42.320Z,1743112242.320 [DataOverHttps](INFO): Moved sent file to Logs/20250327T211740/Courier0018.lzma.bak 2025-03-27T21:50:42.320Z,1743112242.320 [DataOverHttps](INFO): SBD MOMSN=24470784 2025-03-27T21:50:58.166Z,1743112258.166 [DataOverHttps](INFO): Sending 149 bytes from file Logs/20250327T211740/Express0019.lzma 2025-03-27T21:50:59.168Z,1743112259.168 [DataOverHttps](INFO): Moved sent file to Logs/20250327T211740/Express0019.lzma.bak 2025-03-27T21:50:59.168Z,1743112259.168 [DataOverHttps](INFO): SBD MOMSN=24470787 2025-03-27T21:51:00.654Z,1743112260.654 [Default:CheckIn:Read_Iridium] Stopped 2025-03-27T21:51:00.654Z,1743112260.654 [Default:CheckIn:C.Wait] Running Loop=1 2025-03-27T21:51:00.654Z,1743112260.654 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-03-27T21:51:04.684Z,1743112264.684 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2025-03-27T21:51:04.758Z,1743112264.758 [NAL9602](ERROR): received: +CSQ:0 OK769, 2, 0, 0, 0 OK 2025-03-27T21:55:36.172Z,1743112536.172 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-03-27T21:56:01.271Z,1743112561.271 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-03-27T21:56:01.271Z,1743112561.271 [Default:CheckIn:C.Wait] Stopped 2025-03-27T21:56:01.271Z,1743112561.271 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-03-27T21:56:01.271Z,1743112561.271 [Default:CheckIn:D] Running Loop=1 2025-03-27T21:56:01.675Z,1743112561.675 [Default:CheckIn:D] Stopped 2025-03-27T21:56:01.675Z,1743112561.675 [Default:CheckIn:E] Running Loop=1 2025-03-27T21:56:02.094Z,1743112562.094 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 38.681970 min 2025-03-27T21:56:02.095Z,1743112562.095 [Default:CheckIn:E] Stopped 2025-03-27T21:56:02.095Z,1743112562.095 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-03-27T21:56:02.095Z,1743112562.095 [Default:CheckIn] Stopped 2025-03-27T21:56:02.095Z,1743112562.095 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-03-27T21:56:02.095Z,1743112562.095 [Default:CheckIn](INFO): Running loop #7 2025-03-27T21:56:02.095Z,1743112562.095 [Default:CheckIn] Running Loop=7 2025-03-27T21:56:02.095Z,1743112562.095 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-03-27T21:56:02.095Z,1743112562.095 [Default:CheckIn:Read_GPS] Running Loop=1 2025-03-27T21:56:04.090Z,1743112564.090 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,215603.00,A,3648.17424,N,12147.27950,W,0.136,145.58,270325,,,A*72 2025-03-27T21:56:04.092Z,1743112564.092 [NAL9602](INFO): GPS fix at 20250327T215603: (36.802904, -121.787992) 2025-03-27T21:56:04.103Z,1743112564.103 [Default:CheckIn:Read_GPS] Stopped 2025-03-27T21:56:04.103Z,1743112564.103 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-03-27T21:56:16.174Z,1743112576.174 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20250327T211740/Courier0021.lzma 2025-03-27T21:56:34.244Z,1743112594.244 [DataOverHttps](INFO): Moved sent file to Logs/20250327T211740/Courier0021.lzma.bak 2025-03-27T21:56:34.244Z,1743112594.244 [DataOverHttps](INFO): SBD MOMSN=24470796 2025-03-27T21:56:36.408Z,1743112596.408 [NAL9602](INFO): Not Powering down - fast GPS 2025-03-27T21:56:50.138Z,1743112610.138 [DataOverHttps](INFO): Sending 229 bytes from file Logs/20250327T211740/Express0022.lzma 2025-03-27T21:56:51.140Z,1743112611.140 [DataOverHttps](INFO): Moved sent file to Logs/20250327T211740/Express0022.lzma.bak 2025-03-27T21:56:51.140Z,1743112611.140 [DataOverHttps](INFO): SBD MOMSN=24470799 2025-03-27T21:56:52.589Z,1743112612.589 [Default:CheckIn:Read_Iridium] Stopped 2025-03-27T21:56:52.589Z,1743112612.589 [Default:CheckIn:C.Wait] Running Loop=1 2025-03-27T21:56:52.589Z,1743112612.589 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-03-27T21:58:59.020Z,1743112739.020 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2025-03-27T21:58:59.020Z,1743112739.020 [DropWeight] Hardware Fault, FailCount= 1 2025-03-27T21:58:59.020Z,1743112739.020 [DropWeight](ERROR): Hardware Fault 2025-03-27T21:58:59.085Z,1743112739.085 [CBIT](INFO): Critical error at 20250327T215859 2025-03-27T21:58:59.091Z,1743112739.091 [CBIT](ERROR): Hardware Fault in component: DropWeight 2025-03-27T21:58:59.092Z,1743112739.092 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2025-03-27T21:58:59.457Z,1743112739.457 [CBIT](INFO): Critical error at 20250327T215859 2025-03-27T22:01:53.155Z,1743112913.155 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-03-27T22:01:53.155Z,1743112913.155 [Default:CheckIn:C.Wait] Stopped 2025-03-27T22:01:53.155Z,1743112913.155 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-03-27T22:01:53.155Z,1743112913.155 [Default:CheckIn:D] Running Loop=1 2025-03-27T22:01:53.567Z,1743112913.567 [Default:CheckIn:D] Stopped 2025-03-27T22:01:53.567Z,1743112913.567 [Default:CheckIn:E] Running Loop=1 2025-03-27T22:01:53.979Z,1743112913.979 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 44.546855 min 2025-03-27T22:01:53.979Z,1743112913.979 [Default:CheckIn:E] Stopped 2025-03-27T22:01:53.979Z,1743112913.979 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-03-27T22:01:53.979Z,1743112913.979 [Default:CheckIn] Stopped 2025-03-27T22:01:53.979Z,1743112913.979 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-03-27T22:01:53.979Z,1743112913.979 [Default:CheckIn](INFO): Running loop #8 2025-03-27T22:01:53.979Z,1743112913.979 [Default:CheckIn] Running Loop=8 2025-03-27T22:01:53.979Z,1743112913.979 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-03-27T22:01:53.979Z,1743112913.979 [Default:CheckIn:Read_GPS] Running Loop=1 2025-03-27T22:01:55.981Z,1743112915.981 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,220155.00,A,3648.17328,N,12147.28078,W,0.136,145.58,270325,,,A*77 2025-03-27T22:01:55.984Z,1743112915.984 [NAL9602](INFO): GPS fix at 20250327T220155: (36.802888, -121.788013) 2025-03-27T22:01:56.021Z,1743112916.021 [Default:CheckIn:Read_GPS] Stopped 2025-03-27T22:01:56.022Z,1743112916.022 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-03-27T22:02:03.318Z,1743112923.318 [DataOverHttps](INFO): Sending 182 bytes from file Logs/20250327T211740/Courier0024.lzma 2025-03-27T22:02:04.321Z,1743112924.321 [DataOverHttps](INFO): Moved sent file to Logs/20250327T211740/Courier0024.lzma.bak 2025-03-27T22:02:04.321Z,1743112924.321 [DataOverHttps](INFO): SBD MOMSN=24470845 2025-03-27T22:02:20.202Z,1743112940.202 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20250327T211740/Express0025.lzma 2025-03-27T22:02:21.204Z,1743112941.204 [DataOverHttps](INFO): Moved sent file to Logs/20250327T211740/Express0025.lzma.bak 2025-03-27T22:02:21.204Z,1743112941.204 [DataOverHttps](INFO): SBD MOMSN=24470850 2025-03-27T22:02:22.650Z,1743112942.650 [Default:CheckIn:Read_Iridium] Stopped 2025-03-27T22:02:22.650Z,1743112942.650 [Default:CheckIn:C.Wait] Running Loop=1 2025-03-27T22:02:22.650Z,1743112942.650 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-03-27T22:02:26.684Z,1743112946.684 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2025-03-27T22:02:26.762Z,1743112946.762 [NAL9602](ERROR): received: +CSQ:0 OK769, 2, 0, 0, 0 OK 2025-03-27T22:06:58.173Z,1743113218.173 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-03-27T22:07:23.231Z,1743113243.231 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-03-27T22:07:23.231Z,1743113243.231 [Default:CheckIn:C.Wait] Stopped 2025-03-27T22:07:23.231Z,1743113243.231 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-03-27T22:07:23.231Z,1743113243.231 [Default:CheckIn:D] Running Loop=1 2025-03-27T22:07:23.629Z,1743113243.629 [Default:CheckIn:D] Stopped 2025-03-27T22:07:23.629Z,1743113243.629 [Default:CheckIn:E] Running Loop=1 2025-03-27T22:07:24.029Z,1743113244.029 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 50.047892 min 2025-03-27T22:07:24.029Z,1743113244.029 [Default:CheckIn:E] Stopped 2025-03-27T22:07:24.030Z,1743113244.030 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-03-27T22:07:24.030Z,1743113244.030 [Default:CheckIn] Stopped 2025-03-27T22:07:24.030Z,1743113244.030 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-03-27T22:07:24.030Z,1743113244.030 [Default:CheckIn](INFO): Running loop #9 2025-03-27T22:07:24.030Z,1743113244.030 [Default:CheckIn] Running Loop=9 2025-03-27T22:07:24.030Z,1743113244.030 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-03-27T22:07:24.030Z,1743113244.030 [Default:CheckIn:Read_GPS] Running Loop=1 2025-03-27T22:07:26.044Z,1743113246.044 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,220725.00,A,3648.17344,N,12147.27609,W,0.330,145.58,270325,,,A*77 2025-03-27T22:07:26.046Z,1743113246.046 [NAL9602](INFO): GPS fix at 20250327T220725: (36.802891, -121.787935) 2025-03-27T22:07:26.056Z,1743113246.056 [Default:CheckIn:Read_GPS] Stopped 2025-03-27T22:07:26.056Z,1743113246.056 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-03-27T22:07:33.698Z,1743113253.698 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20250327T211740/Courier0027.lzma 2025-03-27T22:07:34.700Z,1743113254.700 [DataOverHttps](INFO): Moved sent file to Logs/20250327T211740/Courier0027.lzma.bak 2025-03-27T22:07:34.700Z,1743113254.700 [DataOverHttps](INFO): SBD MOMSN=24470859 2025-03-27T22:07:55.423Z,1743113275.423 [DataOverHttps](INFO): Sending 229 bytes from file Logs/20250327T211740/Express0028.lzma 2025-03-27T22:07:58.411Z,1743113278.411 [NAL9602](INFO): Not Powering down - fast GPS 2025-03-27T22:08:01.444Z,1743113281.444 [DataOverHttps](INFO): Moved sent file to Logs/20250327T211740/Express0028.lzma.bak 2025-03-27T22:08:01.444Z,1743113281.444 [DataOverHttps](INFO): SBD MOMSN=24470862 2025-03-27T22:08:02.870Z,1743113282.870 [Default:CheckIn:Read_Iridium] Stopped 2025-03-27T22:08:02.870Z,1743113282.870 [Default:CheckIn:C.Wait] Running Loop=1 2025-03-27T22:08:02.871Z,1743113282.871 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-03-27T22:13:03.549Z,1743113583.549 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-03-27T22:13:03.549Z,1743113583.549 [Default:CheckIn:C.Wait] Stopped 2025-03-27T22:13:03.549Z,1743113583.549 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-03-27T22:13:03.549Z,1743113583.549 [Default:CheckIn:D] Running Loop=1 2025-03-27T22:13:03.941Z,1743113583.941 [Default:CheckIn:D] Stopped 2025-03-27T22:13:03.941Z,1743113583.941 [Default:CheckIn:E] Running Loop=1 2025-03-27T22:13:04.347Z,1743113584.347 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 55.719755 min 2025-03-27T22:13:04.347Z,1743113584.347 [Default:CheckIn:E] Stopped 2025-03-27T22:13:04.347Z,1743113584.347 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-03-27T22:13:04.347Z,1743113584.347 [Default:CheckIn] Stopped 2025-03-27T22:13:04.347Z,1743113584.347 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-03-27T22:13:04.348Z,1743113584.348 [Default:CheckIn](INFO): Running loop #10 2025-03-27T22:13:04.348Z,1743113584.348 [Default:CheckIn] Running Loop=10 2025-03-27T22:13:04.348Z,1743113584.348 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-03-27T22:13:04.348Z,1743113584.348 [Default:CheckIn:Read_GPS] Running Loop=1 2025-03-27T22:13:06.418Z,1743113586.418 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221305.00,A,3648.16866,N,12147.27664,W,0.389,193.29,270325,,,A*7E 2025-03-27T22:13:06.420Z,1743113586.420 [NAL9602](INFO): GPS fix at 20250327T221305: (36.802811, -121.787944) 2025-03-27T22:13:06.430Z,1743113586.430 [Default:CheckIn:Read_GPS] Stopped 2025-03-27T22:13:06.430Z,1743113586.430 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-03-27T22:13:13.742Z,1743113593.742 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20250327T211740/Courier0030.lzma 2025-03-27T22:13:14.744Z,1743113594.744 [DataOverHttps](INFO): Moved sent file to Logs/20250327T211740/Courier0030.lzma.bak 2025-03-27T22:13:14.744Z,1743113594.744 [DataOverHttps](INFO): SBD MOMSN=24470911 2025-03-27T22:13:31.034Z,1743113611.034 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20250327T211740/Express0031.lzma 2025-03-27T22:13:32.028Z,1743113612.028 [DataOverHttps](INFO): Moved sent file to Logs/20250327T211740/Express0031.lzma.bak 2025-03-27T22:13:32.028Z,1743113612.028 [DataOverHttps](INFO): SBD MOMSN=24470914 2025-03-27T22:13:33.442Z,1743113613.442 [Default:CheckIn:Read_Iridium] Stopped 2025-03-27T22:13:33.458Z,1743113613.458 [Default:CheckIn:C.Wait] Running Loop=1 2025-03-27T22:13:33.458Z,1743113613.458 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-03-27T22:13:37.066Z,1743113617.066 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2025-03-27T22:13:37.151Z,1743113617.151 [NAL9602](ERROR): received: +CSQ:0 OK769, 2, 0, 0, 0 OK 2025-03-27T22:13:59.301Z,1743113639.301 [CBIT](INFO): Clearing failed state for component DropWeight 2025-03-27T22:13:59.301Z,1743113639.301 [DropWeight] No Fault, FailCount= 1 2025-03-27T22:18:08.217Z,1743113888.217 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-03-27T22:18:34.090Z,1743113914.090 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-03-27T22:18:34.091Z,1743113914.091 [Default:CheckIn:C.Wait] Stopped 2025-03-27T22:18:34.091Z,1743113914.091 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-03-27T22:18:34.091Z,1743113914.091 [Default:CheckIn:D] Running Loop=1 2025-03-27T22:18:34.501Z,1743113914.501 [Default:CheckIn:D] Stopped 2025-03-27T22:18:34.501Z,1743113914.501 [Default:CheckIn:E] Running Loop=1 2025-03-27T22:18:34.905Z,1743113914.905 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 61.229093 min 2025-03-27T22:18:34.905Z,1743113914.905 [Default:CheckIn:E] Stopped 2025-03-27T22:18:34.906Z,1743113914.906 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-03-27T22:18:34.906Z,1743113914.906 [Default:CheckIn] Stopped 2025-03-27T22:18:34.906Z,1743113914.906 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-03-27T22:18:34.906Z,1743113914.906 [Default:CheckIn](INFO): Running loop #11 2025-03-27T22:18:34.906Z,1743113914.906 [Default:CheckIn] Running Loop=11 2025-03-27T22:18:34.910Z,1743113914.910 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-03-27T22:18:34.910Z,1743113914.910 [Default:CheckIn:Read_GPS] Running Loop=1 2025-03-27T22:18:36.906Z,1743113916.906 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221836.00,A,3648.16354,N,12147.29381,W,0.117,136.24,270325,,,A*78 2025-03-27T22:18:36.908Z,1743113916.908 [NAL9602](INFO): GPS fix at 20250327T221836: (36.802726, -121.788230) 2025-03-27T22:18:36.919Z,1743113916.919 [Default:CheckIn:Read_GPS] Stopped 2025-03-27T22:18:36.919Z,1743113916.919 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-03-27T22:18:44.222Z,1743113924.222 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250327T211740/Courier0033.lzma 2025-03-27T22:18:45.224Z,1743113925.224 [DataOverHttps](INFO): Moved sent file to Logs/20250327T211740/Courier0033.lzma.bak 2025-03-27T22:18:45.225Z,1743113925.225 [DataOverHttps](INFO): SBD MOMSN=24470927 2025-03-27T22:19:01.114Z,1743113941.114 [DataOverHttps](INFO): Sending 227 bytes from file Logs/20250327T211740/Express0034.lzma 2025-03-27T22:19:02.116Z,1743113942.116 [DataOverHttps](INFO): Moved sent file to Logs/20250327T211740/Express0034.lzma.bak 2025-03-27T22:19:02.116Z,1743113942.116 [DataOverHttps](INFO): SBD MOMSN=24470930 2025-03-27T22:19:03.584Z,1743113943.584 [Default:CheckIn:Read_Iridium] Stopped 2025-03-27T22:19:03.584Z,1743113943.584 [Default:CheckIn:C.Wait] Running Loop=1 2025-03-27T22:19:03.584Z,1743113943.584 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-03-27T22:19:09.219Z,1743113949.219 [NAL9602](INFO): Not Powering down - fast GPS 2025-03-27T22:24:04.176Z,1743114244.176 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-03-27T22:24:04.176Z,1743114244.176 [Default:CheckIn:C.Wait] Stopped 2025-03-27T22:24:04.176Z,1743114244.176 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-03-27T22:24:04.176Z,1743114244.176 [Default:CheckIn:D] Running Loop=1 2025-03-27T22:24:04.587Z,1743114244.587 [Default:CheckIn:D] Stopped 2025-03-27T22:24:04.587Z,1743114244.587 [Default:CheckIn:E] Running Loop=1 2025-03-27T22:24:04.979Z,1743114244.979 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 66.730522 min 2025-03-27T22:24:04.979Z,1743114244.979 [Default:CheckIn:E] Stopped 2025-03-27T22:24:04.979Z,1743114244.979 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-03-27T22:24:04.979Z,1743114244.979 [Default:CheckIn] Stopped 2025-03-27T22:24:04.979Z,1743114244.979 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-03-27T22:24:04.979Z,1743114244.979 [Default:CheckIn](INFO): Running loop #12 2025-03-27T22:24:04.979Z,1743114244.979 [Default:CheckIn] Running Loop=12 2025-03-27T22:24:04.980Z,1743114244.980 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-03-27T22:24:04.980Z,1743114244.980 [Default:CheckIn:Read_GPS] Running Loop=1 2025-03-27T22:24:06.987Z,1743114246.987 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,222406.00,A,3648.16846,N,12147.28244,W,0.894,136.24,270325,,,A*77 2025-03-27T22:24:06.990Z,1743114246.990 [NAL9602](INFO): GPS fix at 20250327T222406: (36.802808, -121.788041) 2025-03-27T22:24:06.000Z,1743114247.000 [Default:CheckIn:Read_GPS] Stopped 2025-03-27T22:24:07.000Z,1743114247.000 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-03-27T22:24:14.614Z,1743114254.614 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250327T211740/Courier0036.lzma 2025-03-27T22:24:15.616Z,1743114255.616 [DataOverHttps](INFO): Moved sent file to Logs/20250327T211740/Courier0036.lzma.bak 2025-03-27T22:24:15.616Z,1743114255.616 [DataOverHttps](INFO): SBD MOMSN=24470978 2025-03-27T22:24:31.634Z,1743114271.634 [DataOverHttps](INFO): Sending 149 bytes from file Logs/20250327T211740/Express0037.lzma 2025-03-27T22:24:32.636Z,1743114272.636 [DataOverHttps](INFO): Moved sent file to Logs/20250327T211740/Express0037.lzma.bak 2025-03-27T22:24:32.637Z,1743114272.637 [DataOverHttps](INFO): SBD MOMSN=24470981 2025-03-27T22:24:34.074Z,1743114274.074 [Default:CheckIn:Read_Iridium] Stopped 2025-03-27T22:24:34.074Z,1743114274.074 [Default:CheckIn:C.Wait] Running Loop=1 2025-03-27T22:24:34.074Z,1743114274.074 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-03-27T22:24:37.716Z,1743114277.716 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2025-03-27T22:24:37.790Z,1743114277.790 [NAL9602](ERROR): received: +CSQ:0 OK769, 2, 0, 0, 0 OK 2025-03-27T22:29:09.254Z,1743114549.254 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-03-27T22:29:34.733Z,1743114574.733 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-03-27T22:29:34.733Z,1743114574.733 [Default:CheckIn:C.Wait] Stopped 2025-03-27T22:29:34.733Z,1743114574.733 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-03-27T22:29:34.734Z,1743114574.734 [Default:CheckIn:D] Running Loop=1 2025-03-27T22:29:35.120Z,1743114575.120 [Default:CheckIn:D] Stopped 2025-03-27T22:29:35.120Z,1743114575.120 [Default:CheckIn:E] Running Loop=1 2025-03-27T22:29:35.532Z,1743114575.532 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 72.239396 min 2025-03-27T22:29:35.532Z,1743114575.532 [Default:CheckIn:E] Stopped 2025-03-27T22:29:35.532Z,1743114575.532 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-03-27T22:29:35.532Z,1743114575.532 [Default:CheckIn] Stopped 2025-03-27T22:29:35.532Z,1743114575.532 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-03-27T22:29:35.532Z,1743114575.532 [Default:CheckIn](INFO): Running loop #13 2025-03-27T22:29:35.532Z,1743114575.532 [Default:CheckIn] Running Loop=13 2025-03-27T22:29:35.532Z,1743114575.532 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-03-27T22:29:35.533Z,1743114575.533 [Default:CheckIn:Read_GPS] Running Loop=1 2025-03-27T22:29:37.534Z,1743114577.534 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,222937.00,A,3648.16680,N,12147.26554,W,0.622,144.81,270325,,,A*7D 2025-03-27T22:29:37.536Z,1743114577.536 [NAL9602](INFO): GPS fix at 20250327T222937: (36.802780, -121.787759) 2025-03-27T22:29:37.566Z,1743114577.566 [Default:CheckIn:Read_GPS] Stopped 2025-03-27T22:29:37.566Z,1743114577.566 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-03-27T22:29:44.506Z,1743114584.506 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20250327T211740/Courier0039.lzma 2025-03-27T22:29:45.508Z,1743114585.508 [DataOverHttps](INFO): Moved sent file to Logs/20250327T211740/Courier0039.lzma.bak 2025-03-27T22:29:45.509Z,1743114585.509 [DataOverHttps](INFO): SBD MOMSN=24470990 2025-03-27T22:29:46.443Z,1743114586.443 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2025-03-27T22:29:46.445Z,1743114586.445 [BPC1](INFO): Received data from all battery sticks. 2025-03-27T22:30:04.198Z,1743114604.198 [DataOverHttps](INFO): Sending 227 bytes from file Logs/20250327T211740/Express0040.lzma 2025-03-27T22:30:05.200Z,1743114605.200 [DataOverHttps](INFO): Moved sent file to Logs/20250327T211740/Express0040.lzma.bak 2025-03-27T22:30:05.200Z,1743114605.200 [DataOverHttps](INFO): SBD MOMSN=24470993 2025-03-27T22:30:06.694Z,1743114606.694 [Default:CheckIn:Read_Iridium] Stopped 2025-03-27T22:30:06.695Z,1743114606.695 [Default:CheckIn:C.Wait] Running Loop=1 2025-03-27T22:30:06.695Z,1743114606.695 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-03-27T22:30:10.341Z,1743114610.341 [NAL9602](INFO): Not Powering down - fast GPS 2025-03-27T22:35:07.327Z,1743114907.327 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-03-27T22:35:07.328Z,1743114907.328 [Default:CheckIn:C.Wait] Stopped 2025-03-27T22:35:07.328Z,1743114907.328 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-03-27T22:35:07.328Z,1743114907.328 [Default:CheckIn:D] Running Loop=1 2025-03-27T22:35:07.743Z,1743114907.743 [Default:CheckIn:D] Stopped 2025-03-27T22:35:07.743Z,1743114907.743 [Default:CheckIn:E] Running Loop=1 2025-03-27T22:35:08.137Z,1743114908.137 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 77.783122 min 2025-03-27T22:35:08.137Z,1743114908.137 [Default:CheckIn:E] Stopped 2025-03-27T22:35:08.137Z,1743114908.137 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-03-27T22:35:08.137Z,1743114908.137 [Default:CheckIn] Stopped 2025-03-27T22:35:08.138Z,1743114908.138 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-03-27T22:35:08.138Z,1743114908.138 [Default:CheckIn](INFO): Running loop #14 2025-03-27T22:35:08.138Z,1743114908.138 [Default:CheckIn] Running Loop=14 2025-03-27T22:35:08.138Z,1743114908.138 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-03-27T22:35:08.138Z,1743114908.138 [Default:CheckIn:Read_GPS] Running Loop=1 2025-03-27T22:35:10.150Z,1743114910.150 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,223509.00,A,3648.16177,N,12147.27151,W,0.136,151.86,270325,,,A*73 2025-03-27T22:35:10.152Z,1743114910.152 [NAL9602](INFO): GPS fix at 20250327T223509: (36.802696, -121.787858) 2025-03-27T22:35:10.162Z,1743114910.162 [Default:CheckIn:Read_GPS] Stopped 2025-03-27T22:35:10.162Z,1743114910.162 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-03-27T22:35:17.794Z,1743114917.794 [DataOverHttps](INFO): Sending 86 bytes from file Logs/20250327T211740/Courier0042.lzma 2025-03-27T22:35:18.796Z,1743114918.796 [DataOverHttps](INFO): Moved sent file to Logs/20250327T211740/Courier0042.lzma.bak 2025-03-27T22:35:18.796Z,1743114918.796 [DataOverHttps](INFO): SBD MOMSN=24471043 2025-03-27T22:35:34.698Z,1743114934.698 [DataOverHttps](INFO): Sending 153 bytes from file Logs/20250327T211740/Express0043.lzma 2025-03-27T22:35:35.700Z,1743114935.700 [DataOverHttps](INFO): Moved sent file to Logs/20250327T211740/Express0043.lzma.bak 2025-03-27T22:35:35.701Z,1743114935.701 [DataOverHttps](INFO): SBD MOMSN=24471046 2025-03-27T22:35:37.221Z,1743114937.221 [Default:CheckIn:Read_Iridium] Stopped 2025-03-27T22:35:37.221Z,1743114937.221 [Default:CheckIn:C.Wait] Running Loop=1 2025-03-27T22:35:37.221Z,1743114937.221 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-03-27T22:35:40.848Z,1743114940.848 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2025-03-27T22:35:40.923Z,1743114940.923 [NAL9602](ERROR): received: +CSQ:0 OK769, 2, 0, 0, 0 OK 2025-03-27T22:38:14.659Z,1743115094.659 [CommandExec](IMPORTANT): got command quit 2025-03-27T22:38:15.663Z,1743115095.663 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-27T22:38:15.663Z,1743115095.663 [CommandExec](INFO): Uninitializing the command executive. 2025-03-27T22:38:15.663Z,1743115095.663 [CommandExec](INFO): Uninitializing the command scheduler. 2025-03-27T22:38:15.663Z,1743115095.663 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-03-27T22:38:15.707Z,1743115095.707 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2025-03-27T22:38:15.708Z,1743115095.708 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2025-03-27T22:38:15.708Z,1743115095.708 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-03-27T22:38:15.708Z,1743115095.708 [NavChartDb](INFO): Join timeout helper Thread ID is 1180 2025-03-27T22:38:15.835Z,1743115095.835 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-27T22:38:15.835Z,1743115095.835 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-03-27T22:38:15.846Z,1743115095.846 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2025-03-27T22:38:15.847Z,1743115095.847 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-03-27T22:38:15.847Z,1743115095.847 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1181 2025-03-27T22:38:16.063Z,1743115096.063 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-27T22:38:16.063Z,1743115096.063 [WetLabsBB2FL](INFO): Powering down 2025-03-27T22:38:16.064Z,1743115096.064 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-03-27T22:38:16.066Z,1743115096.066 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2025-03-27T22:38:16.066Z,1743115096.066 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-03-27T22:38:16.067Z,1743115096.067 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1182 2025-03-27T22:38:16.755Z,1743115096.755 [CTD_Seabird](INFO): Powering down 2025-03-27T22:38:16.767Z,1743115096.767 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-27T22:38:16.767Z,1743115096.767 [CTD_Seabird](INFO): Powering down 2025-03-27T22:38:16.786Z,1743115096.786 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-03-27T22:38:16.815Z,1743115096.815 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2025-03-27T22:38:16.815Z,1743115096.815 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-03-27T22:38:16.815Z,1743115096.815 [Radio_Surface](INFO): Join timeout helper Thread ID is 1183 2025-03-27T22:38:16.979Z,1743115096.979 [Radio_Surface](INFO): Powering down 2025-03-27T22:38:16.979Z,1743115096.979 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-27T22:38:16.980Z,1743115096.980 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-03-27T22:38:17.001Z,1743115097.001 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2025-03-27T22:38:17.001Z,1743115097.001 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-03-27T22:38:17.002Z,1743115097.002 [Onboard](INFO): Join timeout helper Thread ID is 1184 2025-03-27T22:38:17.515Z,1743115097.515 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2025-03-27T22:38:20.706Z,1743115100.706 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-27T22:38:20.707Z,1743115100.707 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-03-27T22:38:20.725Z,1743115100.725 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2025-03-27T22:38:20.725Z,1743115100.725 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-03-27T22:38:20.725Z,1743115100.725 [DataOverHttps](INFO): Join timeout helper Thread ID is 1185 2025-03-27T22:38:21.530Z,1743115101.530 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-27T22:38:21.531Z,1743115101.531 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-03-27T22:38:21.539Z,1743115101.539 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2025-03-27T22:38:21.539Z,1743115101.539 [DAT ThreadHandler](INFO): Thread cancelled. 2025-03-27T22:38:21.540Z,1743115101.540 [DAT](INFO): Join timeout helper Thread ID is 1186 2025-03-27T22:38:21.647Z,1743115101.647 [DAT](INFO): Powering down 2025-03-27T22:38:21.719Z,1743115101.719 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-27T22:38:21.719Z,1743115101.719 [DAT](INFO): Powering down 2025-03-27T22:38:21.720Z,1743115101.720 [DAT ThreadHandler](INFO): Thread cancelled. 2025-03-27T22:38:21.731Z,1743115101.731 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2025-03-27T22:38:21.731Z,1743115101.731 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-03-27T22:38:21.732Z,1743115101.732 [BackseatComponent](INFO): Join timeout helper Thread ID is 1187 2025-03-27T22:38:21.751Z,1743115101.751 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-27T22:38:21.751Z,1743115101.751 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-03-27T22:38:21.763Z,1743115101.763 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2025-03-27T22:38:21.763Z,1743115101.763 [logger ThreadHandler](INFO): Thread cancelled. 2025-03-27T22:38:21.764Z,1743115101.764 [logger](INFO): Join timeout helper Thread ID is 1188 2025-03-27T22:38:21.766Z,1743115101.766 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-27T22:38:21.771Z,1743115101.771 [logger ThreadHandler](INFO): Thread cancelled. 2025-03-27T22:38:21.775Z,1743115101.775 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2025-03-27T22:38:21.775Z,1743115101.775 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-03-27T22:38:21.776Z,1743115101.776 [CommandLine](INFO): Join timeout helper Thread ID is 1189 2025-03-27T22:38:21.843Z,1743115101.843 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-27T22:38:21.843Z,1743115101.843 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-03-27T22:38:21.859Z,1743115101.859 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2025-03-27T22:38:21.859Z,1743115101.859 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-03-27T22:38:21.860Z,1743115101.860 [CommandExec](INFO): Join timeout helper Thread ID is 1190 2025-03-27T22:38:21.861Z,1743115101.861 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2025-03-27T22:38:21.861Z,1743115101.861 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-03-27T22:38:21.861Z,1743115101.861 [controlThread](INFO): Join timeout helper Thread ID is 1191 2025-03-27T22:38:22.026Z,1743115102.026 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-27T22:38:22.027Z,1743115102.027 [controlThread](DEBUG): Uninitializing ControlThread 2025-03-27T22:38:22.027Z,1743115102.027 [AHRS_M2](INFO): Powering down 2025-03-27T22:38:22.107Z,1743115102.107 [MultiRay](INFO): Powering down. 2025-03-27T22:38:22.108Z,1743115102.108 [NAL9602](INFO): Powering down 2025-03-27T22:38:22.110Z,1743115102.110 [Waterlinked](INFO): Powering down 2025-03-27T22:38:22.111Z,1743115102.111 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2025-03-27T22:38:22.112Z,1743115102.112 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2025-03-27T22:38:22.112Z,1743115102.112 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2025-03-27T22:38:22.113Z,1743115102.113 [MissionManager](INFO): Uninitializing Mission Default 2025-03-27T22:38:22.113Z,1743115102.113 [Default] Stopped 2025-03-27T22:38:22.113Z,1743115102.113 [Default](DEBUG): Aggregate::uninitialize Default 2025-03-27T22:38:22.113Z,1743115102.113 [Default:B.GoToSurface] Stopped 2025-03-27T22:38:22.113Z,1743115102.113 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-03-27T22:38:22.113Z,1743115102.113 [Default:CheckIn] Stopped 2025-03-27T22:38:22.113Z,1743115102.113 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-03-27T22:38:22.114Z,1743115102.114 [Default:CheckIn:C.Wait] Stopped 2025-03-27T22:38:22.114Z,1743115102.114 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-03-27T22:38:22.117Z,1743115102.117 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2025-03-27T22:38:22.117Z,1743115102.117 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2025-03-27T22:38:22.117Z,1743115102.117 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2025-03-27T22:38:22.118Z,1743115102.118 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2025-03-27T22:38:22.118Z,1743115102.118 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2025-03-27T22:38:22.118Z,1743115102.118 [BuoyancyServo](INFO): Powering down 2025-03-27T22:38:22.131Z,1743115102.131 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2025-03-27T22:38:22.131Z,1743115102.131 [ElevatorServo](INFO): Powering down 2025-03-27T22:38:22.132Z,1743115102.132 [MassServo](DEBUG): Uninitialize Mass Servo. 2025-03-27T22:38:22.132Z,1743115102.132 [MassServo](INFO): Powering down 2025-03-27T22:38:22.132Z,1743115102.132 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2025-03-27T22:38:22.133Z,1743115102.133 [RudderServo](INFO): Powering down 2025-03-27T22:38:22.133Z,1743115102.133 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2025-03-27T22:38:22.133Z,1743115102.133 [ThrusterHE](INFO): Powering down 2025-03-27T22:38:22.134Z,1743115102.134 [SBIT](DEBUG): Uninitialize SBIT Component. 2025-03-27T22:38:22.135Z,1743115102.135 [IBIT](DEBUG): Uninitialize IBIT Component. 2025-03-27T22:38:22.135Z,1743115102.135 [CBIT](DEBUG): Uninitialize CBIT Component. 2025-03-27T22:38:22.135Z,1743115102.135 [CBIT](DEBUG): Powering off loads. 2025-03-27T22:38:22.146Z,1743115102.146 [CBIT](DEBUG): Disabling WDT. 2025-03-27T22:38:22.159Z,1743115102.159 [GFScanner](DEBUG): Uninitialize GFScanner component. 2025-03-27T22:38:22.160Z,1743115102.160 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-03-27T22:38:22.194Z,1743115102.194 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-03-27T22:38:22.198Z,1743115102.198 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-03-27T22:38:22.205Z,1743115102.205 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-03-27T22:38:22.211Z,1743115102.211 [DAT ThreadHandler](INFO): Thread cancelled. 2025-03-27T22:38:22.253Z,1743115102.253 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-03-27T22:38:22.288Z,1743115102.288 [GFScanner](DEBUG): Uninitialize GFScanner component. 2025-03-27T22:38:22.303Z,1743115102.303 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-03-27T22:38:22.308Z,1743115102.308 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-03-27T22:38:22.362Z,1743115102.362 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-03-27T22:38:22.410Z,1743115102.410 [logger ThreadHandler](INFO): Thread cancelled.