2024-04-15T20:04:45.514Z,1713211485.514 [Supervisor](DEBUG): Initializing supervisor. 2024-04-15T20:04:45.518Z,1713211485.518 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-04-15T20:04:45.519Z,1713211485.519 [SyncHandler](INFO): Protected caller Thread ID is 838 2024-04-15T20:04:45.519Z,1713211485.519 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-04-15T20:04:45.520Z,1713211485.520 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-04-15T20:04:45.520Z,1713211485.520 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 839 2024-04-15T20:04:45.524Z,1713211485.524 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-04-15T20:04:45.542Z,1713211485.542 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-04-15T20:04:45.543Z,1713211485.543 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-04-15T20:04:45.543Z,1713211485.543 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 840 2024-04-15T20:04:45.548Z,1713211485.548 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-04-15T20:04:45.549Z,1713211485.549 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-04-15T20:04:45.549Z,1713211485.549 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 841 2024-04-15T20:04:45.551Z,1713211485.551 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-04-15T20:04:45.552Z,1713211485.552 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-04-15T20:04:45.552Z,1713211485.552 [logger ThreadHandler](INFO): Protected caller Thread ID is 842 2024-04-15T20:04:45.556Z,1713211485.556 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-04-15T20:04:45.556Z,1713211485.556 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-04-15T20:04:45.560Z,1713211485.560 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-04-15T20:04:45.938Z,1713211485.938 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-04-15T20:04:45.939Z,1713211485.939 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-04-15T20:04:46.034Z,1713211486.034 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-04-15T20:04:46.157Z,1713211486.157 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-04-15T20:04:46.159Z,1713211486.159 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-04-15T20:04:46.307Z,1713211486.307 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-04-15T20:04:46.307Z,1713211486.307 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-04-15T20:04:46.697Z,1713211486.697 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-04-15T20:04:46.697Z,1713211486.697 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-04-15T20:04:46.820Z,1713211486.820 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-04-15T20:04:46.821Z,1713211486.821 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-04-15T20:04:47.271Z,1713211487.271 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-04-15T20:04:47.272Z,1713211487.272 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-04-15T20:04:47.514Z,1713211487.514 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-04-15T20:04:47.516Z,1713211487.516 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-04-15T20:04:47.609Z,1713211487.609 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-04-15T20:04:47.877Z,1713211487.877 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-04-15T20:04:47.878Z,1713211487.878 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-04-15T20:04:48.127Z,1713211488.127 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-04-15T20:04:48.128Z,1713211488.128 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-04-15T20:04:48.714Z,1713211488.714 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-04-15T20:04:48.715Z,1713211488.715 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-04-15T20:04:48.942Z,1713211488.942 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-04-15T20:04:48.978Z,1713211488.978 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-04-15T20:04:49.318Z,1713211489.318 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-04-15T20:04:49.320Z,1713211489.320 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-04-15T20:04:50.270Z,1713211490.270 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-04-15T20:04:50.271Z,1713211490.271 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-04-15T20:04:50.904Z,1713211490.904 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-04-15T20:04:50.906Z,1713211490.906 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/ 2024-04-15T20:04:50.909Z,1713211490.909 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Control.cfg 2024-04-15T20:04:51.023Z,1713211491.023 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Science.cfg 2024-04-15T20:04:51.158Z,1713211491.158 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/secure.cfg 2024-04-15T20:04:51.255Z,1713211491.255 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Servo.cfg 2024-04-15T20:04:51.379Z,1713211491.379 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/BIT.cfg 2024-04-15T20:04:51.480Z,1713211491.480 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Battery.cfg 2024-04-15T20:04:51.775Z,1713211491.775 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-04-15T20:04:51.777Z,1713211491.777 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/vehicle.cfg 2024-04-15T20:04:51.900Z,1713211491.900 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/logger.cfg 2024-04-15T20:04:52.010Z,1713211492.010 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Navigation.cfg 2024-04-15T20:04:52.130Z,1713211492.130 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Sensor.cfg 2024-04-15T20:04:52.289Z,1713211492.289 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Simulator.cfg 2024-04-15T20:04:52.389Z,1713211492.389 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2024-04-15T20:04:52.404Z,1713211492.404 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-04-15T20:04:52.565Z,1713211492.565 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-04-15T20:04:52.566Z,1713211492.566 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-04-15T20:04:52.642Z,1713211492.642 [VerticalControl](DEBUG): Construct VerticalControl. 2024-04-15T20:04:52.704Z,1713211492.704 [VerticalControl] Loaded 2024-04-15T20:04:52.705Z,1713211492.705 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-04-15T20:04:52.708Z,1713211492.708 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-04-15T20:04:52.752Z,1713211492.752 [HorizontalControl] Loaded 2024-04-15T20:04:52.752Z,1713211492.752 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-04-15T20:04:52.755Z,1713211492.755 [SpeedControl](DEBUG): Construct SpeedControl. 2024-04-15T20:04:52.758Z,1713211492.758 [SpeedControl] Loaded 2024-04-15T20:04:52.758Z,1713211492.758 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-04-15T20:04:52.761Z,1713211492.761 [LoopControl](DEBUG): Construct LoopControl. 2024-04-15T20:04:52.762Z,1713211492.762 [LoopControl] Loaded 2024-04-15T20:04:52.762Z,1713211492.762 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-04-15T20:04:52.762Z,1713211492.762 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-04-15T20:04:52.763Z,1713211492.763 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-04-15T20:04:52.851Z,1713211492.851 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-04-15T20:04:52.852Z,1713211492.852 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-04-15T20:04:53.684Z,1713211493.684 [AHRS_M2] Loaded 2024-04-15T20:04:53.684Z,1713211493.684 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2024-04-15T20:04:53.935Z,1713211493.935 [BackseatComponent] Loaded 2024-04-15T20:04:53.935Z,1713211493.935 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2024-04-15T20:04:53.937Z,1713211493.937 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 4089C4E0 2024-04-15T20:04:53.937Z,1713211493.937 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 924 2024-04-15T20:04:53.940Z,1713211493.940 [LcmUniversalReporter] Loaded 2024-04-15T20:04:53.940Z,1713211493.940 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2024-04-15T20:04:54.797Z,1713211494.797 [BPC1] Loaded 2024-04-15T20:04:54.797Z,1713211494.797 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-04-15T20:04:54.937Z,1713211494.937 [DataOverHttps] Loaded 2024-04-15T20:04:54.938Z,1713211494.938 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-04-15T20:04:54.939Z,1713211494.939 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408CC4E0 2024-04-15T20:04:54.939Z,1713211494.939 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 925 2024-04-15T20:04:54.960Z,1713211494.960 [Depth_Keller] Loaded 2024-04-15T20:04:54.961Z,1713211494.961 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-04-15T20:04:54.966Z,1713211494.966 [DropWeight] Loaded 2024-04-15T20:04:54.966Z,1713211494.966 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2024-04-15T20:04:55.031Z,1713211495.031 [NAL9602] Loaded 2024-04-15T20:04:55.031Z,1713211495.031 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-04-15T20:04:55.063Z,1713211495.063 [Onboard] Loaded 2024-04-15T20:04:55.063Z,1713211495.063 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-04-15T20:04:55.064Z,1713211495.064 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408FC4E0 2024-04-15T20:04:55.064Z,1713211495.064 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 926 2024-04-15T20:04:55.070Z,1713211495.070 [PowerOnly](INFO): Adding load control power supply at /dev/loadC1 2024-04-15T20:04:55.083Z,1713211495.083 [PowerOnly] Loaded 2024-04-15T20:04:55.083Z,1713211495.083 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread. 2024-04-15T20:04:55.095Z,1713211495.095 [Power24vConverter] Loaded 2024-04-15T20:04:55.095Z,1713211495.095 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-04-15T20:04:55.109Z,1713211495.109 [Radio_Surface] Loaded 2024-04-15T20:04:55.109Z,1713211495.109 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-04-15T20:04:55.110Z,1713211495.110 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4092C4E0 2024-04-15T20:04:55.111Z,1713211495.111 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 927 2024-04-15T20:04:55.125Z,1713211495.125 [Sonardyne_Nano] Loaded 2024-04-15T20:04:55.125Z,1713211495.125 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2024-04-15T20:04:55.220Z,1713211495.220 [DAT] Loaded 2024-04-15T20:04:55.220Z,1713211495.220 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2024-04-15T20:04:55.221Z,1713211495.221 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 4095C4E0 2024-04-15T20:04:55.221Z,1713211495.221 [DAT ThreadHandler](INFO): Protected caller Thread ID is 928 2024-04-15T20:04:55.245Z,1713211495.245 [Waterlinked] Loaded 2024-04-15T20:04:55.246Z,1713211495.246 [ComponentRegistry](DEBUG): SyncComponent "Waterlinked" handled in the control thread. 2024-04-15T20:04:55.246Z,1713211495.246 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-04-15T20:04:55.247Z,1713211495.247 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-04-15T20:04:55.263Z,1713211495.263 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-04-15T20:04:55.264Z,1713211495.264 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-04-15T20:04:55.307Z,1713211495.307 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-04-15T20:04:55.308Z,1713211495.308 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-04-15T20:04:55.497Z,1713211495.497 [SBIT](DEBUG): Construct Startup Built In Test. 2024-04-15T20:04:55.506Z,1713211495.506 [SBIT] Loaded 2024-04-15T20:04:55.507Z,1713211495.507 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-04-15T20:04:55.510Z,1713211495.510 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-04-15T20:04:55.523Z,1713211495.523 [IBIT] Loaded 2024-04-15T20:04:55.523Z,1713211495.523 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-04-15T20:04:55.529Z,1713211495.529 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-04-15T20:04:55.638Z,1713211495.638 [CBIT] Loaded 2024-04-15T20:04:55.638Z,1713211495.638 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-04-15T20:04:55.639Z,1713211495.639 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-04-15T20:04:55.639Z,1713211495.639 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-04-15T20:04:56.103Z,1713211496.103 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-04-15T20:04:56.104Z,1713211496.104 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-04-15T20:04:56.178Z,1713211496.178 [DepthRateCalculator] Loaded 2024-04-15T20:04:56.178Z,1713211496.178 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-04-15T20:04:56.183Z,1713211496.183 [PitchRateCalculator] Loaded 2024-04-15T20:04:56.184Z,1713211496.184 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-04-15T20:04:56.195Z,1713211496.195 [SpeedCalculator] Loaded 2024-04-15T20:04:56.195Z,1713211496.195 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-04-15T20:04:56.200Z,1713211496.200 [YawRateCalculator] Loaded 2024-04-15T20:04:56.200Z,1713211496.200 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-04-15T20:04:56.220Z,1713211496.220 [ElevatorOffsetCalculator] Loaded 2024-04-15T20:04:56.221Z,1713211496.221 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-04-15T20:04:56.221Z,1713211496.221 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-04-15T20:04:56.222Z,1713211496.222 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-04-15T20:04:56.461Z,1713211496.461 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-04-15T20:04:56.461Z,1713211496.461 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-04-15T20:04:56.606Z,1713211496.606 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-04-15T20:04:56.606Z,1713211496.606 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-04-15T20:04:56.650Z,1713211496.650 [DeadReckonUsingSpeedCalculator] Loaded 2024-04-15T20:04:56.651Z,1713211496.651 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2024-04-15T20:04:56.694Z,1713211496.694 [DeadReckonWithRespectToSeafloor] Loaded 2024-04-15T20:04:56.695Z,1713211496.695 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread. 2024-04-15T20:04:56.709Z,1713211496.709 [NavChart] Loaded 2024-04-15T20:04:56.709Z,1713211496.709 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-04-15T20:04:56.715Z,1713211496.715 [UniversalFixResidualReporter] Loaded 2024-04-15T20:04:56.716Z,1713211496.716 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-04-15T20:04:56.716Z,1713211496.716 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-04-15T20:04:56.717Z,1713211496.717 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-04-15T20:04:56.891Z,1713211496.891 [BuoyancyServo] Loaded 2024-04-15T20:04:56.891Z,1713211496.891 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-04-15T20:04:56.913Z,1713211496.913 [ElevatorServo] Loaded 2024-04-15T20:04:56.913Z,1713211496.913 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-04-15T20:04:56.934Z,1713211496.934 [MassServo] Loaded 2024-04-15T20:04:56.934Z,1713211496.934 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-04-15T20:04:56.953Z,1713211496.953 [RudderServo] Loaded 2024-04-15T20:04:56.954Z,1713211496.954 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-04-15T20:04:56.969Z,1713211496.969 [ThrusterHE] Loaded 2024-04-15T20:04:56.970Z,1713211496.970 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2024-04-15T20:04:56.970Z,1713211496.970 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-04-15T20:04:56.971Z,1713211496.971 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-04-15T20:04:57.209Z,1713211497.209 [CTD_Seabird] Loaded 2024-04-15T20:04:57.210Z,1713211497.210 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2024-04-15T20:04:57.211Z,1713211497.211 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40BD64E0 2024-04-15T20:04:57.211Z,1713211497.211 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 929 2024-04-15T20:04:57.246Z,1713211497.246 [ESPComponent] Loaded 2024-04-15T20:04:57.246Z,1713211497.246 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2024-04-15T20:04:57.267Z,1713211497.267 [PAR_Licor] Loaded 2024-04-15T20:04:57.267Z,1713211497.267 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-04-15T20:04:57.314Z,1713211497.314 [WetLabsBB2FL] Loaded 2024-04-15T20:04:57.314Z,1713211497.314 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2024-04-15T20:04:57.315Z,1713211497.315 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40C064E0 2024-04-15T20:04:57.316Z,1713211497.316 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 930 2024-04-15T20:04:57.316Z,1713211497.316 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-04-15T20:04:57.323Z,1713211497.323 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-04-15T20:04:57.326Z,1713211497.326 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-04-15T20:04:57.337Z,1713211497.337 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-04-15T20:04:57.338Z,1713211497.338 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C364E0 2024-04-15T20:04:57.338Z,1713211497.338 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 931 2024-04-15T20:04:57.343Z,1713211497.343 [Supervisor](INFO): Main Thread ID is 828 2024-04-15T20:04:57.343Z,1713211497.343 [Supervisor](DEBUG): Running supervisor. 2024-04-15T20:04:57.343Z,1713211497.343 [CommandExec ThreadHandler](INFO): Handler Thread ID is 932 2024-04-15T20:04:57.344Z,1713211497.344 [CommandExec](INFO): Initializing the command executive. 2024-04-15T20:04:57.346Z,1713211497.346 [CommandLine ThreadHandler](INFO): Handler Thread ID is 933 2024-04-15T20:04:57.348Z,1713211497.348 [controlThread ThreadHandler](INFO): Handler Thread ID is 934 2024-04-15T20:04:57.348Z,1713211497.348 [controlThread](DEBUG): Initializing ControlThread 2024-04-15T20:04:57.349Z,1713211497.349 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-04-15T20:04:57.350Z,1713211497.350 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-04-15T20:04:57.351Z,1713211497.351 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-04-15T20:04:57.352Z,1713211497.352 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-04-15T20:04:57.358Z,1713211497.358 [SBIT](INFO): Initialize SBIT Component. 2024-04-15T20:04:57.358Z,1713211497.358 [SBIT](IMPORTANT): git: 2024-04-15_A 2024-04-15T20:04:57.359Z,1713211497.359 [SBIT](INFO): git hash: 2bacc01b88145f0e093f8ff9b52cfcf5607eedc3 2024-04-15T20:04:57.359Z,1713211497.359 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-04-15T20:04:57.360Z,1713211497.360 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #639 PREEMPT Wed Mar 12 12:53:33 PDT 2014 Kernel Reported: #1 PREEMPT Tue Nov 28 15:04:22 PST 2023 2024-04-15T20:04:57.361Z,1713211497.361 [SBIT](INFO): Beginning SBIT in 83.000000 seconds. 2024-04-15T20:04:57.362Z,1713211497.362 [IBIT](INFO): Initialize IBIT Component. 2024-04-15T20:04:57.362Z,1713211497.362 [CBIT](DEBUG): Initialize CBIT Component. 2024-04-15T20:04:57.363Z,1713211497.363 [logger ThreadHandler](INFO): Handler Thread ID is 935 2024-04-15T20:04:57.376Z,1713211497.376 [CBIT](DEBUG): Initialized mux pins. 2024-04-15T20:04:57.376Z,1713211497.376 [CBIT](DEBUG): Initializing the watchdog timer. 2024-04-15T20:04:57.385Z,1713211497.385 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 936 2024-04-15T20:04:57.396Z,1713211497.396 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 937 2024-04-15T20:04:57.398Z,1713211497.398 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-04-15T20:04:57.400Z,1713211497.400 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-04-15T20:04:57.400Z,1713211497.400 [CBIT](DEBUG): Initializing heartbeat. 2024-04-15T20:04:57.408Z,1713211497.408 [Onboard ThreadHandler](INFO): Handler Thread ID is 938 2024-04-15T20:04:57.425Z,1713211497.425 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 939 2024-04-15T20:04:57.444Z,1713211497.444 [DAT ThreadHandler](INFO): Handler Thread ID is 940 2024-04-15T20:04:57.445Z,1713211497.445 [DAT](INFO): Powering up 2024-04-15T20:04:57.445Z,1713211497.445 [DAT](DEBUG): Initializing DAT. 2024-04-15T20:04:57.450Z,1713211497.450 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 942 2024-04-15T20:04:57.450Z,1713211497.450 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-04-15T20:04:57.457Z,1713211497.457 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 944 2024-04-15T20:04:57.461Z,1713211497.461 [WetLabsBB2FL](INFO): Powering up 2024-04-15T20:04:57.462Z,1713211497.462 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 946 2024-04-15T20:04:57.469Z,1713211497.469 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2HA05M.000 2024-04-15T20:04:57.469Z,1713211497.469 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2HA05M.000 2024-04-15T20:04:57.469Z,1713211497.469 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3HA20M.000 2024-04-15T20:04:57.469Z,1713211497.469 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3HA20M.000 2024-04-15T20:04:57.469Z,1713211497.469 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000 2024-04-15T20:04:57.469Z,1713211497.469 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4HA51M.000 2024-04-15T20:04:57.470Z,1713211497.470 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000 2024-04-15T20:04:57.470Z,1713211497.470 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4HA51M.000 2024-04-15T20:04:57.470Z,1713211497.470 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA53M.000 2024-04-15T20:04:57.470Z,1713211497.470 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5HA53M.000 2024-04-15T20:04:57.470Z,1713211497.470 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA55M.000 2024-04-15T20:04:57.470Z,1713211497.470 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5HA55M.000 2024-04-15T20:04:57.472Z,1713211497.472 [CBIT](DEBUG): Deactivating GF circuits. 2024-04-15T20:04:57.472Z,1713211497.472 [CBIT](DEBUG): Deactivating emergency mode. 2024-04-15T20:04:57.512Z,1713211497.512 [CBIT](DEBUG): Backplane powered. 2024-04-15T20:04:57.512Z,1713211497.512 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-04-15T20:04:57.513Z,1713211497.513 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-04-15T20:04:57.513Z,1713211497.513 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-04-15T20:04:57.513Z,1713211497.513 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-04-15T20:04:57.514Z,1713211497.514 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-04-15T20:04:57.515Z,1713211497.515 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-04-15T20:04:57.516Z,1713211497.516 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-04-15T20:04:57.516Z,1713211497.516 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-04-15T20:04:57.520Z,1713211497.520 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2024-04-15T20:04:57.521Z,1713211497.521 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2024-04-15T20:04:57.521Z,1713211497.521 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2024-04-15T20:04:57.527Z,1713211497.527 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2024-04-15T20:04:57.605Z,1713211497.605 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2024-04-15T20:04:57.610Z,1713211497.610 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-04-15T20:04:57.648Z,1713211497.648 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission Startup { behavior Guidance:GoToSurface { run in progression } aggregate StartupSatComms { run in sequence readDatum { timeout duration=P1M Universal:latitude_fix } readDatum { timeout duration=P1M Universal:platform_communications } } } 2024-04-15T20:04:57.664Z,1713211497.664 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2024-04-15T20:04:57.664Z,1713211497.664 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2024-04-15T20:04:57.668Z,1713211497.668 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2024-04-15T20:04:57.840Z,1713211497.840 [Radio_Surface](INFO): Powering up 2024-04-15T20:04:57.950Z,1713211497.950 [MissionManager](DEBUG): TethyslAPI: Missions/Default.tl translated into: 0 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2024-04-15T20:04:57.972Z,1713211497.972 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2024-04-15T20:04:57.973Z,1713211497.973 [Default:A.Wait](DEBUG): Construct Wait. 2024-04-15T20:04:57.976Z,1713211497.976 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2024-04-15T20:04:58.015Z,1713211498.015 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-04-15T20:04:58.034Z,1713211498.034 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-04-15T20:04:58.039Z,1713211498.039 [Default:E.Execute](DEBUG): Construct Execute. 2024-04-15T20:04:58.062Z,1713211498.062 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission Default { arguments { ElapsedSinceDefaultStarted = 0 minute } behavior Guidance:Wait { """ Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. """ run in sequence set duration = 13 second } behavior Guidance:GoToSurface { run in progression } aggregate CheckIn { run in sequence repeat=288 readDatum id="Read_GPS" { timeout duration=P5M Universal:time_fix } readDatum id="Read_Iridium" { timeout duration=P4H { behavior Guidance:Execute { run in sequence set command = "Burn on" } syslog critical "Dropped weight due to communications timeout." } Universal:platform_communications } behavior Guidance:Wait { run in sequence set duration = 5 minute } assign in sequence ElapsedSinceDefaultStarted = elapsed ( Universal:mission_started ) syslog important "Default mission has been running for " + ElapsedSinceDefaultStarted~minute } syslog important "Restarting logs and Default mission." behavior Guidance:Execute { run in sequence set command = "restart logs" } } 2024-04-15T20:04:58.068Z,1713211498.068 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,PowerOnly,Power24vConverter,Sonardyne_Nano,Waterlinked,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-04-15T20:04:58.079Z,1713211498.079 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-04-15T20:04:58.249Z,1713211498.249 [Depth_Keller](ERROR): Pressure or depth reading out of range: -1.140412 decibar, -1.132002 m 2024-04-15T20:04:58.251Z,1713211498.251 [Power24vConverter](INFO): Powering up. 2024-04-15T20:04:58.256Z,1713211498.256 [Sonardyne_Nano](INFO): Initializing. 2024-04-15T20:04:58.290Z,1713211498.290 [DepthRateCalculator](ERROR): Depth measurement is not active 2024-04-15T20:04:58.334Z,1713211498.334 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-04-15T20:04:58.340Z,1713211498.340 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-04-15T20:04:58.342Z,1713211498.342 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-04-15T20:04:58.348Z,1713211498.348 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-04-15T20:04:58.349Z,1713211498.349 [MassServo](DEBUG): Initializing EZServoServo. 2024-04-15T20:04:58.356Z,1713211498.356 [MassServo](DEBUG): Initializing MassServo. 2024-04-15T20:04:58.357Z,1713211498.357 [RudderServo](DEBUG): Initializing EZServoServo. 2024-04-15T20:04:58.364Z,1713211498.364 [RudderServo](DEBUG): Initializing RudderServo. 2024-04-15T20:04:58.365Z,1713211498.365 [ThrusterHE](DEBUG): Initializing EZServoServo. 2024-04-15T20:04:58.372Z,1713211498.372 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2024-04-15T20:04:59.564Z,1713211499.564 [WetLabsBB2FL](INFO): Powering down 2024-04-15T20:05:00.503Z,1713211500.503 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2024-04-15T20:05:01.745Z,1713211501.745 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2311 2024-04-15T20:05:04.017Z,1713211504.017 [ThrusterHE](ERROR): Zero Speed Commanded. 2024-04-15T20:05:04.480Z,1713211504.480 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit. 2024-04-15T20:05:10.297Z,1713211510.297 [DAT](INFO): DAT read: 2024-04-15T20:05:10.298Z,1713211510.298 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2024-04-15T20:05:11.811Z,1713211511.811 [DAT](INFO): DAT read: MF Frequency Band 2024-04-15T20:05:12.061Z,1713211512.061 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2024-04-15T20:05:12.062Z,1713211512.062 [DAT](INFO): DAT read: Apr 15 2024 20:05:06 2024-04-15T20:05:13.069Z,1713211513.069 [DAT](INFO): DAT read: Features enabled [Bearing] 2024-04-15T20:05:13.070Z,1713211513.070 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2024-04-15T20:05:13.071Z,1713211513.071 [DAT](INFO): commRate: 800 2024-04-15T20:05:15.136Z,1713211515.136 [DAT](INFO): entering command mode 2024-04-15T20:05:15.336Z,1713211515.336 [DAT](INFO): DAT read: 2024-04-15T20:05:15.337Z,1713211515.337 [DAT](INFO): DAT read: user:1> 2024-04-15T20:05:15.337Z,1713211515.337 [DAT](INFO): setting verbose to 3 2024-04-15T20:05:15.589Z,1713211515.589 [DAT](INFO): DAT read: user:1> 2024-04-15T20:05:15.590Z,1713211515.590 [DAT](INFO): DAT read: Verbose | 3 2024-04-15T20:05:15.590Z,1713211515.590 [DAT](INFO): set verbose to 3 2024-04-15T20:05:15.590Z,1713211515.590 [DAT](INFO): setting DatVerbose to 27440 2024-04-15T20:05:15.840Z,1713211515.840 [DAT](INFO): DAT read: user:2> 2024-04-15T20:05:15.841Z,1713211515.841 [DAT](INFO): DAT read: DatVerbose | 27440 2024-04-15T20:05:15.842Z,1713211515.842 [DAT](INFO): set DatVerbose to 27440 2024-04-15T20:05:15.842Z,1713211515.842 [DAT](INFO): setting transmit power to 8 2024-04-15T20:05:16.093Z,1713211516.093 [DAT](INFO): DAT read: user:3> 2024-04-15T20:05:16.094Z,1713211516.094 [DAT](INFO): DAT read: TxPower | 8 (Max) 2024-04-15T20:05:16.094Z,1713211516.094 [DAT](INFO): set transmit power to 8 2024-04-15T20:05:16.095Z,1713211516.095 [DAT](INFO): setting local address to 1 2024-04-15T20:05:16.345Z,1713211516.345 [DAT](INFO): DAT read: user:4> 2024-04-15T20:05:16.346Z,1713211516.346 [DAT](INFO): DAT read: LocalAddr | 1 2024-04-15T20:05:16.346Z,1713211516.346 [DAT](INFO): set local address to 1 2024-04-15T20:05:16.347Z,1713211516.347 [DAT](INFO): Setting time to: 20:5:16 And date to:4/15/2024 2024-04-15T20:05:16.597Z,1713211516.597 [DAT](INFO): DAT read: user:5> 2024-04-15T20:05:16.598Z,1713211516.598 [DAT](INFO): DAT read: Mon Apr 15, 2024 20:05:16 2024-04-15T20:05:16.598Z,1713211516.598 [DAT](INFO): Local DAT time set to Mon Apr 15, 2024 20:05:16 2024-04-15T20:05:25.162Z,1713211525.162 [NAL9602](INFO): Powering up NAL9602 2024-04-15T20:05:29.215Z,1713211529.215 [Waterlinked](ERROR): only read 0 of 1 data item for BIT error. Device response::TS,22032019555062, 0.0, +0.0,47 2024-04-15T20:05:32.524Z,1713211532.524 [Waterlinked](INFO): Powering down 2024-04-15T20:05:36.061Z,1713211536.061 [NAL9602](INFO): NAL9602 initialized 2024-04-15T20:05:50.605Z,1713211550.605 [NAL9602](INFO): SBD MO Status=0, MOMSN=11859, MT Status=0, MTMSN=0 2024-04-15T20:05:50.605Z,1713211550.605 [NAL9602](INFO): No messages in MT queue 2024-04-15T20:06:00.707Z,1713211560.707 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,200600.00,A,3648.13886,N,12147.20352,W,0.117,0.00,150424,,,A*73 2024-04-15T20:06:00.710Z,1713211560.710 [NAL9602](INFO): GPS fix at 20240415T200600: (36.802314, -121.786725) 2024-04-15T20:06:05.148Z,1713211565.148 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-15T20:06:20.098Z,1713211580.098 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-15T20:06:20.948Z,1713211580.948 [SBIT](IMPORTANT): Beginning Startup BIT 2024-04-15T20:06:20.953Z,1713211580.953 [CBIT](IMPORTANT): Beginning ground fault scan 2024-04-15T20:06:32.012Z,1713211592.012 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.000588 CHAN A1 (24V): 0.000333 CHAN A2 (12V): -0.000140 CHAN A3 (5V): -0.001294 CHAN B0 (3.3V): 0.000460 CHAN B1 (3.15aV): 0.000143 CHAN B2 (3.15bV): -0.000541 CHAN B3 (GND): -0.000362 OPEN: 0.006268 Full Scale: +/- 1 mA 2024-04-15T20:06:33.027Z,1713211593.027 [NAL9602](INFO): Not Powering down - fast GPS 2024-04-15T20:06:35.448Z,1713211595.448 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-15T20:06:50.801Z,1713211610.801 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-15T20:07:06.164Z,1713211626.164 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-15T20:07:15.061Z,1713211635.061 [SBIT](IMPORTANT): SBIT PASSED 2024-04-15T20:07:15.061Z,1713211635.061 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2024-04-15T20:07:15.062Z,1713211635.062 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=15 count; 2024-04-15T20:07:15.062Z,1713211635.062 [SBIT](IMPORTANT): Express linearApproximation DAT.acoustic_contact_range 10.000000 meter; 2024-04-15T20:07:15.062Z,1713211635.062 [SBIT](IMPORTANT): Express linearApproximation PowerOnly.loadControl 50.000000 milliampere; 2024-04-15T20:07:15.062Z,1713211635.062 [SBIT](IMPORTANT): Express linearApproximation _.planktivore_HM_AvgRois 0.600000 count_per_second; 2024-04-15T20:07:15.062Z,1713211635.062 [SBIT](IMPORTANT): Express linearApproximation _.planktivore_LM_AvgRois 0.600000 count_per_second; 2024-04-15T20:07:15.062Z,1713211635.062 [SBIT](IMPORTANT): Express linearApproximation height_above_sea_floor 5.000000 meter; 2024-04-15T20:07:15.063Z,1713211635.063 [SBIT](IMPORTANT): Vehicle.useTlLoader=1 bool; 2024-04-15T20:07:15.063Z,1713211635.063 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=205.380030 cubic_centimeter; 2024-04-15T20:07:15.063Z,1713211635.063 [SBIT](IMPORTANT): VerticalControl.massDefault=15.858152 millimeter; 2024-04-15T20:07:15.467Z,1713211635.467 [MissionManager](IMPORTANT): Started mission Startup 2024-04-15T20:07:15.467Z,1713211635.467 [Startup] Running Loop=1 2024-04-15T20:07:15.467Z,1713211635.467 [Startup](DEBUG): Aggregate::initialize Startup 2024-04-15T20:07:15.467Z,1713211635.467 [Startup:A.GoToSurface] Running Loop=1 2024-04-15T20:07:15.467Z,1713211635.467 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-04-15T20:07:15.469Z,1713211635.469 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-04-15T20:07:15.469Z,1713211635.469 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-04-15T20:07:15.469Z,1713211635.469 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-04-15T20:07:15.470Z,1713211635.470 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-04-15T20:07:15.470Z,1713211635.470 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-04-15T20:07:15.472Z,1713211635.472 [Startup:StartupSatComms] Running Loop=1 2024-04-15T20:07:15.472Z,1713211635.472 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2024-04-15T20:07:15.472Z,1713211635.472 [Startup:StartupSatComms:A] Running Loop=1 2024-04-15T20:07:15.887Z,1713211635.887 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2024-04-15T20:07:17.475Z,1713211637.475 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,200718.00,A,3648.13816,N,12147.20249,W,0.233,279.93,150424,,,A*7A 2024-04-15T20:07:17.477Z,1713211637.477 [NAL9602](INFO): GPS fix at 20240415T200718: (36.802303, -121.786708) 2024-04-15T20:07:17.521Z,1713211637.521 [Startup:StartupSatComms:A] Stopped 2024-04-15T20:07:17.522Z,1713211637.522 [Startup:StartupSatComms:B] Running Loop=1 2024-04-15T20:07:17.924Z,1713211637.924 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-04-15T20:07:21.505Z,1713211641.505 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-15T20:07:32.875Z,1713211652.875 [NAL9602](INFO): SBD MO Status=1, MOMSN=11860, MT Status=0, MTMSN=0 2024-04-15T20:07:32.936Z,1713211652.936 [NAL9602](INFO): Sent 73 bytes from file Logs/20240415T150703/Courier0169.lzma 2024-04-15T20:07:32.936Z,1713211652.936 [NAL9602](INFO): Packets left to send: 0 2024-04-15T20:07:36.963Z,1713211656.963 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-15T20:07:41.007Z,1713211661.007 [NAL9602](INFO): SBD MO Status=1, MOMSN=11861, MT Status=0, MTMSN=0 2024-04-15T20:07:41.064Z,1713211661.064 [NAL9602](INFO): Sent 18 bytes from file Logs/20240415T150703/Courier0172.lzma 2024-04-15T20:07:41.064Z,1713211661.064 [NAL9602](INFO): Packets left to send: 0 2024-04-15T20:07:47.951Z,1713211667.951 [NAL9602](INFO): SBD MO Status=1, MOMSN=11862, MT Status=0, MTMSN=0 2024-04-15T20:07:48.004Z,1713211668.004 [NAL9602](INFO): Sent 268 bytes from file Logs/20240415T200445/Courier0000.lzma 2024-04-15T20:07:48.004Z,1713211668.004 [NAL9602](INFO): Packets left to send: 0 2024-04-15T20:07:52.032Z,1713211672.032 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-15T20:07:57.723Z,1713211677.723 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-04-15T20:07:57.723Z,1713211677.723 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-04-15T20:07:57.734Z,1713211677.734 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-04-15T20:07:58.137Z,1713211678.137 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-04-15T20:07:58.138Z,1713211678.138 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-04-15T20:07:59.314Z,1713211679.314 [NAL9602](INFO): SBD MO Status=1, MOMSN=11863, MT Status=0, MTMSN=0 2024-04-15T20:07:59.372Z,1713211679.372 [NAL9602](INFO): Sent 135 bytes from file Logs/20240415T150703/Express0170.lzma 2024-04-15T20:07:59.373Z,1713211679.373 [NAL9602](INFO): Packets left to send: 0 2024-04-15T20:08:07.443Z,1713211687.443 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-15T20:08:07.453Z,1713211687.453 [NAL9602](INFO): SBD MO Status=1, MOMSN=11864, MT Status=0, MTMSN=0 2024-04-15T20:08:07.504Z,1713211687.504 [NAL9602](INFO): Sent 18 bytes from file Logs/20240415T150703/Express0173.lzma 2024-04-15T20:08:07.504Z,1713211687.504 [NAL9602](INFO): Packets left to send: 0 2024-04-15T20:08:17.642Z,1713211697.642 [Startup:StartupSatComms:B](INFO): Timed out from 2024-04-15T20:07:17.5Z 2024-04-15T20:08:17.642Z,1713211697.642 [Startup:StartupSatComms:B] Stopped 2024-04-15T20:08:17.642Z,1713211697.642 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2024-04-15T20:08:17.642Z,1713211697.642 [Startup:StartupSatComms] Stopped 2024-04-15T20:08:17.642Z,1713211697.642 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2024-04-15T20:08:17.643Z,1713211697.643 [Startup](INFO): Completed Startup 2024-04-15T20:08:17.643Z,1713211697.643 [MissionManager](INFO): Startup is completed. 2024-04-15T20:08:17.643Z,1713211697.643 [MissionManager](INFO): Uninitializing Mission Startup 2024-04-15T20:08:17.644Z,1713211697.644 [Startup] Stopped 2024-04-15T20:08:17.648Z,1713211697.648 [Startup](DEBUG): Aggregate::uninitialize Startup 2024-04-15T20:08:17.648Z,1713211697.648 [Startup:A.GoToSurface] Stopped 2024-04-15T20:08:17.648Z,1713211697.648 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-04-15T20:08:18.038Z,1713211698.038 [MissionManager](IMPORTANT): Started mission Default 2024-04-15T20:08:18.039Z,1713211698.039 [Default] Running Loop=1 2024-04-15T20:08:18.039Z,1713211698.039 [Default](DEBUG): Aggregate::initialize Default 2024-04-15T20:08:18.039Z,1713211698.039 [Default:B.GoToSurface] Running Loop=1 2024-04-15T20:08:18.039Z,1713211698.039 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-04-15T20:08:18.039Z,1713211698.039 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-04-15T20:08:18.040Z,1713211698.040 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-04-15T20:08:18.040Z,1713211698.040 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-04-15T20:08:18.040Z,1713211698.040 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-04-15T20:08:18.041Z,1713211698.041 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-04-15T20:08:18.041Z,1713211698.041 [Default:A.Wait] Running Loop=1 2024-04-15T20:08:18.041Z,1713211698.041 [Default:A.Wait](DEBUG): Initialize Wait Component. 2024-04-15T20:08:18.426Z,1713211698.426 [NAL9602](INFO): SBD MO Status=1, MOMSN=11865, MT Status=0, MTMSN=0 2024-04-15T20:08:18.484Z,1713211698.484 [NAL9602](INFO): Sent 332 bytes from file Logs/20240415T200445/Express0001.lzma 2024-04-15T20:08:18.484Z,1713211698.484 [NAL9602](INFO): Packets left to send: 3 2024-04-15T20:08:31.367Z,1713211711.367 [Default:A.Wait](INFO): Done Waiting. 2024-04-15T20:08:31.367Z,1713211711.367 [Default:A.Wait] Stopped 2024-04-15T20:08:31.367Z,1713211711.367 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2024-04-15T20:08:31.793Z,1713211711.793 [Default:CheckIn] Running Loop=1 2024-04-15T20:08:31.793Z,1713211711.793 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-04-15T20:08:31.794Z,1713211711.794 [Default:CheckIn:Read_GPS] Running Loop=1 2024-04-15T20:08:32.192Z,1713211712.192 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2024-04-15T20:08:33.801Z,1713211713.801 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,200834.00,A,3648.13862,N,12147.20495,W,0.175,215.75,150424,,,D*79 2024-04-15T20:08:33.803Z,1713211713.803 [NAL9602](INFO): GPS fix at 20240415T200834: (36.802310, -121.786749) 2024-04-15T20:08:33.818Z,1713211713.818 [Default:CheckIn:Read_GPS] Stopped 2024-04-15T20:08:33.818Z,1713211713.818 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-04-15T20:08:34.237Z,1713211714.237 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-04-15T20:08:41.793Z,1713211721.793 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004086 2024-04-15T20:08:49.694Z,1713211729.694 [NAL9602](INFO): SBD MO Status=1, MOMSN=11866, MT Status=0, MTMSN=0 2024-04-15T20:08:49.744Z,1713211729.744 [NAL9602](INFO): Sent 73 bytes from file Logs/20240415T200445/Courier0004.lzma 2024-04-15T20:08:49.744Z,1713211729.744 [NAL9602](INFO): Packets left to send: 0 2024-04-15T20:08:49.830Z,1713211729.830 [Default:CheckIn:Read_Iridium] Stopped 2024-04-15T20:08:49.831Z,1713211729.831 [Default:CheckIn:C.Wait] Running Loop=1 2024-04-15T20:08:49.831Z,1713211729.831 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-04-15T20:08:51.726Z,1713211731.726 [DataOverHttps](IMPORTANT): Could not stat file Logs/20240415T200445/Courier0004.lzma 2024-04-15T20:08:51.726Z,1713211731.726 [DataOverHttps](FAULT): Could not open file Logs/20240415T200445/Courier0004.lzma 2024-04-15T20:09:02.914Z,1713211742.914 [DataOverHttps](IMPORTANT): Could not stat file Logs/20240415T200445/Courier0004.lzma 2024-04-15T20:09:02.914Z,1713211742.914 [DataOverHttps](FAULT): Could not open file Logs/20240415T200445/Courier0004.lzma 2024-04-15T20:09:20.415Z,1713211760.415 [NAL9602](INFO): Not Powering down - fast GPS 2024-04-15T20:09:27.098Z,1713211767.098 [CommandExec](IMPORTANT): got command get 2024-04-15T20:09:27.099Z,1713211767.099 [CommandExec](FAULT): Incomplete syntax. Try: help get 2024-04-15T20:09:32.178Z,1713211772.178 [DataOverHttps](IMPORTANT): Could not stat file Logs/20240415T200445/Courier0004.lzma 2024-04-15T20:09:32.178Z,1713211772.178 [DataOverHttps](FAULT): Could not open file Logs/20240415T200445/Courier0004.lzma 2024-04-15T20:09:38.344Z,1713211778.344 [CommandExec](IMPORTANT): got command get PowerOnly.component_avgCurrent_loadControl 2024-04-15T20:09:38.345Z,1713211778.345 [CommandExec](IMPORTANT): PowerOnly.component_avgCurrent_loadControl nan mA 2024-04-15T20:09:46.701Z,1713211786.701 [CommandExec](IMPORTANT): got command show variable powerOnly 2024-04-15T20:09:46.795Z,1713211786.795 [CommandExec](IMPORTANT): PowerOnly.loadControl (none) 2024-04-15T20:09:46.796Z,1713211786.796 [CommandExec](IMPORTANT): PowerOnly.loadControl2 (none) 2024-04-15T20:09:46.796Z,1713211786.796 [CommandExec](IMPORTANT): PowerOnly.loadControl3 (none) 2024-04-15T20:09:46.813Z,1713211786.813 [CommandExec](IMPORTANT): PowerOnly.loadAtStartup (bool) 2024-04-15T20:09:46.813Z,1713211786.813 [CommandExec](IMPORTANT): PowerOnly.simulateHardware (bool) 2024-04-15T20:09:46.814Z,1713211786.814 [CommandExec](IMPORTANT): PowerOnly.sampleTime (second) 2024-04-15T20:09:46.814Z,1713211786.814 [CommandExec](IMPORTANT): PowerOnly.sampleTime1 (second) 2024-04-15T20:09:46.814Z,1713211786.814 [CommandExec](IMPORTANT): PowerOnly.sampleTime2 (second) 2024-04-15T20:09:46.815Z,1713211786.815 [CommandExec](IMPORTANT): PowerOnly.sampleTime3 (second) 2024-04-15T20:09:46.961Z,1713211786.961 [CommandExec](IMPORTANT): PowerOnly.enableBroadcast (bool) 2024-04-15T20:09:46.962Z,1713211786.962 [CommandExec](IMPORTANT): PowerOnly.samplePowerOnly (bool) 2024-04-15T20:09:46.962Z,1713211786.962 [CommandExec](IMPORTANT): PowerOnly.component_voltage_loadControl (volt) 2024-04-15T20:09:46.963Z,1713211786.963 [CommandExec](IMPORTANT): PowerOnly.component_avgVoltage_loadControl (volt) 2024-04-15T20:09:46.963Z,1713211786.963 [CommandExec](IMPORTANT): PowerOnly.component_current_loadControl (milliampere) 2024-04-15T20:09:46.963Z,1713211786.963 [CommandExec](IMPORTANT): PowerOnly.component_avgCurrent_loadControl (milliampere) 2024-04-15T20:09:46.976Z,1713211786.976 [CommandExec](IMPORTANT): PowerOnly.sampleLoad1 (bool) 2024-04-15T20:10:00.838Z,1713211800.838 [DataOverHttps](IMPORTANT): Could not stat file Logs/20240415T200445/Courier0004.lzma 2024-04-15T20:10:00.838Z,1713211800.838 [DataOverHttps](FAULT): Could not open file Logs/20240415T200445/Courier0004.lzma 2024-04-15T20:10:05.971Z,1713211805.971 [CommandExec](IMPORTANT): got command get PowerOnly.loadControl 2024-04-15T20:10:05.971Z,1713211805.971 [CommandExec](IMPORTANT): PowerOnly.loadControl /dev/loadC1 2024-04-15T20:10:30.804Z,1713211830.804 [CommandExec](IMPORTANT): got command get PowerOnly.component_voltage_loadControl 2024-04-15T20:10:30.804Z,1713211830.804 [CommandExec](IMPORTANT): PowerOnly.component_voltage_loadControl nan V 2024-04-15T20:10:33.118Z,1713211833.118 [DataOverHttps](IMPORTANT): Could not stat file Logs/20240415T200445/Courier0004.lzma 2024-04-15T20:10:33.118Z,1713211833.118 [DataOverHttps](FAULT): Could not open file Logs/20240415T200445/Courier0004.lzma 2024-04-15T20:10:37.184Z,1713211837.184 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-15T20:10:43.231Z,1713211843.231 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-15T20:10:55.757Z,1713211855.757 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-15T20:10:58.614Z,1713211858.614 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-04-15T20:10:58.614Z,1713211858.614 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-04-15T20:10:58.665Z,1713211858.665 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-04-15T20:10:59.059Z,1713211859.059 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-04-15T20:10:59.059Z,1713211859.059 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-04-15T20:11:01.766Z,1713211861.766 [DataOverHttps](IMPORTANT): Could not stat file Logs/20240415T200445/Courier0004.lzma 2024-04-15T20:11:01.766Z,1713211861.766 [DataOverHttps](FAULT): Could not open file Logs/20240415T200445/Courier0004.lzma 2024-04-15T20:11:08.281Z,1713211868.281 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-15T20:11:20.402Z,1713211880.402 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-15T20:11:32.434Z,1713211892.434 [DataOverHttps](IMPORTANT): Could not stat file Logs/20240415T200445/Courier0004.lzma 2024-04-15T20:11:32.434Z,1713211892.434 [DataOverHttps](FAULT): Could not open file Logs/20240415T200445/Courier0004.lzma 2024-04-15T20:11:32.923Z,1713211892.923 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-15T20:11:45.851Z,1713211905.851 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-15T20:11:58.388Z,1713211918.388 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-15T20:12:01.029Z,1713211921.029 [CommandExec](IMPORTANT): got command show variable alwaysOn 2024-04-15T20:12:01.185Z,1713211921.185 [CommandExec](IMPORTANT): BackseatComponent.alwaysOn (bool) 2024-04-15T20:12:03.306Z,1713211923.306 [DataOverHttps](IMPORTANT): Could not stat file Logs/20240415T200445/Courier0004.lzma 2024-04-15T20:12:03.307Z,1713211923.307 [DataOverHttps](FAULT): Could not open file Logs/20240415T200445/Courier0004.lzma 2024-04-15T20:12:10.567Z,1713211930.567 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-15T20:12:23.021Z,1713211943.021 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-15T20:12:33.922Z,1713211953.922 [DataOverHttps](IMPORTANT): Could not stat file Logs/20240415T200445/Courier0004.lzma 2024-04-15T20:12:33.922Z,1713211953.922 [DataOverHttps](FAULT): Could not open file Logs/20240415T200445/Courier0004.lzma 2024-04-15T20:12:35.141Z,1713211955.141 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-15T20:12:47.259Z,1713211967.259 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-15T20:12:59.784Z,1713211979.784 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-15T20:12:59.795Z,1713211979.795 [BPC1](INFO): Calculating totals. Valid battery stick count: 44. Valid reserve battery stick count: 5. 2024-04-15T20:12:59.799Z,1713211979.799 [BPC1](INFO): Received data from all battery sticks. 2024-04-15T20:13:04.498Z,1713211984.498 [DataOverHttps](IMPORTANT): Could not stat file Logs/20240415T200445/Courier0004.lzma 2024-04-15T20:13:04.498Z,1713211984.498 [DataOverHttps](FAULT): Could not open file Logs/20240415T200445/Courier0004.lzma 2024-04-15T20:13:28.703Z,1713212008.703 [CommandExec](IMPORTANT): got command get Sonardyne_Nano.loadControl 2024-04-15T20:13:28.705Z,1713212008.705 [CommandExec](IMPORTANT): Sonardyne_Nano.loadControl /dev/loadC1 2024-04-15T20:13:35.026Z,1713212015.026 [DataOverHttps](IMPORTANT): Could not stat file Logs/20240415T200445/Courier0004.lzma 2024-04-15T20:13:35.026Z,1713212015.026 [DataOverHttps](FAULT): Could not open file Logs/20240415T200445/Courier0004.lzma 2024-04-15T20:13:50.299Z,1713212030.299 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-04-15T20:13:50.299Z,1713212030.299 [Default:CheckIn:C.Wait] Stopped 2024-04-15T20:13:50.299Z,1713212030.299 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-04-15T20:13:50.299Z,1713212030.299 [Default:CheckIn:D] Running Loop=1 2024-04-15T20:13:50.715Z,1713212030.715 [Default:CheckIn:D] Stopped 2024-04-15T20:13:50.715Z,1713212030.715 [Default:CheckIn:E] Running Loop=1 2024-04-15T20:13:51.107Z,1713212031.107 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 5.544609 min 2024-04-15T20:13:51.107Z,1713212031.107 [Default:CheckIn:E] Stopped 2024-04-15T20:13:51.107Z,1713212031.107 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-04-15T20:13:51.107Z,1713212031.107 [Default:CheckIn] Stopped 2024-04-15T20:13:51.107Z,1713212031.107 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-04-15T20:13:51.107Z,1713212031.107 [Default:CheckIn](INFO): Running loop #2 2024-04-15T20:13:51.107Z,1713212031.107 [Default:CheckIn] Running Loop=2 2024-04-15T20:13:51.108Z,1713212031.108 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-04-15T20:13:51.108Z,1713212031.108 [Default:CheckIn:Read_GPS] Running Loop=1 2024-04-15T20:13:53.119Z,1713212033.119 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,201353.00,A,3648.13693,N,12147.20647,W,0.000,215.75,150424,,,D*7C 2024-04-15T20:13:53.121Z,1713212033.121 [NAL9602](INFO): GPS fix at 20240415T201353: (36.802282, -121.786775) 2024-04-15T20:13:53.137Z,1713212033.137 [Default:CheckIn:Read_GPS] Stopped 2024-04-15T20:13:53.137Z,1713212033.137 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-04-15T20:13:59.602Z,1713212039.602 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-04-15T20:13:59.602Z,1713212039.602 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-04-15T20:13:59.613Z,1713212039.613 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-04-15T20:14:00.012Z,1713212040.012 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-04-15T20:14:00.012Z,1713212040.012 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-04-15T20:14:00.546Z,1713212040.546 [DataOverHttps](INFO): Sending 202 bytes from file Logs/20240415T200445/Courier0007.lzma 2024-04-15T20:14:01.546Z,1713212041.546 [DataOverHttps](INFO): Moved sent file to Logs/20240415T200445/Courier0007.lzma.bak 2024-04-15T20:14:01.546Z,1713212041.546 [DataOverHttps](INFO): SBD MOMSN=19408996 2024-04-15T20:14:08.067Z,1713212048.067 [NAL9602](INFO): SBD MO Status=0, MOMSN=11867, MT Status=0, MTMSN=0 2024-04-15T20:14:08.067Z,1713212048.067 [NAL9602](INFO): No messages in MT queue 2024-04-15T20:14:17.490Z,1713212057.490 [DataOverHttps](INFO): Sending 1060 bytes from file Logs/20240415T200445/Express0001.lzma 2024-04-15T20:14:18.490Z,1713212058.490 [DataOverHttps](INFO): Moved sent file to Logs/20240415T200445/Express0001.lzma.bak 2024-04-15T20:14:18.490Z,1713212058.490 [DataOverHttps](INFO): SBD MOMSN=19408999 2024-04-15T20:14:22.230Z,1713212062.230 [CommandExec](IMPORTANT): got command show variable sonardyne_nano.loadControl 2024-04-15T20:14:22.401Z,1713212062.401 [CommandExec](IMPORTANT): Sonardyne_Nano.loadControl (none) 2024-04-15T20:14:29.625Z,1713212069.625 [CommandExec](IMPORTANT): got command get Sonardyne_Nano.loadControl 2024-04-15T20:14:29.625Z,1713212069.625 [CommandExec](IMPORTANT): Sonardyne_Nano.loadControl /dev/loadC1 2024-04-15T20:14:35.167Z,1713212075.167 [DataOverHttps](INFO): Sending 107 bytes from file Logs/20240415T200445/Express0005.lzma 2024-04-15T20:14:36.170Z,1713212076.170 [DataOverHttps](INFO): Moved sent file to Logs/20240415T200445/Express0005.lzma.bak 2024-04-15T20:14:36.170Z,1713212076.170 [DataOverHttps](INFO): SBD MOMSN=19409022 2024-04-15T20:14:37.739Z,1713212077.739 [CommandExec](IMPORTANT): got command get PowerOnly.loadControl 2024-04-15T20:14:37.739Z,1713212077.739 [CommandExec](IMPORTANT): PowerOnly.loadControl /dev/loadC1 2024-04-15T20:14:38.773Z,1713212078.773 [NAL9602](INFO): Not Powering down - fast GPS 2024-04-15T20:14:55.049Z,1713212095.049 [DataOverHttps](INFO): Sending 773 bytes from file Logs/20240415T200445/Express0008.lzma 2024-04-15T20:14:56.050Z,1713212096.050 [DataOverHttps](INFO): Moved sent file to Logs/20240415T200445/Express0008.lzma.bak 2024-04-15T20:14:56.050Z,1713212096.050 [DataOverHttps](INFO): SBD MOMSN=19409025 2024-04-15T20:14:57.439Z,1713212097.439 [Default:CheckIn:Read_Iridium] Stopped 2024-04-15T20:14:57.439Z,1713212097.439 [Default:CheckIn:C.Wait] Running Loop=1 2024-04-15T20:14:57.439Z,1713212097.439 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-04-15T20:17:00.661Z,1713212220.661 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-04-15T20:17:00.661Z,1713212220.661 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-04-15T20:17:00.696Z,1713212220.696 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-04-15T20:17:01.075Z,1713212221.075 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-04-15T20:17:01.075Z,1713212221.075 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-04-15T20:18:42.018Z,1713212322.018 [CommandExec](IMPORTANT): got command get PowerOnly.sampleTime 2024-04-15T20:18:42.019Z,1713212322.019 [CommandExec](IMPORTANT): PowerOnly.sampleTime 90.000000 s 2024-04-15T20:19:58.102Z,1713212398.102 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-04-15T20:19:58.102Z,1713212398.102 [Default:CheckIn:C.Wait] Stopped 2024-04-15T20:19:58.102Z,1713212398.102 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-04-15T20:19:58.102Z,1713212398.102 [Default:CheckIn:D] Running Loop=1 2024-04-15T20:19:58.446Z,1713212398.446 [Default:CheckIn:D] Stopped 2024-04-15T20:19:58.446Z,1713212398.446 [Default:CheckIn:E] Running Loop=1 2024-04-15T20:19:58.859Z,1713212398.859 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 11.673457 min 2024-04-15T20:19:58.859Z,1713212398.859 [Default:CheckIn:E] Stopped 2024-04-15T20:19:58.859Z,1713212398.859 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-04-15T20:19:58.859Z,1713212398.859 [Default:CheckIn] Stopped 2024-04-15T20:19:58.859Z,1713212398.859 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-04-15T20:19:58.860Z,1713212398.860 [Default:CheckIn](INFO): Running loop #3 2024-04-15T20:19:58.860Z,1713212398.860 [Default:CheckIn] Running Loop=3 2024-04-15T20:19:58.860Z,1713212398.860 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-04-15T20:19:58.860Z,1713212398.860 [Default:CheckIn:Read_GPS] Running Loop=1 2024-04-15T20:20:00.860Z,1713212400.860 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,202001.00,A,3648.13663,N,12147.20467,W,0.058,215.75,150424,,,D*79 2024-04-15T20:20:00.862Z,1713212400.862 [NAL9602](INFO): GPS fix at 20240415T202001: (36.802277, -121.786744) 2024-04-15T20:20:00.895Z,1713212400.895 [Default:CheckIn:Read_GPS] Stopped 2024-04-15T20:20:00.895Z,1713212400.895 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-04-15T20:20:01.679Z,1713212401.679 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-04-15T20:20:01.679Z,1713212401.679 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-04-15T20:20:01.691Z,1713212401.691 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-04-15T20:20:02.100Z,1713212402.100 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-04-15T20:20:02.100Z,1713212402.100 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-04-15T20:20:07.935Z,1713212407.935 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240415T200445/Courier0010.lzma 2024-04-15T20:20:08.937Z,1713212408.937 [DataOverHttps](INFO): Moved sent file to Logs/20240415T200445/Courier0010.lzma.bak 2024-04-15T20:20:08.938Z,1713212408.938 [DataOverHttps](INFO): SBD MOMSN=19409079 2024-04-15T20:20:23.487Z,1713212423.487 [NAL9602](INFO): SBD MO Status=0, MOMSN=11868, MT Status=0, MTMSN=0 2024-04-15T20:20:23.487Z,1713212423.487 [NAL9602](INFO): No messages in MT queue 2024-04-15T20:20:25.016Z,1713212425.016 [DataOverHttps](INFO): Sending 288 bytes from file Logs/20240415T200445/Express0011.lzma 2024-04-15T20:20:26.018Z,1713212426.018 [DataOverHttps](INFO): Moved sent file to Logs/20240415T200445/Express0011.lzma.bak 2024-04-15T20:20:26.018Z,1713212426.018 [DataOverHttps](INFO): SBD MOMSN=19409082 2024-04-15T20:20:27.143Z,1713212427.143 [Default:CheckIn:Read_Iridium] Stopped 2024-04-15T20:20:27.143Z,1713212427.143 [Default:CheckIn:C.Wait] Running Loop=1 2024-04-15T20:20:27.143Z,1713212427.143 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-04-15T20:20:54.265Z,1713212454.265 [NAL9602](INFO): Not Powering down - fast GPS 2024-04-15T20:21:04.953Z,1713212464.953 [DataOverHttps](IMPORTANT): SBD MTMSN=20240415T202105 2024-04-15T20:21:12.464Z,1713212472.464 [DataOverHttps](INFO): Received command: restart app 2024-04-15T20:21:12.525Z,1713212472.525 [CommandExec](IMPORTANT): got command restart application 2024-04-15T20:21:13.528Z,1713212473.528 [Supervisor](INFO): Stop Mission called by Supervisor::terminate 2024-04-15T20:21:13.528Z,1713212473.528 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-15T20:21:13.529Z,1713212473.529 [CommandExec](INFO): Uninitializing the command executive. 2024-04-15T20:21:13.529Z,1713212473.529 [CommandExec](INFO): Uninitializing the command scheduler. 2024-04-15T20:21:13.529Z,1713212473.529 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-04-15T20:21:13.668Z,1713212473.668 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-04-15T20:21:13.668Z,1713212473.668 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-04-15T20:21:13.668Z,1713212473.668 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-04-15T20:21:13.669Z,1713212473.669 [NavChartDb](INFO): Join timeout helper Thread ID is 1136 2024-04-15T20:21:13.864Z,1713212473.864 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-15T20:21:13.864Z,1713212473.864 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-04-15T20:21:13.880Z,1713212473.880 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-04-15T20:21:13.880Z,1713212473.880 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-04-15T20:21:13.880Z,1713212473.880 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1137 2024-04-15T20:21:14.140Z,1713212474.140 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-15T20:21:14.140Z,1713212474.140 [WetLabsBB2FL](INFO): Powering down 2024-04-15T20:21:14.141Z,1713212474.141 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-04-15T20:21:14.144Z,1713212474.144 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2024-04-15T20:21:14.144Z,1713212474.144 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-04-15T20:21:14.144Z,1713212474.144 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1138 2024-04-15T20:21:14.628Z,1713212474.628 [CTD_Seabird](INFO): Powering down 2024-04-15T20:21:14.640Z,1713212474.640 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-15T20:21:14.640Z,1713212474.640 [CTD_Seabird](INFO): Powering down 2024-04-15T20:21:14.652Z,1713212474.652 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-04-15T20:21:14.660Z,1713212474.660 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2024-04-15T20:21:14.660Z,1713212474.660 [DAT ThreadHandler](INFO): Thread cancelled. 2024-04-15T20:21:14.660Z,1713212474.660 [DAT](INFO): Join timeout helper Thread ID is 1139 2024-04-15T20:21:14.805Z,1713212474.805 [DAT](INFO): Powering down 2024-04-15T20:21:14.888Z,1713212474.888 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-15T20:21:14.889Z,1713212474.889 [DAT](INFO): Powering down 2024-04-15T20:21:14.889Z,1713212474.889 [DAT ThreadHandler](INFO): Thread cancelled. 2024-04-15T20:21:14.890Z,1713212474.890 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-04-15T20:21:14.890Z,1713212474.890 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-04-15T20:21:14.890Z,1713212474.890 [Radio_Surface](INFO): Join timeout helper Thread ID is 1140 2024-04-15T20:21:15.060Z,1713212475.060 [Radio_Surface](INFO): Powering down 2024-04-15T20:21:15.061Z,1713212475.061 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-15T20:21:15.061Z,1713212475.061 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-04-15T20:21:15.077Z,1713212475.077 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-04-15T20:21:15.077Z,1713212475.077 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-04-15T20:21:15.077Z,1713212475.077 [Onboard](INFO): Join timeout helper Thread ID is 1141 2024-04-15T20:21:15.472Z,1713212475.472 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2024-04-15T20:21:18.264Z,1713212478.264 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-15T20:21:18.264Z,1713212478.264 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-04-15T20:21:18.275Z,1713212478.275 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-04-15T20:21:18.275Z,1713212478.275 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-04-15T20:21:18.275Z,1713212478.275 [DataOverHttps](INFO): Join timeout helper Thread ID is 1142 2024-04-15T20:21:18.484Z,1713212478.484 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-15T20:21:18.484Z,1713212478.484 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-04-15T20:21:18.497Z,1713212478.497 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2024-04-15T20:21:18.497Z,1713212478.497 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-04-15T20:21:18.497Z,1713212478.497 [BackseatComponent](INFO): Join timeout helper Thread ID is 1143 2024-04-15T20:21:18.608Z,1713212478.608 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-15T20:21:18.608Z,1713212478.608 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-04-15T20:21:18.624Z,1713212478.624 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-04-15T20:21:18.625Z,1713212478.625 [logger ThreadHandler](INFO): Thread cancelled. 2024-04-15T20:21:18.625Z,1713212478.625 [logger](INFO): Join timeout helper Thread ID is 1144 2024-04-15T20:21:18.632Z,1713212478.632 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-15T20:21:18.632Z,1713212478.632 [logger ThreadHandler](INFO): Thread cancelled. 2024-04-15T20:21:18.645Z,1713212478.645 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-04-15T20:21:18.645Z,1713212478.645 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-04-15T20:21:18.645Z,1713212478.645 [CommandLine](INFO): Join timeout helper Thread ID is 1145 2024-04-15T20:21:18.716Z,1713212478.716 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-15T20:21:18.716Z,1713212478.716 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-04-15T20:21:18.724Z,1713212478.724 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-04-15T20:21:18.725Z,1713212478.725 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-04-15T20:21:18.725Z,1713212478.725 [CommandExec](INFO): Join timeout helper Thread ID is 1146 2024-04-15T20:21:18.726Z,1713212478.726 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-04-15T20:21:18.726Z,1713212478.726 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-04-15T20:21:18.727Z,1713212478.727 [controlThread](INFO): Join timeout helper Thread ID is 1147 2024-04-15T20:21:18.888Z,1713212478.888 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-15T20:21:18.888Z,1713212478.888 [controlThread](DEBUG): Uninitializing ControlThread 2024-04-15T20:21:18.889Z,1713212478.889 [AHRS_M2](INFO): Powering down 2024-04-15T20:21:18.961Z,1713212478.961 [NAL9602](INFO): Powering down 2024-04-15T20:21:18.962Z,1713212478.962 [Sonardyne_Nano](INFO): Powering down 2024-04-15T20:21:19.080Z,1713212479.080 [Waterlinked](INFO): Powering down 2024-04-15T20:21:19.083Z,1713212479.083 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-04-15T20:21:19.083Z,1713212479.083 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-04-15T20:21:19.084Z,1713212479.084 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-04-15T20:21:19.085Z,1713212479.085 [MissionManager](INFO): Uninitializing Mission Default 2024-04-15T20:21:19.085Z,1713212479.085 [Default] Stopped 2024-04-15T20:21:19.085Z,1713212479.085 [Default](DEBUG): Aggregate::uninitialize Default 2024-04-15T20:21:19.085Z,1713212479.085 [Default:B.GoToSurface] Stopped 2024-04-15T20:21:19.085Z,1713212479.085 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-04-15T20:21:19.085Z,1713212479.085 [Default:CheckIn] Stopped 2024-04-15T20:21:19.085Z,1713212479.085 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-04-15T20:21:19.086Z,1713212479.086 [Default:CheckIn:C.Wait] Stopped 2024-04-15T20:21:19.086Z,1713212479.086 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-04-15T20:21:19.089Z,1713212479.089 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-04-15T20:21:19.089Z,1713212479.089 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-04-15T20:21:19.089Z,1713212479.089 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-04-15T20:21:19.089Z,1713212479.089 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-04-15T20:21:19.090Z,1713212479.090 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-04-15T20:21:19.090Z,1713212479.090 [BuoyancyServo](INFO): Powering down 2024-04-15T20:21:19.104Z,1713212479.104 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-04-15T20:21:19.104Z,1713212479.104 [ElevatorServo](INFO): Powering down 2024-04-15T20:21:19.105Z,1713212479.105 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-04-15T20:21:19.105Z,1713212479.105 [MassServo](INFO): Powering down 2024-04-15T20:21:19.106Z,1713212479.106 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-04-15T20:21:19.106Z,1713212479.106 [RudderServo](INFO): Powering down 2024-04-15T20:21:19.107Z,1713212479.107 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2024-04-15T20:21:19.107Z,1713212479.107 [ThrusterHE](INFO): Powering down 2024-04-15T20:21:19.108Z,1713212479.108 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-04-15T20:21:19.108Z,1713212479.108 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-04-15T20:21:19.108Z,1713212479.108 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-04-15T20:21:19.109Z,1713212479.109 [CBIT](DEBUG): Powering off loads. 2024-04-15T20:21:19.120Z,1713212479.120 [CBIT](DEBUG): Disabling WDT. 2024-04-15T20:21:19.132Z,1713212479.132 [CBIT](DEBUG): Opening all GF detection circuits. 2024-04-15T20:21:19.133Z,1713212479.133 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-04-15T20:21:19.165Z,1713212479.165 [DAT ThreadHandler](INFO): Thread cancelled. 2024-04-15T20:21:19.171Z,1713212479.171 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-04-15T20:21:19.173Z,1713212479.173 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-04-15T20:21:19.179Z,1713212479.179 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-04-15T20:21:19.222Z,1713212479.222 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-04-15T20:21:19.311Z,1713212479.311 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-04-15T20:21:19.316Z,1713212479.316 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-04-15T20:21:19.324Z,1713212479.324 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-04-15T20:21:19.389Z,1713212479.389 [logger ThreadHandler](INFO): Thread cancelled.