2021-07-16T23:51:01.738Z,1626479461.738 [CommandLine](IMPORTANT): got command restart logs 2021-07-16T23:53:00.398Z,1626479580.398 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-07-16T23:53:00.399Z,1626479580.399 [Default:CheckIn:C.Wait] Stopped 2021-07-16T23:53:00.399Z,1626479580.399 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-07-16T23:53:00.399Z,1626479580.399 [Default:CheckIn:D] Running Loop=1 2021-07-16T23:53:00.801Z,1626479580.801 [Default:CheckIn:D] Stopped 2021-07-16T23:53:00.801Z,1626479580.801 [Default:CheckIn:E] Running Loop=1 2021-07-16T23:53:01.211Z,1626479581.211 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.447921 min 2021-07-16T23:53:01.211Z,1626479581.211 [Default:CheckIn:E] Stopped 2021-07-16T23:53:01.211Z,1626479581.211 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-07-16T23:53:01.212Z,1626479581.212 [Default:CheckIn] Stopped 2021-07-16T23:53:01.212Z,1626479581.212 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-07-16T23:53:01.212Z,1626479581.212 [Default:CheckIn](INFO): Running loop #3 2021-07-16T23:53:01.212Z,1626479581.212 [Default:CheckIn] Running Loop=3 2021-07-16T23:53:01.212Z,1626479581.212 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-07-16T23:53:01.212Z,1626479581.212 [Default:CheckIn:Read_GPS] Running Loop=1 2021-07-16T23:53:03.219Z,1626479583.219 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,235301.00,A,3648.17067,N,12147.28649,W,0.428,51.73,160721,,,A*49 2021-07-16T23:53:03.221Z,1626479583.221 [NAL9602](INFO): GPS fix at 20210716T235301: (36.802844, -121.788108) 2021-07-16T23:53:03.272Z,1626479583.272 [Default:CheckIn:Read_GPS] Stopped 2021-07-16T23:53:03.272Z,1626479583.272 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-07-16T23:53:10.659Z,1626479590.659 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20210716T201400/Courier0073.lzma 2021-07-16T23:53:11.662Z,1626479591.662 [DataOverHttps](INFO): Moved sent file to Logs/20210716T201400/Courier0073.lzma.bak 2021-07-16T23:53:11.662Z,1626479591.662 [DataOverHttps](INFO): SBD MOMSN=15748950 2021-07-16T23:53:33.917Z,1626479613.917 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2021-07-16T23:53:34.000Z,1626479614.000 [NAL9602](ERROR): received: +CSQ:0 OK08, 2, 0, 0, 0 OK 2021-07-16T23:53:58.928Z,1626479638.928 [DataOverHttps](INFO): Sending 268 bytes from file Logs/20210716T235101/Courier0000.lzma 2021-07-16T23:53:59.930Z,1626479639.930 [DataOverHttps](INFO): Moved sent file to Logs/20210716T235101/Courier0000.lzma.bak 2021-07-16T23:53:59.930Z,1626479639.930 [DataOverHttps](INFO): SBD MOMSN=15748952 2021-07-16T23:54:15.592Z,1626479655.592 [DataOverHttps](INFO): Sending 242 bytes from file Logs/20210716T201400/Express0074.lzma 2021-07-16T23:54:16.594Z,1626479656.594 [DataOverHttps](INFO): Moved sent file to Logs/20210716T201400/Express0074.lzma.bak 2021-07-16T23:54:16.594Z,1626479656.594 [DataOverHttps](INFO): SBD MOMSN=15748956 2021-07-16T23:54:31.369Z,1626479671.369 [CommandLine](IMPORTANT): got command failComponent 2021-07-16T23:54:31.370Z,1626479671.370 [CommandLine](IMPORTANT): Failed components: 2021-07-16T23:54:31.370Z,1626479671.370 [CommandLine](IMPORTANT): No failed Components. 2021-07-16T23:54:32.768Z,1626479672.768 [CommandLine](IMPORTANT): got command report 2021-07-16T23:54:32.769Z,1626479672.769 [Reporter](INFO): platform_mass_position reporting changes 2021-07-16T23:54:32.769Z,1626479672.769 [Reporter](INFO): VerticalControl.massPositionAction reporting changes 2021-07-16T23:54:34.105Z,1626479674.105 [DataOverHttps](INFO): Sending 426 bytes from file Logs/20210716T235101/Express0001.lzma 2021-07-16T23:54:34.400Z,1626479674.400 [CommandLine](IMPORTANT): got command report clear 2021-07-16T23:54:35.105Z,1626479675.105 [DataOverHttps](INFO): Moved sent file to Logs/20210716T235101/Express0001.lzma.bak 2021-07-16T23:54:35.106Z,1626479675.106 [DataOverHttps](INFO): SBD MOMSN=15748959 2021-07-16T23:54:36.568Z,1626479676.568 [Default:CheckIn:Read_Iridium] Stopped 2021-07-16T23:54:36.568Z,1626479676.568 [Default:CheckIn:C.Wait] Running Loop=1 2021-07-16T23:54:36.569Z,1626479676.569 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-07-16T23:54:45.873Z,1626479685.873 [CommandLine](IMPORTANT): got command quit 2021-07-16T23:54:46.880Z,1626479686.880 [Supervisor](INFO): Stop Mission called by Supervisor::terminate 2021-07-16T23:54:46.882Z,1626479686.882 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2021-07-16T23:54:46.882Z,1626479686.882 [CommandLine ThreadHandler](INFO): Thread cancelled. 2021-07-16T23:54:46.904Z,1626479686.904 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2021-07-16T23:54:46.904Z,1626479686.904 [CommandLine ThreadHandler](INFO): Thread cancelled. 2021-07-16T23:54:46.904Z,1626479686.904 [CommandLine](INFO): Join timeout helper Thread ID is 3730 2021-07-16T23:54:46.905Z,1626479686.905 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2021-07-16T23:54:46.905Z,1626479686.905 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2021-07-16T23:54:46.905Z,1626479686.905 [NavChartDb](INFO): Join timeout helper Thread ID is 3731 2021-07-16T23:54:47.240Z,1626479687.240 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2021-07-16T23:54:47.240Z,1626479687.240 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2021-07-16T23:54:47.255Z,1626479687.255 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2021-07-16T23:54:47.255Z,1626479687.255 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2021-07-16T23:54:47.255Z,1626479687.255 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 3732 2021-07-16T23:54:47.548Z,1626479687.548 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2021-07-16T23:54:47.548Z,1626479687.548 [WetLabsBB2FL](INFO): Powering down 2021-07-16T23:54:47.549Z,1626479687.549 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2021-07-16T23:54:47.570Z,1626479687.570 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2021-07-16T23:54:47.570Z,1626479687.570 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2021-07-16T23:54:47.571Z,1626479687.571 [CTD_Seabird](INFO): Join timeout helper Thread ID is 3733 2021-07-16T23:54:48.064Z,1626479688.064 [CTD_Seabird](INFO): Powering down 2021-07-16T23:54:48.076Z,1626479688.076 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2021-07-16T23:54:48.076Z,1626479688.076 [CTD_Seabird](INFO): Powering down 2021-07-16T23:54:48.089Z,1626479688.089 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2021-07-16T23:54:48.090Z,1626479688.090 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2021-07-16T23:54:48.091Z,1626479688.091 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2021-07-16T23:54:48.092Z,1626479688.092 [Radio_Surface](INFO): Join timeout helper Thread ID is 3734 2021-07-16T23:54:48.360Z,1626479688.360 [Radio_Surface](INFO): Powering down 2021-07-16T23:54:48.361Z,1626479688.361 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2021-07-16T23:54:48.361Z,1626479688.361 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2021-07-16T23:54:48.381Z,1626479688.381 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2021-07-16T23:54:48.381Z,1626479688.381 [Onboard ThreadHandler](INFO): Thread cancelled. 2021-07-16T23:54:48.381Z,1626479688.381 [Onboard](INFO): Join timeout helper Thread ID is 3735 2021-07-16T23:54:48.496Z,1626479688.496 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2021-07-16T23:54:52.704Z,1626479692.704 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2021-07-16T23:54:52.704Z,1626479692.704 [Onboard ThreadHandler](INFO): Thread cancelled. 2021-07-16T23:54:52.713Z,1626479692.713 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2021-07-16T23:54:52.713Z,1626479692.713 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2021-07-16T23:54:52.713Z,1626479692.713 [DataOverHttps](INFO): Join timeout helper Thread ID is 3736 2021-07-16T23:54:53.536Z,1626479693.536 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2021-07-16T23:54:53.536Z,1626479693.536 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2021-07-16T23:54:53.545Z,1626479693.545 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2021-07-16T23:54:53.545Z,1626479693.545 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2021-07-16T23:54:53.545Z,1626479693.545 [BackseatComponent](INFO): Join timeout helper Thread ID is 3737 2021-07-16T23:54:53.596Z,1626479693.596 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2021-07-16T23:54:53.596Z,1626479693.596 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2021-07-16T23:54:53.612Z,1626479693.612 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2021-07-16T23:54:53.613Z,1626479693.613 [logger ThreadHandler](INFO): Thread cancelled. 2021-07-16T23:54:53.613Z,1626479693.613 [logger](INFO): Join timeout helper Thread ID is 3738 2021-07-16T23:54:53.620Z,1626479693.620 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2021-07-16T23:54:53.620Z,1626479693.620 [logger ThreadHandler](INFO): Thread cancelled. 2021-07-16T23:54:53.632Z,1626479693.632 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2021-07-16T23:54:53.632Z,1626479693.632 [CommandLine ThreadHandler](INFO): Thread cancelled. 2021-07-16T23:54:53.633Z,1626479693.633 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2021-07-16T23:54:53.633Z,1626479693.633 [controlThread ThreadHandler](INFO): Thread cancelled. 2021-07-16T23:54:53.633Z,1626479693.633 [controlThread](INFO): Join timeout helper Thread ID is 3739 2021-07-16T23:54:53.892Z,1626479693.892 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2021-07-16T23:54:53.892Z,1626479693.892 [controlThread](DEBUG): Uninitializing ControlThread 2021-07-16T23:54:53.893Z,1626479693.893 [AHRS_M2](INFO): Powering down 2021-07-16T23:54:53.965Z,1626479693.965 [NAL9602](INFO): Powering down 2021-07-16T23:54:53.966Z,1626479693.966 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2021-07-16T23:54:53.967Z,1626479693.967 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2021-07-16T23:54:53.968Z,1626479693.968 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2021-07-16T23:54:53.969Z,1626479693.969 [MissionManager](INFO): Uninitializing Mission Default 2021-07-16T23:54:53.969Z,1626479693.969 [Default] Stopped 2021-07-16T23:54:53.969Z,1626479693.969 [Default](DEBUG): Aggregate::uninitialize Default 2021-07-16T23:54:53.969Z,1626479693.969 [Default:B.GoToSurface] Stopped 2021-07-16T23:54:53.969Z,1626479693.969 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2021-07-16T23:54:53.969Z,1626479693.969 [Default:CheckIn] Stopped 2021-07-16T23:54:53.969Z,1626479693.969 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-07-16T23:54:53.969Z,1626479693.969 [Default:CheckIn:C.Wait] Stopped 2021-07-16T23:54:53.969Z,1626479693.969 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-07-16T23:54:53.973Z,1626479693.973 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2021-07-16T23:54:53.974Z,1626479693.974 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2021-07-16T23:54:53.974Z,1626479693.974 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2021-07-16T23:54:53.974Z,1626479693.974 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2021-07-16T23:54:53.975Z,1626479693.975 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2021-07-16T23:54:53.975Z,1626479693.975 [BuoyancyServo](INFO): Powering down 2021-07-16T23:54:53.988Z,1626479693.988 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2021-07-16T23:54:53.988Z,1626479693.988 [ElevatorServo](INFO): Powering down 2021-07-16T23:54:53.989Z,1626479693.989 [MassServo](DEBUG): Uninitialize Mass Servo. 2021-07-16T23:54:53.989Z,1626479693.989 [MassServo](INFO): Powering down 2021-07-16T23:54:53.990Z,1626479693.990 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2021-07-16T23:54:53.990Z,1626479693.990 [RudderServo](INFO): Powering down 2021-07-16T23:54:53.991Z,1626479693.991 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2021-07-16T23:54:53.991Z,1626479693.991 [ThrusterHE](INFO): Powering down 2021-07-16T23:54:53.992Z,1626479693.992 [SBIT](DEBUG): Uninitialize SBIT Component. 2021-07-16T23:54:53.993Z,1626479693.993 [IBIT](DEBUG): Uninitialize IBIT Component. 2021-07-16T23:54:53.993Z,1626479693.993 [CBIT](DEBUG): Uninitialize CBIT Component. 2021-07-16T23:54:53.993Z,1626479693.993 [CBIT](DEBUG): Powering off loads. 2021-07-16T23:54:54.004Z,1626479694.004 [CBIT](DEBUG): Disabling WDT. 2021-07-16T23:54:54.016Z,1626479694.016 [CBIT](DEBUG): Opening all GF detection circuits. 2021-07-16T23:54:54.017Z,1626479694.017 [controlThread ThreadHandler](INFO): Thread cancelled. 2021-07-16T23:54:54.070Z,1626479694.070 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2021-07-16T23:54:54.073Z,1626479694.073 [Onboard ThreadHandler](INFO): Thread cancelled. 2021-07-16T23:54:54.080Z,1626479694.080 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2021-07-16T23:54:54.126Z,1626479694.126 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2021-07-16T23:54:54.158Z,1626479694.158 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2021-07-16T23:54:54.162Z,1626479694.162 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2021-07-16T23:54:54.193Z,1626479694.193 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2021-07-16T23:54:54.270Z,1626479694.270 [logger ThreadHandler](INFO): Thread cancelled.