2024-11-01T18:05:09.444Z,1730484309.444 [DataOverHttps](IMPORTANT): SBD MTMSN=20241101T180509 2024-11-01T18:05:20.955Z,1730484320.955 [DataOverHttps](INFO): Received command: restart logs 2024-11-01T18:05:25.686Z,1730484325.686 [CommandExec](IMPORTANT): got command restart logs 2024-11-01T18:05:55.896Z,1730484355.896 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-11-01T18:05:55.896Z,1730484355.896 [Default:CheckIn:C.Wait] Stopped 2024-11-01T18:05:55.896Z,1730484355.896 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-11-01T18:05:55.896Z,1730484355.896 [Default:CheckIn:D] Running Loop=1 2024-11-01T18:05:56.302Z,1730484356.302 [Default:CheckIn:D] Stopped 2024-11-01T18:05:56.302Z,1730484356.302 [Default:CheckIn:E] Running Loop=1 2024-11-01T18:05:56.712Z,1730484356.712 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 25.971535 min 2024-11-01T18:05:56.712Z,1730484356.712 [Default:CheckIn:E] Stopped 2024-11-01T18:05:56.712Z,1730484356.712 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-11-01T18:05:56.712Z,1730484356.712 [Default:CheckIn] Stopped 2024-11-01T18:05:56.712Z,1730484356.712 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-11-01T18:05:56.712Z,1730484356.712 [Default:CheckIn](INFO): Running loop #5 2024-11-01T18:05:56.712Z,1730484356.712 [Default:CheckIn] Running Loop=5 2024-11-01T18:05:56.712Z,1730484356.712 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-11-01T18:05:56.712Z,1730484356.712 [Default:CheckIn:Read_GPS] Running Loop=1 2024-11-01T18:05:58.714Z,1730484358.714 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,180559.00,A,3648.49753,N,12147.23820,W,5.540,59.60,011124,,,D*4F 2024-11-01T18:05:58.716Z,1730484358.716 [NAL9602](INFO): GPS fix at 20241101T180559: (36.808292, -121.787303) 2024-11-01T18:05:58.759Z,1730484358.759 [Default:CheckIn:Read_GPS] Stopped 2024-11-01T18:05:58.759Z,1730484358.759 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-11-01T18:06:05.978Z,1730484365.978 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20241101T054346/Courier0072.lzma 2024-11-01T18:06:06.981Z,1730484366.981 [DataOverHttps](INFO): Moved sent file to Logs/20241101T054346/Courier0072.lzma.bak 2024-11-01T18:06:06.981Z,1730484366.981 [DataOverHttps](INFO): SBD MOMSN=23365700 2024-11-01T18:06:22.911Z,1730484382.911 [DataOverHttps](INFO): Sending 266 bytes from file Logs/20241101T180525/Courier0000.lzma 2024-11-01T18:06:23.912Z,1730484383.912 [DataOverHttps](INFO): Moved sent file to Logs/20241101T180525/Courier0000.lzma.bak 2024-11-01T18:06:23.913Z,1730484383.913 [DataOverHttps](INFO): SBD MOMSN=23365702 2024-11-01T18:06:24.585Z,1730484384.585 [NAL9602](INFO): SBD MO Status=0, MOMSN=10766, MT Status=0, MTMSN=0 2024-11-01T18:06:24.585Z,1730484384.585 [NAL9602](INFO): No messages in MT queue 2024-11-01T18:06:32.695Z,1730484392.695 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-11-01T18:06:32.695Z,1730484392.695 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-11-01T18:06:32.706Z,1730484392.706 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-11-01T18:06:33.087Z,1730484393.087 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-11-01T18:06:33.087Z,1730484393.087 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-11-01T18:06:39.863Z,1730484399.863 [DataOverHttps](INFO): Sending 159 bytes from file Logs/20241101T054346/Express0073.lzma 2024-11-01T18:06:40.865Z,1730484400.865 [DataOverHttps](INFO): Moved sent file to Logs/20241101T054346/Express0073.lzma.bak 2024-11-01T18:06:40.865Z,1730484400.865 [DataOverHttps](INFO): SBD MOMSN=23365706 2024-11-01T18:06:55.292Z,1730484415.292 [NAL9602](INFO): Not Powering down - fast GPS 2024-11-01T18:06:56.775Z,1730484416.775 [DataOverHttps](INFO): Sending 232 bytes from file Logs/20241101T180508/Express0001.lzma 2024-11-01T18:06:57.777Z,1730484417.777 [DataOverHttps](INFO): Moved sent file to Logs/20241101T180508/Express0001.lzma.bak 2024-11-01T18:06:57.777Z,1730484417.777 [DataOverHttps](INFO): SBD MOMSN=23365710 2024-11-01T18:07:18.849Z,1730484438.849 [DataOverHttps](INFO): Sending 439 bytes from file Logs/20241101T180525/Express0001.lzma 2024-11-01T18:07:23.864Z,1730484443.864 [DataOverHttps](INFO): Moved sent file to Logs/20241101T180525/Express0001.lzma.bak 2024-11-01T18:07:23.865Z,1730484443.865 [DataOverHttps](INFO): SBD MOMSN=23365717 2024-11-01T18:07:25.246Z,1730484445.246 [Default:CheckIn:Read_Iridium] Stopped 2024-11-01T18:07:25.246Z,1730484445.246 [Default:CheckIn:C.Wait] Running Loop=1 2024-11-01T18:07:25.246Z,1730484445.246 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-11-01T18:09:33.722Z,1730484573.722 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-11-01T18:09:33.722Z,1730484573.722 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-11-01T18:09:33.733Z,1730484573.733 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-11-01T18:09:34.150Z,1730484574.150 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-11-01T18:09:34.150Z,1730484574.150 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-11-01T18:12:25.896Z,1730484745.896 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-11-01T18:12:25.896Z,1730484745.896 [Default:CheckIn:C.Wait] Stopped 2024-11-01T18:12:25.896Z,1730484745.896 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-11-01T18:12:25.897Z,1730484745.897 [Default:CheckIn:D] Running Loop=1 2024-11-01T18:12:26.284Z,1730484746.284 [Default:CheckIn:D] Stopped 2024-11-01T18:12:26.284Z,1730484746.284 [Default:CheckIn:E] Running Loop=1 2024-11-01T18:12:26.690Z,1730484746.690 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 32.471230 min 2024-11-01T18:12:26.690Z,1730484746.690 [Default:CheckIn:E] Stopped 2024-11-01T18:12:26.690Z,1730484746.690 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-11-01T18:12:26.690Z,1730484746.690 [Default:CheckIn] Stopped 2024-11-01T18:12:26.690Z,1730484746.690 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-11-01T18:12:26.690Z,1730484746.690 [Default:CheckIn](INFO): Running loop #6 2024-11-01T18:12:26.690Z,1730484746.690 [Default:CheckIn] Running Loop=6 2024-11-01T18:12:26.690Z,1730484746.690 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-11-01T18:12:26.691Z,1730484746.691 [Default:CheckIn:Read_GPS] Running Loop=1 2024-11-01T18:12:28.694Z,1730484748.694 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,181229.00,A,3648.14959,N,12147.22275,W,0.078,211.29,011124,,,A*74 2024-11-01T18:12:28.704Z,1730484748.704 [NAL9602](INFO): GPS fix at 20241101T181229: (36.802493, -121.787046) 2024-11-01T18:12:28.718Z,1730484748.718 [Default:CheckIn:Read_GPS] Stopped 2024-11-01T18:12:28.718Z,1730484748.718 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-11-01T18:12:34.777Z,1730484754.777 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-11-01T18:12:34.777Z,1730484754.777 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-11-01T18:12:34.820Z,1730484754.820 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-11-01T18:12:35.206Z,1730484755.206 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-11-01T18:12:35.206Z,1730484755.206 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-11-01T18:12:36.566Z,1730484756.566 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20241101T180525/Courier0006.lzma 2024-11-01T18:12:37.569Z,1730484757.569 [DataOverHttps](INFO): Moved sent file to Logs/20241101T180525/Courier0006.lzma.bak 2024-11-01T18:12:37.569Z,1730484757.569 [DataOverHttps](INFO): SBD MOMSN=23365726 2024-11-01T18:12:37.989Z,1730484757.989 [NAL9602](INFO): SBD MO Status=0, MOMSN=10767, MT Status=0, MTMSN=0 2024-11-01T18:12:37.989Z,1730484757.989 [NAL9602](INFO): No messages in MT queue 2024-11-01T18:12:53.679Z,1730484773.679 [DataOverHttps](INFO): Sending 159 bytes from file Logs/20241101T180525/Express0007.lzma 2024-11-01T18:12:54.681Z,1730484774.681 [DataOverHttps](INFO): Moved sent file to Logs/20241101T180525/Express0007.lzma.bak 2024-11-01T18:12:54.681Z,1730484774.681 [DataOverHttps](INFO): SBD MOMSN=23365730 2024-11-01T18:12:56.187Z,1730484776.187 [Default:CheckIn:Read_Iridium] Stopped 2024-11-01T18:12:56.187Z,1730484776.187 [Default:CheckIn:C.Wait] Running Loop=1 2024-11-01T18:12:56.187Z,1730484776.187 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-11-01T18:13:08.692Z,1730484788.692 [NAL9602](INFO): Not Powering down - fast GPS 2024-11-01T18:15:35.815Z,1730484935.815 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-11-01T18:15:35.815Z,1730484935.815 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-11-01T18:15:35.827Z,1730484935.827 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-11-01T18:15:36.253Z,1730484936.253 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-11-01T18:15:36.253Z,1730484936.253 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-11-01T18:17:56.880Z,1730485076.880 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-11-01T18:17:56.880Z,1730485076.880 [Default:CheckIn:C.Wait] Stopped 2024-11-01T18:17:56.880Z,1730485076.880 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-11-01T18:17:56.880Z,1730485076.880 [Default:CheckIn:D] Running Loop=1 2024-11-01T18:17:57.263Z,1730485077.263 [Default:CheckIn:D] Stopped 2024-11-01T18:17:57.263Z,1730485077.263 [Default:CheckIn:E] Running Loop=1 2024-11-01T18:17:57.669Z,1730485077.669 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 37.987561 min 2024-11-01T18:17:57.669Z,1730485077.669 [Default:CheckIn:E] Stopped 2024-11-01T18:17:57.669Z,1730485077.669 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-11-01T18:17:57.669Z,1730485077.669 [Default:CheckIn] Stopped 2024-11-01T18:17:57.669Z,1730485077.669 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-11-01T18:17:57.669Z,1730485077.669 [Default:CheckIn](INFO): Running loop #7 2024-11-01T18:17:57.670Z,1730485077.670 [Default:CheckIn] Running Loop=7 2024-11-01T18:17:57.670Z,1730485077.670 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-11-01T18:17:57.670Z,1730485077.670 [Default:CheckIn:Read_GPS] Running Loop=1 2024-11-01T18:17:59.686Z,1730485079.686 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,181800.00,A,3648.14943,N,12147.22247,W,0.058,211.29,011124,,,D*78 2024-11-01T18:17:59.688Z,1730485079.688 [NAL9602](INFO): GPS fix at 20241101T181800: (36.802490, -121.787041) 2024-11-01T18:17:59.702Z,1730485079.702 [Default:CheckIn:Read_GPS] Stopped 2024-11-01T18:17:59.702Z,1730485079.702 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-11-01T18:18:06.938Z,1730485086.938 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20241101T180525/Courier0009.lzma 2024-11-01T18:18:07.941Z,1730485087.941 [DataOverHttps](INFO): Moved sent file to Logs/20241101T180525/Courier0009.lzma.bak 2024-11-01T18:18:07.941Z,1730485087.941 [DataOverHttps](INFO): SBD MOMSN=23365742 2024-11-01T18:18:15.033Z,1730485095.033 [NAL9602](INFO): SBD MO Status=0, MOMSN=10768, MT Status=0, MTMSN=0 2024-11-01T18:18:15.033Z,1730485095.033 [NAL9602](INFO): No messages in MT queue 2024-11-01T18:18:23.879Z,1730485103.879 [DataOverHttps](INFO): Sending 141 bytes from file Logs/20241101T180525/Express0010.lzma 2024-11-01T18:18:24.880Z,1730485104.880 [DataOverHttps](INFO): Moved sent file to Logs/20241101T180525/Express0010.lzma.bak 2024-11-01T18:18:24.881Z,1730485104.881 [DataOverHttps](INFO): SBD MOMSN=23365749 2024-11-01T18:18:26.389Z,1730485106.389 [Default:CheckIn:Read_Iridium] Stopped 2024-11-01T18:18:26.389Z,1730485106.389 [Default:CheckIn:C.Wait] Running Loop=1 2024-11-01T18:18:26.389Z,1730485106.389 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-11-01T18:18:36.855Z,1730485116.855 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-11-01T18:18:36.855Z,1730485116.855 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-11-01T18:18:36.866Z,1730485116.866 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-11-01T18:18:37.276Z,1730485117.276 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-11-01T18:18:37.276Z,1730485117.276 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-11-01T18:18:45.735Z,1730485125.735 [NAL9602](INFO): Not Powering down - fast GPS 2024-11-01T18:21:37.904Z,1730485297.904 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-11-01T18:21:37.904Z,1730485297.904 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-11-01T18:21:37.915Z,1730485297.915 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-11-01T18:21:38.325Z,1730485298.325 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-11-01T18:21:38.326Z,1730485298.326 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-11-01T18:23:27.034Z,1730485407.034 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-11-01T18:23:27.034Z,1730485407.034 [Default:CheckIn:C.Wait] Stopped 2024-11-01T18:23:27.035Z,1730485407.035 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-11-01T18:23:27.035Z,1730485407.035 [Default:CheckIn:D] Running Loop=1 2024-11-01T18:23:27.444Z,1730485407.444 [Default:CheckIn:D] Stopped 2024-11-01T18:23:27.444Z,1730485407.444 [Default:CheckIn:E] Running Loop=1 2024-11-01T18:23:27.845Z,1730485407.845 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 43.490564 min 2024-11-01T18:23:27.845Z,1730485407.845 [Default:CheckIn:E] Stopped 2024-11-01T18:23:27.845Z,1730485407.845 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-11-01T18:23:27.845Z,1730485407.845 [Default:CheckIn] Stopped 2024-11-01T18:23:27.845Z,1730485407.845 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-11-01T18:23:27.845Z,1730485407.845 [Default:CheckIn](INFO): Running loop #8 2024-11-01T18:23:27.845Z,1730485407.845 [Default:CheckIn] Running Loop=8 2024-11-01T18:23:27.845Z,1730485407.845 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-11-01T18:23:27.845Z,1730485407.845 [Default:CheckIn:Read_GPS] Running Loop=1 2024-11-01T18:23:29.853Z,1730485409.853 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,182330.00,A,3648.15219,N,12147.25311,W,3.518,358.16,011124,,,D*71 2024-11-01T18:23:29.864Z,1730485409.864 [NAL9602](INFO): GPS fix at 20241101T182330: (36.802537, -121.787552) 2024-11-01T18:23:29.880Z,1730485409.880 [Default:CheckIn:Read_GPS] Stopped 2024-11-01T18:23:29.880Z,1730485409.880 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-11-01T18:23:37.686Z,1730485417.686 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20241101T180525/Courier0012.lzma 2024-11-01T18:23:38.688Z,1730485418.688 [DataOverHttps](INFO): Moved sent file to Logs/20241101T180525/Courier0012.lzma.bak 2024-11-01T18:23:38.689Z,1730485418.689 [DataOverHttps](INFO): SBD MOMSN=23365754 2024-11-01T18:23:54.779Z,1730485434.779 [DataOverHttps](INFO): Sending 142 bytes from file Logs/20241101T180525/Express0013.lzma 2024-11-01T18:23:55.781Z,1730485435.781 [DataOverHttps](INFO): Moved sent file to Logs/20241101T180525/Express0013.lzma.bak 2024-11-01T18:23:55.781Z,1730485435.781 [DataOverHttps](INFO): SBD MOMSN=23365757 2024-11-01T18:23:56.950Z,1730485436.950 [Default:CheckIn:Read_Iridium] Stopped 2024-11-01T18:23:56.950Z,1730485436.950 [Default:CheckIn:C.Wait] Running Loop=1 2024-11-01T18:23:56.950Z,1730485436.950 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-11-01T18:24:38.956Z,1730485478.956 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-11-01T18:24:38.956Z,1730485478.956 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-11-01T18:24:38.967Z,1730485478.967 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-11-01T18:24:39.390Z,1730485479.390 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-11-01T18:24:39.390Z,1730485479.390 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-11-01T18:24:51.874Z,1730485491.874 [NAL9602](INFO): SBD MO Status=0, MOMSN=10769, MT Status=0, MTMSN=0 2024-11-01T18:24:51.874Z,1730485491.874 [NAL9602](INFO): No messages in MT queue 2024-11-01T18:25:22.604Z,1730485522.604 [NAL9602](INFO): Not Powering down - fast GPS 2024-11-01T18:27:40.040Z,1730485660.040 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-11-01T18:27:40.040Z,1730485660.040 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-11-01T18:27:40.051Z,1730485660.051 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-11-01T18:27:40.460Z,1730485660.460 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-11-01T18:27:40.460Z,1730485660.460 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-11-01T18:28:57.600Z,1730485737.600 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-11-01T18:28:57.601Z,1730485737.601 [Default:CheckIn:C.Wait] Stopped 2024-11-01T18:28:57.601Z,1730485737.601 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-11-01T18:28:57.601Z,1730485737.601 [Default:CheckIn:D] Running Loop=1 2024-11-01T18:28:58.004Z,1730485738.004 [Default:CheckIn:D] Stopped 2024-11-01T18:28:58.004Z,1730485738.004 [Default:CheckIn:E] Running Loop=1 2024-11-01T18:28:58.423Z,1730485738.423 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 48.999898 min 2024-11-01T18:28:58.424Z,1730485738.424 [Default:CheckIn:E] Stopped 2024-11-01T18:28:58.424Z,1730485738.424 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-11-01T18:28:58.424Z,1730485738.424 [Default:CheckIn] Stopped 2024-11-01T18:28:58.424Z,1730485738.424 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-11-01T18:28:58.424Z,1730485738.424 [Default:CheckIn](INFO): Running loop #9 2024-11-01T18:28:58.424Z,1730485738.424 [Default:CheckIn] Running Loop=9 2024-11-01T18:28:58.424Z,1730485738.424 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-11-01T18:28:58.424Z,1730485738.424 [Default:CheckIn:Read_GPS] Running Loop=1 2024-11-01T18:29:00.416Z,1730485740.416 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,182900.00,A,3648.17836,N,12147.28194,W,0.136,275.15,011124,,,D*79 2024-11-01T18:29:00.419Z,1730485740.419 [NAL9602](INFO): GPS fix at 20241101T182900: (36.802973, -121.788032) 2024-11-01T18:29:00.432Z,1730485740.432 [Default:CheckIn:Read_GPS] Stopped 2024-11-01T18:29:00.433Z,1730485740.433 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-11-01T18:29:10.598Z,1730485750.598 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20241101T180525/Courier0015.lzma 2024-11-01T18:29:11.601Z,1730485751.601 [DataOverHttps](INFO): Moved sent file to Logs/20241101T180525/Courier0015.lzma.bak 2024-11-01T18:29:11.601Z,1730485751.601 [DataOverHttps](INFO): SBD MOMSN=23365773 2024-11-01T18:29:28.743Z,1730485768.743 [DataOverHttps](INFO): Sending 141 bytes from file Logs/20241101T180525/Express0016.lzma 2024-11-01T18:29:29.737Z,1730485769.737 [DataOverHttps](INFO): Moved sent file to Logs/20241101T180525/Express0016.lzma.bak 2024-11-01T18:29:29.737Z,1730485769.737 [DataOverHttps](INFO): SBD MOMSN=23365776 2024-11-01T18:29:31.211Z,1730485771.211 [Default:CheckIn:Read_Iridium] Stopped 2024-11-01T18:29:31.211Z,1730485771.211 [Default:CheckIn:C.Wait] Running Loop=1 2024-11-01T18:29:31.211Z,1730485771.211 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-11-01T18:30:14.026Z,1730485814.026 [NAL9602](INFO): SBD MO Status=2, MOMSN=10770, MT Status=2, MTMSN=0 2024-11-01T18:30:14.027Z,1730485814.027 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-11-01T18:30:41.170Z,1730485841.170 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-11-01T18:30:41.171Z,1730485841.171 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-11-01T18:30:41.181Z,1730485841.181 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-11-01T18:30:41.550Z,1730485841.550 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-11-01T18:30:41.551Z,1730485841.551 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-11-01T18:31:51.054Z,1730485911.054 [NAL9602](INFO): SBD MO Status=2, MOMSN=10770, MT Status=2, MTMSN=0 2024-11-01T18:31:51.054Z,1730485911.054 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-11-01T18:33:42.252Z,1730486022.252 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-11-01T18:33:42.252Z,1730486022.252 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-11-01T18:33:42.264Z,1730486022.264 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-11-01T18:33:42.682Z,1730486022.682 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-11-01T18:33:42.682Z,1730486022.682 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-11-01T18:34:02.416Z,1730486042.416 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-11-01T18:34:31.948Z,1730486071.948 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-11-01T18:34:31.948Z,1730486071.948 [Default:CheckIn:C.Wait] Stopped 2024-11-01T18:34:31.948Z,1730486071.948 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-11-01T18:34:31.948Z,1730486071.948 [Default:CheckIn:D] Running Loop=1 2024-11-01T18:34:32.329Z,1730486072.329 [Default:CheckIn:D] Stopped 2024-11-01T18:34:32.329Z,1730486072.329 [Default:CheckIn:E] Running Loop=1 2024-11-01T18:34:32.729Z,1730486072.729 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 54.571993 min 2024-11-01T18:34:32.729Z,1730486072.729 [Default:CheckIn:E] Stopped 2024-11-01T18:34:32.729Z,1730486072.729 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-11-01T18:34:32.729Z,1730486072.729 [Default:CheckIn] Stopped 2024-11-01T18:34:32.730Z,1730486072.730 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-11-01T18:34:32.730Z,1730486072.730 [Default:CheckIn](INFO): Running loop #10 2024-11-01T18:34:32.730Z,1730486072.730 [Default:CheckIn] Running Loop=10 2024-11-01T18:34:32.730Z,1730486072.730 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-11-01T18:34:32.730Z,1730486072.730 [Default:CheckIn:Read_GPS] Running Loop=1 2024-11-01T18:34:33.124Z,1730486073.124 [NAL9602](INFO): Not Powering down - fast GPS 2024-11-01T18:34:34.746Z,1730486074.746 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183435.00,A,3648.16532,N,12147.27959,W,0.836,71.57,011124,,,A*41 2024-11-01T18:34:34.748Z,1730486074.748 [NAL9602](INFO): GPS fix at 20241101T183435: (36.802755, -121.787993) 2024-11-01T18:34:34.762Z,1730486074.762 [Default:CheckIn:Read_GPS] Stopped 2024-11-01T18:34:34.762Z,1730486074.762 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-11-01T18:34:41.722Z,1730486081.722 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20241101T180525/Courier0018.lzma 2024-11-01T18:34:42.725Z,1730486082.725 [DataOverHttps](INFO): Moved sent file to Logs/20241101T180525/Courier0018.lzma.bak 2024-11-01T18:34:42.725Z,1730486082.725 [DataOverHttps](INFO): SBD MOMSN=23365781 2024-11-01T18:34:58.591Z,1730486098.591 [DataOverHttps](INFO): Sending 253 bytes from file Logs/20241101T180525/Express0019.lzma 2024-11-01T18:34:59.593Z,1730486099.593 [DataOverHttps](INFO): Moved sent file to Logs/20241101T180525/Express0019.lzma.bak 2024-11-01T18:34:59.593Z,1730486099.593 [DataOverHttps](INFO): SBD MOMSN=23365789 2024-11-01T18:35:01.062Z,1730486101.062 [Default:CheckIn:Read_Iridium] Stopped 2024-11-01T18:35:01.062Z,1730486101.062 [Default:CheckIn:C.Wait] Running Loop=1 2024-11-01T18:35:01.062Z,1730486101.062 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-11-01T18:35:05.524Z,1730486105.524 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2024-11-01T18:35:05.599Z,1730486105.599 [NAL9602](ERROR): received: +CSQ:0 OK770, 2, 0, 0, 0 OK 2024-11-01T18:36:43.362Z,1730486203.362 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-11-01T18:36:43.362Z,1730486203.362 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-11-01T18:36:43.373Z,1730486203.373 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-11-01T18:36:43.798Z,1730486203.798 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-11-01T18:36:43.798Z,1730486203.798 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-11-01T18:37:19.167Z,1730486239.167 [CommandExec](IMPORTANT): got command quit 2024-11-01T18:37:20.175Z,1730486240.175 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-01T18:37:20.175Z,1730486240.175 [CommandExec](INFO): Uninitializing the command executive. 2024-11-01T18:37:20.175Z,1730486240.175 [CommandExec](INFO): Uninitializing the command scheduler. 2024-11-01T18:37:20.175Z,1730486240.175 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-11-01T18:37:20.195Z,1730486240.195 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-11-01T18:37:20.195Z,1730486240.195 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-11-01T18:37:20.195Z,1730486240.195 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-11-01T18:37:20.195Z,1730486240.195 [NavChartDb](INFO): Join timeout helper Thread ID is 2003 2024-11-01T18:37:20.295Z,1730486240.295 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-01T18:37:20.295Z,1730486240.295 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-11-01T18:37:20.303Z,1730486240.303 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-11-01T18:37:20.303Z,1730486240.303 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-11-01T18:37:20.303Z,1730486240.303 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 2004 2024-11-01T18:37:20.459Z,1730486240.459 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-01T18:37:20.459Z,1730486240.459 [WetLabsBB2FL](INFO): Powering down 2024-11-01T18:37:20.460Z,1730486240.460 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-11-01T18:37:20.463Z,1730486240.463 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2024-11-01T18:37:20.463Z,1730486240.463 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-11-01T18:37:20.463Z,1730486240.463 [CTD_Seabird](INFO): Join timeout helper Thread ID is 2005 2024-11-01T18:37:20.643Z,1730486240.643 [CTD_Seabird](INFO): Powering down 2024-11-01T18:37:20.656Z,1730486240.656 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-01T18:37:20.663Z,1730486240.663 [CTD_Seabird](INFO): Powering down 2024-11-01T18:37:20.675Z,1730486240.675 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-11-01T18:37:20.683Z,1730486240.683 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-11-01T18:37:20.683Z,1730486240.683 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-11-01T18:37:20.683Z,1730486240.683 [Radio_Surface](INFO): Join timeout helper Thread ID is 2006 2024-11-01T18:37:20.719Z,1730486240.719 [Radio_Surface](INFO): Powering down 2024-11-01T18:37:20.720Z,1730486240.720 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-01T18:37:20.720Z,1730486240.720 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-11-01T18:37:20.723Z,1730486240.723 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-11-01T18:37:20.723Z,1730486240.723 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-11-01T18:37:20.723Z,1730486240.723 [Onboard](INFO): Join timeout helper Thread ID is 2007 2024-11-01T18:37:21.619Z,1730486241.619 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2024-11-01T18:37:22.307Z,1730486242.307 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-01T18:37:22.307Z,1730486242.307 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-11-01T18:37:22.312Z,1730486242.312 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-11-01T18:37:22.312Z,1730486242.312 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-11-01T18:37:22.312Z,1730486242.312 [DataOverHttps](INFO): Join timeout helper Thread ID is 2008 2024-11-01T18:37:22.623Z,1730486242.623 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-01T18:37:22.623Z,1730486242.623 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-11-01T18:37:22.628Z,1730486242.628 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2024-11-01T18:37:22.628Z,1730486242.628 [DAT ThreadHandler](INFO): Thread cancelled. 2024-11-01T18:37:22.628Z,1730486242.628 [DAT](INFO): Join timeout helper Thread ID is 2009 2024-11-01T18:37:22.767Z,1730486242.767 [DAT](INFO): Powering down 2024-11-01T18:37:22.836Z,1730486242.836 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-01T18:37:22.836Z,1730486242.836 [DAT](INFO): Powering down 2024-11-01T18:37:22.837Z,1730486242.837 [DAT ThreadHandler](INFO): Thread cancelled. 2024-11-01T18:37:22.848Z,1730486242.848 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2024-11-01T18:37:22.848Z,1730486242.848 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-11-01T18:37:22.848Z,1730486242.848 [BackseatComponent](INFO): Join timeout helper Thread ID is 2010 2024-11-01T18:37:22.891Z,1730486242.891 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-01T18:37:22.891Z,1730486242.891 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-11-01T18:37:22.892Z,1730486242.892 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-11-01T18:37:22.892Z,1730486242.892 [logger ThreadHandler](INFO): Thread cancelled. 2024-11-01T18:37:22.893Z,1730486242.893 [logger](INFO): Join timeout helper Thread ID is 2011 2024-11-01T18:37:22.933Z,1730486242.933 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-01T18:37:22.933Z,1730486242.933 [logger ThreadHandler](INFO): Thread cancelled. 2024-11-01T18:37:22.947Z,1730486242.947 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-11-01T18:37:22.947Z,1730486242.947 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-11-01T18:37:22.948Z,1730486242.948 [CommandLine](INFO): Join timeout helper Thread ID is 2012 2024-11-01T18:37:22.951Z,1730486242.951 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-01T18:37:22.951Z,1730486242.951 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-11-01T18:37:22.967Z,1730486242.967 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-11-01T18:37:22.968Z,1730486242.968 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-11-01T18:37:22.968Z,1730486242.968 [CommandExec](INFO): Join timeout helper Thread ID is 2013 2024-11-01T18:37:22.976Z,1730486242.976 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-11-01T18:37:22.976Z,1730486242.976 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-11-01T18:37:22.976Z,1730486242.976 [controlThread](INFO): Join timeout helper Thread ID is 2014 2024-11-01T18:37:23.003Z,1730486243.003 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-01T18:37:23.003Z,1730486243.003 [controlThread](DEBUG): Uninitializing ControlThread 2024-11-01T18:37:23.004Z,1730486243.004 [AHRS_M2](INFO): Powering down 2024-11-01T18:37:23.075Z,1730486243.075 [NAL9602](INFO): Powering down 2024-11-01T18:37:23.077Z,1730486243.077 [Sonardyne_Nano](INFO): Powering down 2024-11-01T18:37:23.196Z,1730486243.196 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-11-01T18:37:23.196Z,1730486243.196 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-11-01T18:37:23.197Z,1730486243.197 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-11-01T18:37:23.198Z,1730486243.198 [MissionManager](INFO): Uninitializing Mission Default 2024-11-01T18:37:23.198Z,1730486243.198 [Default] Stopped 2024-11-01T18:37:23.198Z,1730486243.198 [Default](DEBUG): Aggregate::uninitialize Default 2024-11-01T18:37:23.198Z,1730486243.198 [Default:B.GoToSurface] Stopped 2024-11-01T18:37:23.198Z,1730486243.198 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-11-01T18:37:23.198Z,1730486243.198 [Default:CheckIn] Stopped 2024-11-01T18:37:23.198Z,1730486243.198 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-11-01T18:37:23.198Z,1730486243.198 [Default:CheckIn:C.Wait] Stopped 2024-11-01T18:37:23.198Z,1730486243.198 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-11-01T18:37:23.201Z,1730486243.201 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-11-01T18:37:23.201Z,1730486243.201 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-11-01T18:37:23.201Z,1730486243.201 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-11-01T18:37:23.202Z,1730486243.202 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-11-01T18:37:23.202Z,1730486243.202 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-11-01T18:37:23.202Z,1730486243.202 [BuoyancyServo](INFO): Powering down 2024-11-01T18:37:23.215Z,1730486243.215 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-11-01T18:37:23.215Z,1730486243.215 [ElevatorServo](INFO): Powering down 2024-11-01T18:37:23.216Z,1730486243.216 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-11-01T18:37:23.216Z,1730486243.216 [MassServo](INFO): Powering down 2024-11-01T18:37:23.217Z,1730486243.217 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-11-01T18:37:23.217Z,1730486243.217 [RudderServo](INFO): Powering down 2024-11-01T18:37:23.217Z,1730486243.217 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2024-11-01T18:37:23.218Z,1730486243.218 [ThrusterHE](INFO): Powering down 2024-11-01T18:37:23.218Z,1730486243.218 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-11-01T18:37:23.219Z,1730486243.219 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-11-01T18:37:23.219Z,1730486243.219 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-11-01T18:37:23.219Z,1730486243.219 [CBIT](DEBUG): Powering off loads. 2024-11-01T18:37:23.231Z,1730486243.231 [CBIT](DEBUG): Disabling WDT. 2024-11-01T18:37:23.243Z,1730486243.243 [CBIT](DEBUG): Opening all GF detection circuits. 2024-11-01T18:37:23.244Z,1730486243.244 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-11-01T18:37:23.290Z,1730486243.290 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-11-01T18:37:23.293Z,1730486243.293 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-11-01T18:37:23.299Z,1730486243.299 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-11-01T18:37:23.305Z,1730486243.305 [DAT ThreadHandler](INFO): Thread cancelled. 2024-11-01T18:37:23.344Z,1730486243.344 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-11-01T18:37:23.431Z,1730486243.431 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-11-01T18:37:23.436Z,1730486243.436 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-11-01T18:37:23.453Z,1730486243.453 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-11-01T18:37:23.501Z,1730486243.501 [logger ThreadHandler](INFO): Thread cancelled.