2024-11-05T18:25:15.459Z,1730831115.459 [Supervisor](DEBUG): Initializing supervisor. 2024-11-05T18:25:15.463Z,1730831115.463 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-11-05T18:25:15.464Z,1730831115.464 [SyncHandler](INFO): Protected caller Thread ID is 319 2024-11-05T18:25:15.464Z,1730831115.464 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-11-05T18:25:15.465Z,1730831115.465 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-11-05T18:25:15.465Z,1730831115.465 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 320 2024-11-05T18:25:15.469Z,1730831115.469 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-11-05T18:25:15.486Z,1730831115.486 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-11-05T18:25:15.487Z,1730831115.487 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-11-05T18:25:15.488Z,1730831115.488 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 321 2024-11-05T18:25:15.492Z,1730831115.492 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-11-05T18:25:15.493Z,1730831115.493 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-11-05T18:25:15.493Z,1730831115.493 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 322 2024-11-05T18:25:15.495Z,1730831115.495 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-11-05T18:25:15.496Z,1730831115.496 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-11-05T18:25:15.496Z,1730831115.496 [logger ThreadHandler](INFO): Protected caller Thread ID is 323 2024-11-05T18:25:15.500Z,1730831115.500 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-11-05T18:25:15.500Z,1730831115.500 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-11-05T18:25:15.502Z,1730831115.502 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-11-05T18:25:15.753Z,1730831115.753 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-11-05T18:25:15.754Z,1730831115.754 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-11-05T18:25:15.979Z,1730831115.979 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-11-05T18:25:15.979Z,1730831115.979 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-11-05T18:25:16.086Z,1730831116.086 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-11-05T18:25:16.087Z,1730831116.087 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-11-05T18:25:16.304Z,1730831116.304 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-11-05T18:25:16.304Z,1730831116.304 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-11-05T18:25:16.889Z,1730831116.889 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-11-05T18:25:16.890Z,1730831116.890 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-11-05T18:25:17.009Z,1730831117.009 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-11-05T18:25:17.010Z,1730831117.010 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-11-05T18:25:17.297Z,1730831117.297 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-11-05T18:25:17.298Z,1730831117.298 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-11-05T18:25:17.522Z,1730831117.522 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-11-05T18:25:17.522Z,1730831117.522 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-11-05T18:25:18.078Z,1730831118.078 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-11-05T18:25:18.078Z,1730831118.078 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-11-05T18:25:18.513Z,1730831118.513 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-11-05T18:25:18.513Z,1730831118.513 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-11-05T18:25:18.604Z,1730831118.604 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-11-05T18:25:18.987Z,1730831118.987 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-11-05T18:25:18.988Z,1730831118.988 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-11-05T18:25:19.139Z,1730831119.139 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-11-05T18:25:19.140Z,1730831119.140 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-11-05T18:25:20.017Z,1730831120.017 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-11-05T18:25:20.018Z,1730831120.018 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-11-05T18:25:20.460Z,1730831120.460 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-11-05T18:25:20.461Z,1730831120.461 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-11-05T18:25:20.556Z,1730831120.556 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-aku/ 2024-11-05T18:25:20.557Z,1730831120.557 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/secure.cfg 2024-11-05T18:25:20.652Z,1730831120.652 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/logger.cfg 2024-11-05T18:25:20.770Z,1730831120.770 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/vehicle.cfg 2024-11-05T18:25:20.886Z,1730831120.886 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Navigation.cfg 2024-11-05T18:25:21.004Z,1730831121.004 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/BIT.cfg 2024-11-05T18:25:21.104Z,1730831121.104 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Simulator.cfg 2024-11-05T18:25:21.201Z,1730831121.201 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Servo.cfg 2024-11-05T18:25:21.323Z,1730831121.323 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Science.cfg 2024-11-05T18:25:21.521Z,1730831121.521 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Sensor.cfg 2024-11-05T18:25:21.701Z,1730831121.701 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Control.cfg 2024-11-05T18:25:21.809Z,1730831121.809 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Battery.cfg 2024-11-05T18:25:22.084Z,1730831122.084 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-11-05T18:25:22.085Z,1730831122.085 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-aku/root/ 2024-11-05T18:25:22.086Z,1730831122.086 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2024-11-05T18:25:22.096Z,1730831122.096 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-11-05T18:25:22.453Z,1730831122.453 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-11-05T18:25:22.453Z,1730831122.453 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-11-05T18:25:22.889Z,1730831122.889 [AHRS_M2] Loaded 2024-11-05T18:25:22.889Z,1730831122.889 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2024-11-05T18:25:22.927Z,1730831122.927 [BackseatComponent] Loaded 2024-11-05T18:25:22.928Z,1730831122.928 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2024-11-05T18:25:22.929Z,1730831122.929 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408914E0 2024-11-05T18:25:22.929Z,1730831122.929 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 408 2024-11-05T18:25:22.932Z,1730831122.932 [LcmUniversalReporter] Loaded 2024-11-05T18:25:22.932Z,1730831122.932 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2024-11-05T18:25:23.812Z,1730831123.812 [BPC1] Loaded 2024-11-05T18:25:23.813Z,1730831123.813 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-11-05T18:25:23.904Z,1730831123.904 [DAT] Loaded 2024-11-05T18:25:23.904Z,1730831123.904 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2024-11-05T18:25:23.905Z,1730831123.905 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 408C14E0 2024-11-05T18:25:23.905Z,1730831123.905 [DAT ThreadHandler](INFO): Protected caller Thread ID is 409 2024-11-05T18:25:23.982Z,1730831123.982 [DataOverHttps] Loaded 2024-11-05T18:25:23.982Z,1730831123.982 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-11-05T18:25:23.983Z,1730831123.983 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408F14E0 2024-11-05T18:25:23.983Z,1730831123.983 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 410 2024-11-05T18:25:24.043Z,1730831124.043 [Depth_Keller] Loaded 2024-11-05T18:25:24.043Z,1730831124.043 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-11-05T18:25:24.155Z,1730831124.155 [NAL9602] Loaded 2024-11-05T18:25:24.155Z,1730831124.155 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-11-05T18:25:24.184Z,1730831124.184 [Onboard] Loaded 2024-11-05T18:25:24.184Z,1730831124.184 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-11-05T18:25:24.185Z,1730831124.185 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409214E0 2024-11-05T18:25:24.186Z,1730831124.186 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 411 2024-11-05T18:25:24.200Z,1730831124.200 [Power24vConverter] Loaded 2024-11-05T18:25:24.200Z,1730831124.200 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-11-05T18:25:24.216Z,1730831124.216 [Radio_Surface] Loaded 2024-11-05T18:25:24.216Z,1730831124.216 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-11-05T18:25:24.217Z,1730831124.217 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409514E0 2024-11-05T18:25:24.217Z,1730831124.217 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 412 2024-11-05T18:25:24.232Z,1730831124.232 [Sonardyne_Nano] Loaded 2024-11-05T18:25:24.233Z,1730831124.233 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2024-11-05T18:25:24.233Z,1730831124.233 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-11-05T18:25:24.234Z,1730831124.234 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-11-05T18:25:24.341Z,1730831124.341 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-11-05T18:25:24.342Z,1730831124.342 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-11-05T18:25:24.393Z,1730831124.393 [VerticalControl](DEBUG): Construct VerticalControl. 2024-11-05T18:25:24.452Z,1730831124.452 [VerticalControl] Loaded 2024-11-05T18:25:24.452Z,1730831124.452 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-11-05T18:25:24.455Z,1730831124.455 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-11-05T18:25:24.502Z,1730831124.502 [HorizontalControl] Loaded 2024-11-05T18:25:24.503Z,1730831124.503 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-11-05T18:25:24.505Z,1730831124.505 [SpeedControl](DEBUG): Construct SpeedControl. 2024-11-05T18:25:24.508Z,1730831124.508 [SpeedControl] Loaded 2024-11-05T18:25:24.508Z,1730831124.508 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-11-05T18:25:24.511Z,1730831124.511 [LoopControl](DEBUG): Construct LoopControl. 2024-11-05T18:25:24.511Z,1730831124.511 [LoopControl] Loaded 2024-11-05T18:25:24.512Z,1730831124.512 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-11-05T18:25:24.512Z,1730831124.512 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-11-05T18:25:24.512Z,1730831124.512 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-11-05T18:25:24.523Z,1730831124.523 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-11-05T18:25:24.523Z,1730831124.523 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-11-05T18:25:24.550Z,1730831124.550 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-11-05T18:25:24.551Z,1730831124.551 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-11-05T18:25:24.664Z,1730831124.664 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-11-05T18:25:24.664Z,1730831124.664 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-11-05T18:25:24.706Z,1730831124.706 [DeadReckonUsingSpeedCalculator] Loaded 2024-11-05T18:25:24.706Z,1730831124.706 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2024-11-05T18:25:24.748Z,1730831124.748 [DeadReckonWithRespectToSeafloor] Loaded 2024-11-05T18:25:24.748Z,1730831124.748 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread. 2024-11-05T18:25:24.765Z,1730831124.765 [NavChart] Loaded 2024-11-05T18:25:24.766Z,1730831124.766 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-11-05T18:25:24.771Z,1730831124.771 [UniversalFixResidualReporter] Loaded 2024-11-05T18:25:24.772Z,1730831124.772 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-11-05T18:25:24.772Z,1730831124.772 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-11-05T18:25:24.773Z,1730831124.773 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-11-05T18:25:24.912Z,1730831124.912 [SBIT](DEBUG): Construct Startup Built In Test. 2024-11-05T18:25:24.973Z,1730831124.973 [SBIT] Loaded 2024-11-05T18:25:24.973Z,1730831124.973 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-11-05T18:25:24.996Z,1730831124.996 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-11-05T18:25:25.022Z,1730831125.022 [IBIT] Loaded 2024-11-05T18:25:25.022Z,1730831125.022 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-11-05T18:25:25.028Z,1730831125.028 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-11-05T18:25:25.133Z,1730831125.133 [CBIT] Loaded 2024-11-05T18:25:25.133Z,1730831125.133 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-11-05T18:25:25.133Z,1730831125.133 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-11-05T18:25:25.134Z,1730831125.134 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-11-05T18:25:25.305Z,1730831125.305 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-11-05T18:25:25.305Z,1730831125.305 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-11-05T18:25:25.438Z,1730831125.438 [BuoyancyServo] Loaded 2024-11-05T18:25:25.438Z,1730831125.438 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-11-05T18:25:25.460Z,1730831125.460 [ElevatorServo] Loaded 2024-11-05T18:25:25.461Z,1730831125.461 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-11-05T18:25:25.482Z,1730831125.482 [MassServo] Loaded 2024-11-05T18:25:25.483Z,1730831125.483 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-11-05T18:25:25.504Z,1730831125.504 [RudderServo] Loaded 2024-11-05T18:25:25.505Z,1730831125.505 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-11-05T18:25:25.521Z,1730831125.521 [ThrusterHE] Loaded 2024-11-05T18:25:25.522Z,1730831125.522 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2024-11-05T18:25:25.522Z,1730831125.522 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-11-05T18:25:25.523Z,1730831125.523 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-11-05T18:25:25.696Z,1730831125.696 [CTD_Seabird] Loaded 2024-11-05T18:25:25.697Z,1730831125.697 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2024-11-05T18:25:25.698Z,1730831125.698 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40B7B4E0 2024-11-05T18:25:25.698Z,1730831125.698 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 414 2024-11-05T18:25:25.721Z,1730831125.721 [PAR_Licor] Loaded 2024-11-05T18:25:25.722Z,1730831125.722 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-11-05T18:25:25.766Z,1730831125.766 [WetLabsBB2FL] Loaded 2024-11-05T18:25:25.766Z,1730831125.766 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2024-11-05T18:25:25.767Z,1730831125.767 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40BAB4E0 2024-11-05T18:25:25.768Z,1730831125.768 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 415 2024-11-05T18:25:25.768Z,1730831125.768 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-11-05T18:25:25.769Z,1730831125.769 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-11-05T18:25:25.819Z,1730831125.819 [DepthRateCalculator] Loaded 2024-11-05T18:25:25.819Z,1730831125.819 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-11-05T18:25:25.824Z,1730831125.824 [PitchRateCalculator] Loaded 2024-11-05T18:25:25.824Z,1730831125.824 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-11-05T18:25:25.833Z,1730831125.833 [SpeedCalculator] Loaded 2024-11-05T18:25:25.833Z,1730831125.833 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-11-05T18:25:25.837Z,1730831125.837 [YawRateCalculator] Loaded 2024-11-05T18:25:25.838Z,1730831125.838 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-11-05T18:25:25.874Z,1730831125.874 [ElevatorOffsetCalculator] Loaded 2024-11-05T18:25:25.874Z,1730831125.874 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-11-05T18:25:25.875Z,1730831125.875 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-11-05T18:25:25.875Z,1730831125.875 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-11-05T18:25:25.931Z,1730831125.931 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-11-05T18:25:25.937Z,1730831125.937 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-11-05T18:25:25.940Z,1730831125.940 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-11-05T18:25:25.951Z,1730831125.951 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-11-05T18:25:25.952Z,1730831125.952 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C374E0 2024-11-05T18:25:25.952Z,1730831125.952 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 416 2024-11-05T18:25:25.957Z,1730831125.957 [Supervisor](INFO): Main Thread ID is 318 2024-11-05T18:25:25.957Z,1730831125.957 [Supervisor](DEBUG): Running supervisor. 2024-11-05T18:25:25.958Z,1730831125.958 [CommandExec ThreadHandler](INFO): Handler Thread ID is 417 2024-11-05T18:25:25.958Z,1730831125.958 [CommandExec](INFO): Initializing the command executive. 2024-11-05T18:25:25.960Z,1730831125.960 [CommandLine ThreadHandler](INFO): Handler Thread ID is 418 2024-11-05T18:25:25.962Z,1730831125.962 [controlThread ThreadHandler](INFO): Handler Thread ID is 419 2024-11-05T18:25:25.962Z,1730831125.962 [controlThread](DEBUG): Initializing ControlThread 2024-11-05T18:25:25.968Z,1730831125.968 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-11-05T18:25:25.969Z,1730831125.969 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-11-05T18:25:25.970Z,1730831125.970 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-11-05T18:25:25.971Z,1730831125.971 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-11-05T18:25:25.972Z,1730831125.972 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-11-05T18:25:25.972Z,1730831125.972 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-11-05T18:25:25.973Z,1730831125.973 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-11-05T18:25:25.973Z,1730831125.973 [SBIT](INFO): Initialize SBIT Component. 2024-11-05T18:25:25.973Z,1730831125.973 [SBIT](IMPORTANT): git: 2024-10-30 2024-11-05T18:25:25.973Z,1730831125.973 [SBIT](INFO): git hash: c4b9a7fa8cf6bf84d0dff31525ea982806c2df17 2024-11-05T18:25:25.974Z,1730831125.974 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-11-05T18:25:25.975Z,1730831125.975 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2024-11-05T18:25:25.976Z,1730831125.976 [SBIT](INFO): Beginning SBIT in 63.000000 seconds. 2024-11-05T18:25:25.977Z,1730831125.977 [IBIT](INFO): Initialize IBIT Component. 2024-11-05T18:25:25.978Z,1730831125.978 [CBIT](DEBUG): Initialize CBIT Component. 2024-11-05T18:25:25.979Z,1730831125.979 [logger ThreadHandler](INFO): Handler Thread ID is 420 2024-11-05T18:25:25.991Z,1730831125.991 [CBIT](DEBUG): Initialized mux pins. 2024-11-05T18:25:25.991Z,1730831125.991 [CBIT](DEBUG): Initializing the watchdog timer. 2024-11-05T18:25:25.999Z,1730831125.999 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 421 2024-11-05T18:25:26.011Z,1730831126.011 [DAT ThreadHandler](INFO): Handler Thread ID is 422 2024-11-05T18:25:26.012Z,1730831126.012 [DAT](INFO): Powering up 2024-11-05T18:25:26.012Z,1730831126.012 [DAT](DEBUG): Initializing DAT. 2024-11-05T18:25:26.015Z,1730831126.015 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-11-05T18:25:26.015Z,1730831126.015 [CBIT](DEBUG): Initializing heartbeat. 2024-11-05T18:25:26.023Z,1730831126.023 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 424 2024-11-05T18:25:26.025Z,1730831126.025 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-11-05T18:25:26.039Z,1730831126.039 [Onboard ThreadHandler](INFO): Handler Thread ID is 425 2024-11-05T18:25:26.056Z,1730831126.056 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 426 2024-11-05T18:25:26.075Z,1730831126.075 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 427 2024-11-05T18:25:26.076Z,1730831126.076 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-11-05T18:25:26.080Z,1730831126.080 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 429 2024-11-05T18:25:26.083Z,1730831126.083 [WetLabsBB2FL](INFO): Powering up 2024-11-05T18:25:26.084Z,1730831126.084 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 431 2024-11-05T18:25:26.087Z,1730831126.087 [CBIT](DEBUG): Deactivating GF circuits. 2024-11-05T18:25:26.087Z,1730831126.087 [CBIT](DEBUG): Deactivating emergency mode. 2024-11-05T18:25:26.088Z,1730831126.088 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2HA05M.000 2024-11-05T18:25:26.088Z,1730831126.088 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2HA05M.000 2024-11-05T18:25:26.088Z,1730831126.088 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3HA20M.000 2024-11-05T18:25:26.088Z,1730831126.088 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3HA20M.000 2024-11-05T18:25:26.088Z,1730831126.088 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000 2024-11-05T18:25:26.088Z,1730831126.088 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4HA51M.000 2024-11-05T18:25:26.089Z,1730831126.089 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000 2024-11-05T18:25:26.089Z,1730831126.089 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4HA51M.000 2024-11-05T18:25:26.089Z,1730831126.089 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA53M.000 2024-11-05T18:25:26.089Z,1730831126.089 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5HA53M.000 2024-11-05T18:25:26.089Z,1730831126.089 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA55M.000 2024-11-05T18:25:26.089Z,1730831126.089 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5HA55M.000 2024-11-05T18:25:26.127Z,1730831126.127 [CBIT](DEBUG): Backplane powered. 2024-11-05T18:25:26.131Z,1730831126.131 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-11-05T18:25:26.131Z,1730831126.131 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-11-05T18:25:26.132Z,1730831126.132 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-11-05T18:25:26.132Z,1730831126.132 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-11-05T18:25:26.133Z,1730831126.133 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-11-05T18:25:26.134Z,1730831126.134 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2024-11-05T18:25:26.134Z,1730831126.134 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2024-11-05T18:25:26.135Z,1730831126.135 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2024-11-05T18:25:26.136Z,1730831126.136 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2024-11-05T18:25:26.193Z,1730831126.193 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2024-11-05T18:25:26.197Z,1730831126.197 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-11-05T18:25:26.222Z,1730831126.222 [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-11-05T18:25:26.223Z,1730831126.223 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2024-11-05T18:25:26.223Z,1730831126.223 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2024-11-05T18:25:26.224Z,1730831126.224 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2024-11-05T18:25:26.436Z,1730831126.436 [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-11-05T18:25:26.459Z,1730831126.459 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2024-11-05T18:25:26.460Z,1730831126.460 [Default:A.Wait](DEBUG): Construct Wait. 2024-11-05T18:25:26.462Z,1730831126.462 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2024-11-05T18:25:26.463Z,1730831126.463 [Radio_Surface](INFO): Powering up 2024-11-05T18:25:26.484Z,1730831126.484 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-11-05T18:25:26.486Z,1730831126.486 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-11-05T18:25:26.504Z,1730831126.504 [Default:E.Execute](DEBUG): Construct Execute. 2024-11-05T18:25:26.507Z,1730831126.507 [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-11-05T18:25:26.511Z,1730831126.511 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,NAL9602,Power24vConverter,Sonardyne_Nano,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-11-05T18:25:26.522Z,1730831126.522 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-11-05T18:25:26.578Z,1730831126.578 [Power24vConverter](INFO): Powering up. 2024-11-05T18:25:26.580Z,1730831126.580 [Sonardyne_Nano](INFO): Initializing. 2024-11-05T18:25:26.636Z,1730831126.636 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-11-05T18:25:26.643Z,1730831126.643 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-11-05T18:25:26.644Z,1730831126.644 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-11-05T18:25:26.651Z,1730831126.651 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-11-05T18:25:26.652Z,1730831126.652 [MassServo](DEBUG): Initializing EZServoServo. 2024-11-05T18:25:26.667Z,1730831126.667 [MassServo](DEBUG): Initializing MassServo. 2024-11-05T18:25:26.668Z,1730831126.668 [RudderServo](DEBUG): Initializing EZServoServo. 2024-11-05T18:25:26.675Z,1730831126.675 [RudderServo](DEBUG): Initializing RudderServo. 2024-11-05T18:25:26.676Z,1730831126.676 [ThrusterHE](DEBUG): Initializing EZServoServo. 2024-11-05T18:25:26.683Z,1730831126.683 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2024-11-05T18:25:28.191Z,1730831128.191 [WetLabsBB2FL](INFO): Powering down 2024-11-05T18:25:28.541Z,1730831128.541 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2024-11-05T18:25:29.831Z,1730831129.831 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2409 2024-11-05T18:25:32.424Z,1730831132.424 [ThrusterHE](ERROR): Zero Speed Commanded. 2024-11-05T18:25:33.108Z,1730831133.108 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit. 2024-11-05T18:25:36.878Z,1730831136.878 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005281 2024-11-05T18:25:37.860Z,1730831137.860 [DAT](INFO): DAT read: 2024-11-05T18:25:37.861Z,1730831137.861 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2024-11-05T18:25:39.372Z,1730831139.372 [DAT](INFO): DAT read: MF Frequency Band 2024-11-05T18:25:39.373Z,1730831139.373 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2024-11-05T18:25:39.373Z,1730831139.373 [DAT](INFO): DAT read: Nov 5 2024 02:21:03 2024-11-05T18:25:40.380Z,1730831140.380 [DAT](INFO): DAT read: Features enabled [Bearing] 2024-11-05T18:25:40.381Z,1730831140.381 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2024-11-05T18:25:40.381Z,1730831140.381 [DAT](INFO): commRate: 800 2024-11-05T18:25:42.451Z,1730831142.451 [DAT](INFO): entering command mode 2024-11-05T18:25:42.651Z,1730831142.651 [DAT](INFO): DAT read: 2024-11-05T18:25:42.652Z,1730831142.652 [DAT](INFO): DAT read: user:1> 2024-11-05T18:25:42.652Z,1730831142.652 [DAT](INFO): setting verbose to 3 2024-11-05T18:25:42.904Z,1730831142.904 [DAT](INFO): DAT read: user:1> 2024-11-05T18:25:42.905Z,1730831142.905 [DAT](INFO): DAT read: Verbose | 3 2024-11-05T18:25:42.905Z,1730831142.905 [DAT](INFO): set verbose to 3 2024-11-05T18:25:42.905Z,1730831142.905 [DAT](INFO): setting DatVerbose to 27440 2024-11-05T18:25:43.156Z,1730831143.156 [DAT](INFO): DAT read: user:2> 2024-11-05T18:25:43.157Z,1730831143.157 [DAT](INFO): DAT read: DatVerbose | 27440 2024-11-05T18:25:43.157Z,1730831143.157 [DAT](INFO): set DatVerbose to 27440 2024-11-05T18:25:43.157Z,1730831143.157 [DAT](INFO): setting transmit power to 8 2024-11-05T18:25:43.409Z,1730831143.409 [DAT](INFO): DAT read: user:3> 2024-11-05T18:25:43.410Z,1730831143.410 [DAT](INFO): DAT read: TxPower | 8 (Max) 2024-11-05T18:25:43.410Z,1730831143.410 [DAT](INFO): set transmit power to 8 2024-11-05T18:25:43.411Z,1730831143.411 [DAT](INFO): setting local address to 2 2024-11-05T18:25:43.659Z,1730831143.659 [DAT](INFO): DAT read: user:4> 2024-11-05T18:25:43.660Z,1730831143.660 [DAT](INFO): DAT read: LocalAddr | 2 2024-11-05T18:25:43.661Z,1730831143.661 [DAT](INFO): set local address to 2 2024-11-05T18:25:43.662Z,1730831143.662 [DAT](INFO): Setting time to: 18:25:43 And date to:11/5/2024 2024-11-05T18:25:43.911Z,1730831143.911 [DAT](INFO): DAT read: user:5> 2024-11-05T18:25:43.912Z,1730831143.912 [DAT](INFO): DAT read: Tue Nov 5, 2024 18:25:43 2024-11-05T18:25:43.913Z,1730831143.913 [DAT](INFO): Local DAT time set to Tue Nov 5, 2024 18:25:43 2024-11-05T18:25:54.400Z,1730831154.400 [NAL9602](INFO): Powering up NAL9602 2024-11-05T18:26:05.312Z,1730831165.312 [NAL9602](INFO): NAL9602 initialized 2024-11-05T18:26:23.844Z,1730831183.844 [CommandExec](IMPORTANT): got command strobe off 2024-11-05T18:26:23.844Z,1730831183.844 [CommandExec](IMPORTANT): Deactivating strobe 2024-11-05T18:26:29.598Z,1730831189.598 [SBIT](IMPORTANT): Beginning Startup BIT 2024-11-05T18:26:29.611Z,1730831189.611 [CBIT](IMPORTANT): Beginning ground fault scan 2024-11-05T18:26:34.809Z,1730831194.809 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-11-05T18:26:40.603Z,1730831200.603 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.007883 CHAN A1 (24V): 0.004355 CHAN A2 (12V): -0.001344 CHAN A3 (5V): -0.004702 CHAN B0 (3.3V): -0.007232 CHAN B1 (3.15aV): -0.004454 CHAN B2 (3.15bV): -0.003353 CHAN B3 (GND): -0.003806 OPEN: 0.005367 Full Scale: +/- 1 mA 2024-11-05T18:26:41.730Z,1730831201.730 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-11-05T18:26:53.380Z,1730831213.380 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-11-05T18:26:54.254Z,1730831214.254 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-11-05T18:27:09.633Z,1730831229.633 [SBIT](FAULT): Rudder: EXPECTED:-15.000000 ACTUAL:-14.651782 2024-11-05T18:27:09.633Z,1730831229.633 [SBIT](FAULT): Control surface position failure. 2024-11-05T18:27:11.964Z,1730831231.964 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-11-05T18:27:23.702Z,1730831243.702 [SBIT](CRITICAL): SBIT FAILED 2024-11-05T18:27:23.719Z,1730831243.719 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2024-11-05T18:27:23.720Z,1730831243.720 [SBIT](IMPORTANT): CBIT.gf24Offset=162 microampere; 2024-11-05T18:27:23.720Z,1730831243.720 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool; 2024-11-05T18:27:23.720Z,1730831243.720 [SBIT](IMPORTANT): Express linearApproximation height_above_sea_floor 5.000000 meter; 2024-11-05T18:27:23.720Z,1730831243.720 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=267.110907 cubic_centimeter; 2024-11-05T18:27:23.720Z,1730831243.720 [SBIT](IMPORTANT): VerticalControl.kdPitchMass=1.25 second; 2024-11-05T18:27:23.720Z,1730831243.720 [SBIT](IMPORTANT): VerticalControl.kiPitchMass=1.25 reciprocal_second; 2024-11-05T18:27:23.720Z,1730831243.720 [SBIT](IMPORTANT): VerticalControl.kpPitchMass=1.25 none; 2024-11-05T18:27:23.720Z,1730831243.720 [SBIT](IMPORTANT): VerticalControl.massDeadband=0.05 centimeter; 2024-11-05T18:27:23.721Z,1730831243.721 [SBIT](IMPORTANT): VerticalControl.massDefault=10.867964 millimeter; 2024-11-05T18:27:23.721Z,1730831243.721 [SBIT](IMPORTANT): VerticalControl.massOnlyForceInt=0 bool; 2024-11-05T18:27:23.722Z,1730831243.722 [CommandExec](FAULT): Scheduling is paused 2024-11-05T18:27:23.723Z,1730831243.723 [CBIT](INFO): Critical error at 20241105T182723 2024-11-05T18:27:23.724Z,1730831243.724 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2024-11-05T18:27:24.158Z,1730831244.158 [MissionManager](IMPORTANT): Started mission Startup 2024-11-05T18:27:24.159Z,1730831244.159 [Startup] Running Loop=1 2024-11-05T18:27:24.159Z,1730831244.159 [Startup](DEBUG): Aggregate::initialize Startup 2024-11-05T18:27:24.159Z,1730831244.159 [Startup:A.GoToSurface] Running Loop=1 2024-11-05T18:27:24.159Z,1730831244.159 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-11-05T18:27:24.160Z,1730831244.160 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-11-05T18:27:24.160Z,1730831244.160 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-11-05T18:27:24.160Z,1730831244.160 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-11-05T18:27:24.161Z,1730831244.161 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-11-05T18:27:24.161Z,1730831244.161 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2024-11-05T18:27:24.161Z,1730831244.161 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-11-05T18:27:24.163Z,1730831244.163 [Startup:StartupSatComms] Running Loop=1 2024-11-05T18:27:24.163Z,1730831244.163 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2024-11-05T18:27:24.163Z,1730831244.163 [Startup:StartupSatComms:A] Running Loop=1 2024-11-05T18:27:24.537Z,1730831244.537 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2024-11-05T18:27:30.952Z,1730831250.952 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-11-05T18:27:49.939Z,1730831269.939 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-11-05T18:27:54.449Z,1730831274.449 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-11-05T18:28:06.964Z,1730831286.964 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-11-05T18:28:08.121Z,1730831288.121 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-11-05T18:28:24.309Z,1730831304.309 [Startup:StartupSatComms:A](INFO): Timed out from 2024-11-05T18:27:24.2Z 2024-11-05T18:28:24.309Z,1730831304.309 [Startup:StartupSatComms:A] Stopped 2024-11-05T18:28:24.309Z,1730831304.309 [Startup:StartupSatComms:B] Running Loop=1 2024-11-05T18:28:24.723Z,1730831304.723 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-11-05T18:28:26.360Z,1730831306.360 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2024-11-05T18:28:26.360Z,1730831306.360 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-11-05T18:28:26.361Z,1730831306.361 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1 2024-11-05T18:28:26.361Z,1730831306.361 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-11-05T18:28:26.362Z,1730831306.362 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-11-05T18:28:26.362Z,1730831306.362 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-11-05T18:28:26.398Z,1730831306.398 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-11-05T18:28:26.398Z,1730831306.398 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-11-05T18:28:26.398Z,1730831306.398 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-11-05T18:28:26.704Z,1730831306.704 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-11-05T18:28:26.729Z,1730831306.729 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-11-05T18:28:26.729Z,1730831306.729 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2024-11-05T18:28:26.730Z,1730831306.730 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-11-05T18:28:26.730Z,1730831306.730 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1 2024-11-05T18:28:26.730Z,1730831306.730 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-11-05T18:28:26.730Z,1730831306.730 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-11-05T18:28:27.134Z,1730831307.134 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-11-05T18:28:31.583Z,1730831311.583 [DataOverHttps](INFO): Sending 105 bytes from file Logs/20241105T020256/Courier0003.lzma 2024-11-05T18:28:32.585Z,1730831312.585 [DataOverHttps](INFO): Moved sent file to Logs/20241105T020256/Courier0003.lzma.bak 2024-11-05T18:28:32.585Z,1730831312.585 [DataOverHttps](INFO): SBD MOMSN=23372002 2024-11-05T18:28:48.567Z,1730831328.567 [DataOverHttps](INFO): Sending 185 bytes from file Logs/20241105T182515/Courier0000.lzma 2024-11-05T18:28:49.568Z,1730831329.568 [DataOverHttps](INFO): Moved sent file to Logs/20241105T182515/Courier0000.lzma.bak 2024-11-05T18:28:49.569Z,1730831329.569 [DataOverHttps](INFO): SBD MOMSN=23372005 2024-11-05T18:29:05.228Z,1730831345.228 [DataOverHttps](INFO): Sending 545 bytes from file Logs/20241105T020256/Express0004.lzma 2024-11-05T18:29:06.229Z,1730831346.229 [DataOverHttps](INFO): Moved sent file to Logs/20241105T020256/Express0004.lzma.bak 2024-11-05T18:29:06.229Z,1730831346.229 [DataOverHttps](INFO): SBD MOMSN=23372009 2024-11-05T18:29:21.777Z,1730831361.777 [DataOverHttps](INFO): Sending 1021 bytes from file Logs/20241105T182515/Express0001.lzma 2024-11-05T18:29:22.776Z,1730831362.776 [DataOverHttps](INFO): Moved sent file to Logs/20241105T182515/Express0001.lzma.bak 2024-11-05T18:29:22.777Z,1730831362.777 [DataOverHttps](INFO): SBD MOMSN=23372033 2024-11-05T18:29:24.106Z,1730831364.106 [Startup:StartupSatComms:B] Stopped 2024-11-05T18:29:24.106Z,1730831364.106 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2024-11-05T18:29:24.106Z,1730831364.106 [Startup:StartupSatComms] Stopped 2024-11-05T18:29:24.106Z,1730831364.106 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2024-11-05T18:29:24.127Z,1730831364.127 [Startup](INFO): Completed Startup 2024-11-05T18:29:24.127Z,1730831364.127 [MissionManager](INFO): Startup is completed. 2024-11-05T18:29:24.127Z,1730831364.127 [MissionManager](INFO): Uninitializing Mission Startup 2024-11-05T18:29:24.128Z,1730831364.128 [Startup] Stopped 2024-11-05T18:29:24.128Z,1730831364.128 [Startup](DEBUG): Aggregate::uninitialize Startup 2024-11-05T18:29:24.128Z,1730831364.128 [Startup:A.GoToSurface] Stopped 2024-11-05T18:29:24.128Z,1730831364.128 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-11-05T18:29:24.509Z,1730831364.509 [MissionManager](IMPORTANT): Started mission Default 2024-11-05T18:29:24.509Z,1730831364.509 [Default] Running Loop=1 2024-11-05T18:29:24.510Z,1730831364.510 [Default](DEBUG): Aggregate::initialize Default 2024-11-05T18:29:24.510Z,1730831364.510 [Default:B.GoToSurface] Running Loop=1 2024-11-05T18:29:24.510Z,1730831364.510 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-11-05T18:29:24.510Z,1730831364.510 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-11-05T18:29:24.510Z,1730831364.510 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-11-05T18:29:24.511Z,1730831364.511 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-11-05T18:29:24.511Z,1730831364.511 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-11-05T18:29:24.511Z,1730831364.511 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2024-11-05T18:29:24.512Z,1730831364.512 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-11-05T18:29:24.512Z,1730831364.512 [Default:A.Wait] Running Loop=1 2024-11-05T18:29:24.512Z,1730831364.512 [Default:A.Wait](DEBUG): Initialize Wait Component. 2024-11-05T18:29:37.843Z,1730831377.843 [Default:A.Wait](INFO): Done Waiting. 2024-11-05T18:29:37.843Z,1730831377.843 [Default:A.Wait] Stopped 2024-11-05T18:29:37.843Z,1730831377.843 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2024-11-05T18:29:38.278Z,1730831378.278 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-11-05T18:29:38.314Z,1730831378.314 [Default:CheckIn] Running Loop=1 2024-11-05T18:29:38.314Z,1730831378.314 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-11-05T18:29:38.314Z,1730831378.314 [Default:CheckIn:Read_GPS] Running Loop=1 2024-11-05T18:29:38.673Z,1730831378.673 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2024-11-05T18:30:12.608Z,1730831412.608 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-11-05T18:31:04.720Z,1730831464.720 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-11-05T18:31:08.317Z,1730831468.317 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-11-05T18:31:27.471Z,1730831487.471 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2024-11-05T18:31:27.471Z,1730831487.471 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-11-05T18:31:27.472Z,1730831487.472 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2 2024-11-05T18:31:27.472Z,1730831487.472 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-11-05T18:31:27.474Z,1730831487.474 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-11-05T18:31:27.474Z,1730831487.474 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-11-05T18:31:27.533Z,1730831487.533 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-11-05T18:31:27.534Z,1730831487.534 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-11-05T18:31:27.534Z,1730831487.534 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-11-05T18:31:27.747Z,1730831487.747 [BPC1](ERROR): BPC1A: No match for serial number 0000 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file). 2024-11-05T18:31:27.822Z,1730831487.822 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-11-05T18:31:27.822Z,1730831487.822 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2024-11-05T18:31:27.843Z,1730831487.843 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-11-05T18:31:27.843Z,1730831487.843 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2 2024-11-05T18:31:27.844Z,1730831487.844 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-11-05T18:31:27.844Z,1730831487.844 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-11-05T18:31:28.263Z,1730831488.263 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-11-05T18:31:28.288Z,1730831488.288 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-11-05T18:32:17.481Z,1730831537.481 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-11-05T18:33:05.957Z,1730831585.957 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-11-05T18:33:17.270Z,1730831597.270 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-11-05T18:33:35.399Z,1730831615.399 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7). 2024-11-05T18:33:35.406Z,1730831615.406 [BPC1](ERROR): Battery stick #62 (s/n: 00CC) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0. 2024-11-05T18:33:35.406Z,1730831615.406 [BPC1](INFO): Calculating totals. Valid battery stick count: 52. Valid reserve battery stick count: 5. 2024-11-05T18:33:35.409Z,1730831615.409 [BPC1](INFO): Received data from all battery sticks. 2024-11-05T18:34:28.338Z,1730831668.338 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2024-11-05T18:34:28.338Z,1730831668.338 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-11-05T18:34:28.340Z,1730831668.340 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3 2024-11-05T18:34:28.340Z,1730831668.340 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-11-05T18:34:28.341Z,1730831668.341 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 3 2024-11-05T18:34:28.341Z,1730831668.341 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-11-05T18:34:28.352Z,1730831668.352 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-11-05T18:34:28.352Z,1730831668.352 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-11-05T18:34:28.352Z,1730831668.352 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-11-05T18:34:28.774Z,1730831668.774 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-11-05T18:34:28.774Z,1730831668.774 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2024-11-05T18:34:28.774Z,1730831668.774 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-11-05T18:34:28.775Z,1730831668.775 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3 2024-11-05T18:34:28.775Z,1730831668.775 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-11-05T18:34:28.775Z,1730831668.775 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 3 2024-11-05T18:34:29.168Z,1730831669.168 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-11-05T18:34:38.458Z,1730831678.458 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-11-05T18:29:38.3Z 2024-11-05T18:34:38.459Z,1730831678.459 [Default:CheckIn:Read_GPS] Stopped 2024-11-05T18:34:38.459Z,1730831678.459 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-11-05T18:34:38.863Z,1730831678.863 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-11-05T18:34:45.287Z,1730831685.287 [DataOverHttps](INFO): Sending 169 bytes from file Logs/20241105T182515/Courier0004.lzma 2024-11-05T18:34:46.289Z,1730831686.289 [DataOverHttps](INFO): Moved sent file to Logs/20241105T182515/Courier0004.lzma.bak 2024-11-05T18:34:46.289Z,1730831686.289 [DataOverHttps](INFO): SBD MOMSN=23372069 2024-11-05T18:35:01.863Z,1730831701.863 [DataOverHttps](INFO): Sending 186 bytes from file Logs/20241105T182515/Express0005.lzma 2024-11-05T18:35:02.864Z,1730831702.865 [DataOverHttps](INFO): Moved sent file to Logs/20241105T182515/Express0005.lzma.bak 2024-11-05T18:35:02.865Z,1730831702.865 [DataOverHttps](INFO): SBD MOMSN=23372071 2024-11-05T18:35:04.309Z,1730831704.309 [Default:CheckIn:Read_Iridium] Stopped 2024-11-05T18:35:04.309Z,1730831704.309 [Default:CheckIn:C.Wait] Running Loop=1 2024-11-05T18:35:04.309Z,1730831704.309 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-11-05T18:36:06.509Z,1730831766.509 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-11-05T18:36:06.509Z,1730831766.509 [NAL9602] Data Fault, FailCount= 1 2024-11-05T18:36:06.509Z,1730831766.509 [NAL9602](ERROR): Data Fault 2024-11-05T18:36:06.550Z,1730831766.550 [CBIT](ERROR): Data Fault in component: NAL9602 2024-11-05T18:36:06.916Z,1730831766.916 [NAL9602](INFO): Powering down 2024-11-05T18:36:07.764Z,1730831767.764 [CBIT](INFO): Clearing failed state for component NAL9602 2024-11-05T18:36:07.764Z,1730831767.764 [NAL9602] No Fault, FailCount= 1 2024-11-05T18:36:37.208Z,1730831797.208 [NAL9602](INFO): Powering up NAL9602 2024-11-05T18:36:48.120Z,1730831808.120 [NAL9602](INFO): NAL9602 initialized 2024-11-05T18:37:29.349Z,1730831849.349 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2024-11-05T18:37:29.349Z,1730831849.349 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-11-05T18:37:29.351Z,1730831849.351 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4 2024-11-05T18:37:29.351Z,1730831849.351 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-11-05T18:37:29.352Z,1730831849.352 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 4 2024-11-05T18:37:29.352Z,1730831849.352 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-11-05T18:37:29.398Z,1730831849.398 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-11-05T18:37:29.399Z,1730831849.399 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-11-05T18:37:29.399Z,1730831849.399 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-11-05T18:37:29.770Z,1730831849.770 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-11-05T18:37:29.770Z,1730831849.770 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2024-11-05T18:37:29.770Z,1730831849.770 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-11-05T18:37:29.770Z,1730831849.770 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4 2024-11-05T18:37:29.771Z,1730831849.771 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-11-05T18:37:29.771Z,1730831849.771 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 4 2024-11-05T18:37:30.153Z,1730831850.153 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-11-05T18:40:04.881Z,1730832004.881 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-11-05T18:40:04.881Z,1730832004.881 [Default:CheckIn:C.Wait] Stopped 2024-11-05T18:40:04.881Z,1730832004.881 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-11-05T18:40:04.881Z,1730832004.881 [Default:CheckIn:D] Running Loop=1 2024-11-05T18:40:05.289Z,1730832005.289 [Default:CheckIn:D] Stopped 2024-11-05T18:40:05.289Z,1730832005.289 [Default:CheckIn:E] Running Loop=1 2024-11-05T18:40:05.686Z,1730832005.686 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.679658 min 2024-11-05T18:40:05.686Z,1730832005.686 [Default:CheckIn:E] Stopped 2024-11-05T18:40:05.686Z,1730832005.686 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-11-05T18:40:05.686Z,1730832005.686 [Default:CheckIn] Stopped 2024-11-05T18:40:05.686Z,1730832005.686 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-11-05T18:40:05.687Z,1730832005.687 [Default:CheckIn](INFO): Running loop #2 2024-11-05T18:40:05.687Z,1730832005.687 [Default:CheckIn] Running Loop=2 2024-11-05T18:40:05.687Z,1730832005.687 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-11-05T18:40:05.687Z,1730832005.687 [Default:CheckIn:Read_GPS] Running Loop=1 2024-11-05T18:40:30.348Z,1730832030.348 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2024-11-05T18:40:30.348Z,1730832030.348 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-11-05T18:40:30.349Z,1730832030.349 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 5 2024-11-05T18:40:30.349Z,1730832030.349 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-11-05T18:40:30.350Z,1730832030.350 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 5 2024-11-05T18:40:30.350Z,1730832030.350 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-11-05T18:40:30.392Z,1730832030.392 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-11-05T18:40:30.392Z,1730832030.392 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-11-05T18:40:30.392Z,1730832030.392 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-11-05T18:40:30.761Z,1730832030.761 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-11-05T18:40:30.762Z,1730832030.762 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2024-11-05T18:40:30.762Z,1730832030.762 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-11-05T18:40:30.762Z,1730832030.762 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 5 2024-11-05T18:40:30.763Z,1730832030.763 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-11-05T18:40:30.763Z,1730832030.763 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 5 2024-11-05T18:40:31.148Z,1730832031.148 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-11-05T18:43:31.343Z,1730832211.343 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2024-11-05T18:43:31.343Z,1730832211.343 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-11-05T18:43:31.344Z,1730832211.344 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 6 2024-11-05T18:43:31.344Z,1730832211.344 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-11-05T18:43:31.345Z,1730832211.345 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 6 2024-11-05T18:43:31.346Z,1730832211.346 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-11-05T18:43:31.356Z,1730832211.356 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-11-05T18:43:31.357Z,1730832211.357 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-11-05T18:43:31.357Z,1730832211.357 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-11-05T18:43:31.764Z,1730832211.764 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-11-05T18:43:31.764Z,1730832211.764 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2024-11-05T18:43:31.764Z,1730832211.764 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-11-05T18:43:31.764Z,1730832211.764 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 6 2024-11-05T18:43:31.765Z,1730832211.765 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-11-05T18:43:31.765Z,1730832211.765 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 6 2024-11-05T18:43:32.148Z,1730832212.148 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-11-05T18:45:05.869Z,1730832305.869 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-11-05T18:40:05.7Z 2024-11-05T18:45:05.869Z,1730832305.869 [Default:CheckIn:Read_GPS] Stopped 2024-11-05T18:45:05.869Z,1730832305.869 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-11-05T18:45:12.718Z,1730832312.718 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20241105T182515/Courier0007.lzma 2024-11-05T18:45:13.725Z,1730832313.725 [DataOverHttps](INFO): Moved sent file to Logs/20241105T182515/Courier0007.lzma.bak 2024-11-05T18:45:13.725Z,1730832313.725 [DataOverHttps](INFO): SBD MOMSN=23372200 2024-11-05T18:45:29.563Z,1730832329.563 [DataOverHttps](INFO): Sending 183 bytes from file Logs/20241105T182515/Express0008.lzma 2024-11-05T18:45:30.564Z,1730832330.564 [DataOverHttps](INFO): Moved sent file to Logs/20241105T182515/Express0008.lzma.bak 2024-11-05T18:45:30.565Z,1730832330.565 [DataOverHttps](INFO): SBD MOMSN=23372202 2024-11-05T18:45:31.746Z,1730832331.746 [Default:CheckIn:Read_Iridium] Stopped 2024-11-05T18:45:31.746Z,1730832331.746 [Default:CheckIn:C.Wait] Running Loop=1 2024-11-05T18:45:31.746Z,1730832331.746 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-11-05T18:46:32.319Z,1730832392.319 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7 2024-11-05T18:46:32.319Z,1730832392.319 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-11-05T18:46:32.320Z,1730832392.320 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 7 2024-11-05T18:46:32.320Z,1730832392.320 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-11-05T18:46:32.321Z,1730832392.321 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 7 2024-11-05T18:46:32.321Z,1730832392.321 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-11-05T18:46:32.332Z,1730832392.332 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-11-05T18:46:32.332Z,1730832392.332 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-11-05T18:46:32.333Z,1730832392.333 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-11-05T18:46:32.742Z,1730832392.742 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-11-05T18:46:32.742Z,1730832392.742 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7 2024-11-05T18:46:32.742Z,1730832392.742 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-11-05T18:46:32.743Z,1730832392.743 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 7 2024-11-05T18:46:32.743Z,1730832392.743 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-11-05T18:46:32.743Z,1730832392.743 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 7 2024-11-05T18:46:33.119Z,1730832393.119 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-11-05T18:46:50.484Z,1730832410.484 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-11-05T18:46:50.484Z,1730832410.484 [NAL9602] Data Fault, FailCount= 2 2024-11-05T18:46:50.484Z,1730832410.484 [NAL9602](ERROR): Data Fault 2024-11-05T18:46:50.503Z,1730832410.503 [CBIT](ERROR): Data Fault in component: NAL9602 2024-11-05T18:46:50.893Z,1730832410.893 [NAL9602](INFO): Powering down 2024-11-05T18:46:51.714Z,1730832411.714 [CBIT](INFO): Clearing failed state for component NAL9602 2024-11-05T18:46:51.714Z,1730832411.714 [NAL9602] No Fault, FailCount= 2 2024-11-05T18:47:21.185Z,1730832441.185 [NAL9602](INFO): Powering up NAL9602 2024-11-05T18:47:32.096Z,1730832452.096 [NAL9602](INFO): NAL9602 initialized 2024-11-05T18:49:33.328Z,1730832573.328 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8 2024-11-05T18:49:33.328Z,1730832573.328 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-11-05T18:49:33.329Z,1730832573.329 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 8 2024-11-05T18:49:33.329Z,1730832573.329 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-11-05T18:49:33.330Z,1730832573.330 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 8 2024-11-05T18:49:33.330Z,1730832573.330 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-11-05T18:49:33.341Z,1730832573.341 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-11-05T18:49:33.341Z,1730832573.341 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-11-05T18:49:33.342Z,1730832573.342 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-11-05T18:49:33.742Z,1730832573.742 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-11-05T18:49:33.742Z,1730832573.742 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8 2024-11-05T18:49:33.743Z,1730832573.743 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-11-05T18:49:33.743Z,1730832573.743 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 8 2024-11-05T18:49:33.743Z,1730832573.743 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-11-05T18:49:33.744Z,1730832573.744 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 8 2024-11-05T18:49:34.137Z,1730832574.137 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-11-05T18:50:32.326Z,1730832632.326 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-11-05T18:50:32.326Z,1730832632.326 [Default:CheckIn:C.Wait] Stopped 2024-11-05T18:50:32.326Z,1730832632.326 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-11-05T18:50:32.326Z,1730832632.326 [Default:CheckIn:D] Running Loop=1 2024-11-05T18:50:32.697Z,1730832632.697 [Default:CheckIn:D] Stopped 2024-11-05T18:50:32.697Z,1730832632.697 [Default:CheckIn:E] Running Loop=1 2024-11-05T18:50:33.102Z,1730832633.102 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.136462 min 2024-11-05T18:50:33.102Z,1730832633.102 [Default:CheckIn:E] Stopped 2024-11-05T18:50:33.103Z,1730832633.103 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-11-05T18:50:33.103Z,1730832633.103 [Default:CheckIn] Stopped 2024-11-05T18:50:33.103Z,1730832633.103 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-11-05T18:50:33.103Z,1730832633.103 [Default:CheckIn](INFO): Running loop #3 2024-11-05T18:50:33.103Z,1730832633.103 [Default:CheckIn] Running Loop=3 2024-11-05T18:50:33.103Z,1730832633.103 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-11-05T18:50:33.103Z,1730832633.103 [Default:CheckIn:Read_GPS] Running Loop=1 2024-11-05T18:52:34.314Z,1730832754.314 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9 2024-11-05T18:52:34.314Z,1730832754.314 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-11-05T18:52:34.316Z,1730832754.316 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 9 2024-11-05T18:52:34.316Z,1730832754.316 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-11-05T18:52:34.317Z,1730832754.317 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 9 2024-11-05T18:52:34.317Z,1730832754.317 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-11-05T18:52:34.328Z,1730832754.328 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-11-05T18:52:34.328Z,1730832754.328 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-11-05T18:52:34.329Z,1730832754.329 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-11-05T18:52:34.741Z,1730832754.741 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-11-05T18:52:34.741Z,1730832754.741 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9 2024-11-05T18:52:34.741Z,1730832754.741 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-11-05T18:52:34.742Z,1730832754.742 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 9 2024-11-05T18:52:34.742Z,1730832754.742 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-11-05T18:52:34.742Z,1730832754.742 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 9 2024-11-05T18:52:35.124Z,1730832755.124 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-11-05T18:55:33.302Z,1730832933.302 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-11-05T18:50:33.1Z 2024-11-05T18:55:33.302Z,1730832933.302 [Default:CheckIn:Read_GPS] Stopped 2024-11-05T18:55:33.302Z,1730832933.302 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-11-05T18:55:35.308Z,1730832935.308 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10 2024-11-05T18:55:35.308Z,1730832935.308 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-11-05T18:55:35.309Z,1730832935.309 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 10 2024-11-05T18:55:35.309Z,1730832935.309 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-11-05T18:55:35.310Z,1730832935.310 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 10 2024-11-05T18:55:35.311Z,1730832935.311 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-11-05T18:55:35.342Z,1730832935.342 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-11-05T18:55:35.342Z,1730832935.342 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-11-05T18:55:35.342Z,1730832935.342 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-11-05T18:55:35.726Z,1730832935.726 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-11-05T18:55:35.726Z,1730832935.726 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10 2024-11-05T18:55:35.727Z,1730832935.727 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-11-05T18:55:35.727Z,1730832935.727 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 10 2024-11-05T18:55:35.727Z,1730832935.727 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-11-05T18:55:35.728Z,1730832935.728 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 10 2024-11-05T18:55:36.152Z,1730832936.152 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-11-05T18:55:40.438Z,1730832940.438 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20241105T182515/Courier0010.lzma 2024-11-05T18:55:41.441Z,1730832941.441 [DataOverHttps](INFO): Moved sent file to Logs/20241105T182515/Courier0010.lzma.bak 2024-11-05T18:55:41.441Z,1730832941.441 [DataOverHttps](INFO): SBD MOMSN=23372223 2024-11-05T18:55:57.039Z,1730832957.039 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20241105T182515/Express0011.lzma 2024-11-05T18:55:58.040Z,1730832958.040 [DataOverHttps](INFO): Moved sent file to Logs/20241105T182515/Express0011.lzma.bak 2024-11-05T18:55:58.041Z,1730832958.041 [DataOverHttps](INFO): SBD MOMSN=23372225 2024-11-05T18:55:59.558Z,1730832959.558 [Default:CheckIn:Read_Iridium] Stopped 2024-11-05T18:55:59.558Z,1730832959.558 [Default:CheckIn:C.Wait] Running Loop=1 2024-11-05T18:55:59.558Z,1730832959.558 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-11-05T18:57:34.460Z,1730833054.460 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-11-05T18:57:34.460Z,1730833054.460 [NAL9602] Data Fault, FailCount= 3 2024-11-05T18:57:34.460Z,1730833054.460 [NAL9602](ERROR): Data Fault 2024-11-05T18:57:34.526Z,1730833054.526 [CBIT](ERROR): Data Fault in component: NAL9602 2024-11-05T18:57:34.876Z,1730833054.876 [NAL9602](INFO): Powering down 2024-11-05T18:57:35.712Z,1730833055.712 [CBIT](INFO): Clearing failed state for component NAL9602 2024-11-05T18:57:35.712Z,1730833055.712 [NAL9602] No Fault, FailCount= 3 2024-11-05T18:58:05.164Z,1730833085.164 [NAL9602](INFO): Powering up NAL9602 2024-11-05T18:58:16.070Z,1730833096.070 [NAL9602](INFO): NAL9602 initialized 2024-11-05T18:58:36.307Z,1730833116.307 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11 2024-11-05T18:58:36.307Z,1730833116.307 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-11-05T18:58:36.308Z,1730833116.308 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 11 2024-11-05T18:58:36.308Z,1730833116.308 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-11-05T18:58:36.309Z,1730833116.309 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 11 2024-11-05T18:58:36.310Z,1730833116.310 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-11-05T18:58:36.320Z,1730833116.320 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-11-05T18:58:36.321Z,1730833116.321 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-11-05T18:58:36.321Z,1730833116.321 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-11-05T18:58:36.730Z,1730833116.730 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-11-05T18:58:36.730Z,1730833116.730 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11 2024-11-05T18:58:36.731Z,1730833116.731 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-11-05T18:58:36.731Z,1730833116.731 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 11 2024-11-05T18:58:36.732Z,1730833116.732 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-11-05T18:58:36.732Z,1730833116.732 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 11 2024-11-05T18:58:37.116Z,1730833117.116 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-11-05T19:01:00.119Z,1730833260.119 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-11-05T19:01:00.119Z,1730833260.119 [Default:CheckIn:C.Wait] Stopped 2024-11-05T19:01:00.119Z,1730833260.119 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-11-05T19:01:00.119Z,1730833260.119 [Default:CheckIn:D] Running Loop=1 2024-11-05T19:01:00.530Z,1730833260.530 [Default:CheckIn:D] Stopped 2024-11-05T19:01:00.530Z,1730833260.530 [Default:CheckIn:E] Running Loop=1 2024-11-05T19:01:00.942Z,1730833260.942 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 31.600344 min 2024-11-05T19:01:00.942Z,1730833260.942 [Default:CheckIn:E] Stopped 2024-11-05T19:01:00.942Z,1730833260.942 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-11-05T19:01:00.942Z,1730833260.942 [Default:CheckIn] Stopped 2024-11-05T19:01:00.942Z,1730833260.942 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-11-05T19:01:00.942Z,1730833260.942 [Default:CheckIn](INFO): Running loop #4 2024-11-05T19:01:00.942Z,1730833260.942 [Default:CheckIn] Running Loop=4 2024-11-05T19:01:00.942Z,1730833260.942 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-11-05T19:01:00.942Z,1730833260.942 [Default:CheckIn:Read_GPS] Running Loop=1 2024-11-05T19:01:37.291Z,1730833297.291 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12 2024-11-05T19:01:37.291Z,1730833297.291 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-11-05T19:01:37.292Z,1730833297.292 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 12 2024-11-05T19:01:37.292Z,1730833297.292 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-11-05T19:01:37.294Z,1730833297.294 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 12 2024-11-05T19:01:37.294Z,1730833297.294 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-11-05T19:01:37.341Z,1730833297.341 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-11-05T19:01:37.342Z,1730833297.342 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-11-05T19:01:37.342Z,1730833297.342 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-11-05T19:01:37.715Z,1730833297.715 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-11-05T19:01:37.715Z,1730833297.715 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12 2024-11-05T19:01:37.716Z,1730833297.716 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-11-05T19:01:37.716Z,1730833297.716 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 12 2024-11-05T19:01:37.716Z,1730833297.716 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-11-05T19:01:37.716Z,1730833297.716 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 12 2024-11-05T19:01:38.099Z,1730833298.099 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-11-05T19:04:38.300Z,1730833478.300 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13 2024-11-05T19:04:38.300Z,1730833478.300 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-11-05T19:04:38.301Z,1730833478.301 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 13 2024-11-05T19:04:38.301Z,1730833478.301 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-11-05T19:04:38.302Z,1730833478.302 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 13 2024-11-05T19:04:38.302Z,1730833478.302 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-11-05T19:04:38.353Z,1730833478.353 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-11-05T19:04:38.354Z,1730833478.354 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-11-05T19:04:38.354Z,1730833478.354 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-11-05T19:04:38.713Z,1730833478.713 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-11-05T19:04:38.713Z,1730833478.713 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13 2024-11-05T19:04:38.714Z,1730833478.714 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-11-05T19:04:38.714Z,1730833478.714 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 13 2024-11-05T19:04:38.719Z,1730833478.719 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-11-05T19:04:38.719Z,1730833478.719 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 13 2024-11-05T19:04:39.091Z,1730833479.091 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-11-05T19:06:01.111Z,1730833561.111 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-11-05T19:01:00.9Z 2024-11-05T19:06:01.111Z,1730833561.111 [Default:CheckIn:Read_GPS] Stopped 2024-11-05T19:06:01.111Z,1730833561.111 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-11-05T19:06:07.926Z,1730833567.926 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20241105T182515/Courier0013.lzma 2024-11-05T19:06:09.710Z,1730833569.710 [DataOverHttps](INFO): Moved sent file to Logs/20241105T182515/Courier0013.lzma.bak 2024-11-05T19:06:09.710Z,1730833569.710 [DataOverHttps](INFO): SBD MOMSN=23372269 2024-11-05T19:06:24.483Z,1730833584.483 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20241105T182515/Express0014.lzma 2024-11-05T19:06:25.485Z,1730833585.485 [DataOverHttps](INFO): Moved sent file to Logs/20241105T182515/Express0014.lzma.bak 2024-11-05T19:06:25.485Z,1730833585.485 [DataOverHttps](INFO): SBD MOMSN=23372271 2024-11-05T19:06:26.954Z,1730833586.954 [Default:CheckIn:Read_Iridium] Stopped 2024-11-05T19:06:26.954Z,1730833586.954 [Default:CheckIn:C.Wait] Running Loop=1 2024-11-05T19:06:26.954Z,1730833586.954 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-11-05T19:07:39.284Z,1730833659.284 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14 2024-11-05T19:07:39.284Z,1730833659.284 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-11-05T19:07:39.285Z,1730833659.285 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 14 2024-11-05T19:07:39.285Z,1730833659.285 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-11-05T19:07:39.286Z,1730833659.286 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 14 2024-11-05T19:07:39.287Z,1730833659.287 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-11-05T19:07:39.297Z,1730833659.297 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-11-05T19:07:39.298Z,1730833659.298 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-11-05T19:07:39.298Z,1730833659.298 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-11-05T19:07:39.698Z,1730833659.698 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-11-05T19:07:39.698Z,1730833659.698 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14 2024-11-05T19:07:39.698Z,1730833659.698 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-11-05T19:07:39.698Z,1730833659.698 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 14 2024-11-05T19:07:39.699Z,1730833659.699 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-11-05T19:07:39.699Z,1730833659.699 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 14 2024-11-05T19:07:40.095Z,1730833660.095 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-11-05T19:08:18.440Z,1730833698.440 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-11-05T19:08:18.440Z,1730833698.440 [NAL9602] Data Fault, FailCount= 4 2024-11-05T19:08:18.440Z,1730833698.440 [NAL9602](ERROR): Data Fault 2024-11-05T19:08:18.483Z,1730833698.483 [CBIT](ERROR): Data Fault in component: NAL9602 2024-11-05T19:08:18.848Z,1730833698.848 [NAL9602](INFO): Powering down 2024-11-05T19:08:19.678Z,1730833699.678 [CBIT](INFO): Clearing failed state for component NAL9602 2024-11-05T19:08:19.678Z,1730833699.678 [NAL9602] No Fault, FailCount= 4 2024-11-05T19:08:49.149Z,1730833729.149 [NAL9602](INFO): Powering up NAL9602 2024-11-05T19:09:00.056Z,1730833740.056 [NAL9602](INFO): NAL9602 initialized 2024-11-05T19:10:40.268Z,1730833840.268 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15 2024-11-05T19:10:40.268Z,1730833840.268 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-11-05T19:10:40.269Z,1730833840.269 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 15 2024-11-05T19:10:40.269Z,1730833840.269 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-11-05T19:10:40.270Z,1730833840.270 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 15 2024-11-05T19:10:40.270Z,1730833840.270 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-11-05T19:10:40.283Z,1730833840.283 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-11-05T19:10:40.284Z,1730833840.284 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-11-05T19:10:40.284Z,1730833840.284 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-11-05T19:10:40.694Z,1730833840.694 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-11-05T19:10:40.694Z,1730833840.694 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15 2024-11-05T19:10:40.694Z,1730833840.694 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-11-05T19:10:40.694Z,1730833840.694 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 15 2024-11-05T19:10:40.695Z,1730833840.695 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-11-05T19:10:40.695Z,1730833840.695 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 15 2024-11-05T19:10:41.080Z,1730833841.080 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-11-05T19:11:04.118Z,1730833864.118 [CommandExec](IMPORTANT): got command run ./Missions/Maintenance/run_backseat_on_surface.tl 2024-11-05T19:11:04.118Z,1730833864.118 [MissionManager](INFO): Loading Mission from file: ./Missions/Maintenance/run_backseat_on_surface.tl 2024-11-05T19:11:04.118Z,1730833864.118 [MissionManager](DEBUG): TethyslAPI: loading: ./Missions/Maintenance/run_backseat_on_surface.tl 2024-11-05T19:11:04.128Z,1730833864.128 [MissionManager](DEBUG): TethyslAPI: mission file loaded: ./Missions/Maintenance/run_backseat_on_surface.tl 2024-11-05T19:11:04.652Z,1730833864.652 [MissionManager](DEBUG): TethyslAPI: ./Missions/Maintenance/run_backseat_on_surface.tl translated into: 0 Burn on Dropped weight due to communications timeout. 5 run_backseat_on_surface mission has been running for Restarting logs and run_backseat_on_surface mission. restart logs 2024-11-05T19:11:04.664Z,1730833864.664 [MissionManager](INFO): DefineArg run_backseat_on_surface.ElapsedSinceMissionStarted = 0.000000 min 2024-11-05T19:11:04.665Z,1730833864.665 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BackseatDriver.tl 2024-11-05T19:11:04.665Z,1730833864.665 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/BackseatDriver.tl 2024-11-05T19:11:04.666Z,1730833864.666 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/BackseatDriver.tl 2024-11-05T19:11:04.731Z,1730833864.731 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/BackseatDriver.tl translated into: 2024-11-05T19:11:04.739Z,1730833864.739 [MissionManager](INFO): DefineArg run_backseat_on_surface:BackseatDriver.EnableBackseat = 0 bool 2024-11-05T19:11:04.742Z,1730833864.742 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver](DEBUG): Construct BackseatDriver. 2024-11-05T19:11:04.755Z,1730833864.755 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/PowerOnly.tl 2024-11-05T19:11:04.755Z,1730833864.755 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/PowerOnly.tl 2024-11-05T19:11:04.756Z,1730833864.756 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/PowerOnly.tl 2024-11-05T19:11:05.046Z,1730833865.046 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/PowerOnly.tl translated into: 99999 2024-11-05T19:11:05.059Z,1730833865.059 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.SampleAll = 0 bool 2024-11-05T19:11:05.061Z,1730833865.061 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.SampleLoad1 = 0 bool 2024-11-05T19:11:05.068Z,1730833865.068 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.SampleLoad2 = 0 bool 2024-11-05T19:11:05.095Z,1730833865.095 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.SampleLoad3 = 0 bool 2024-11-05T19:11:05.098Z,1730833865.098 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.EnabledPowerOnly = 0 bool 2024-11-05T19:11:05.122Z,1730833865.122 [run_backseat_on_surface:PowerOnly:E.Wait](DEBUG): Construct Wait. 2024-11-05T19:11:05.133Z,1730833865.133 [run_backseat_on_surface:D.GoToSurface](DEBUG): Construct GoToSurface. 2024-11-05T19:11:05.170Z,1730833865.170 [run_backseat_on_surface:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-11-05T19:11:05.200Z,1730833865.200 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-11-05T19:11:05.213Z,1730833865.213 [run_backseat_on_surface:G.Execute](DEBUG): Construct Execute. 2024-11-05T19:11:05.226Z,1730833865.226 [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 run_backseat_on_surface { arguments { ElapsedSinceMissionStarted = 0 minute } # Power the science payload. # insert id="Science" Insert/Science.tl # Power the Backseat payload. insert Insert/BackseatDriver.tl assign in sequence BackseatDriver:EnableBackseat = true insert Insert/PowerOnly.tl 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=P2H { 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 ElapsedSinceMissionStarted = elapsed ( Universal:mission_started ) syslog important "run_backseat_on_surface mission has been running for " + ElapsedSinceMissionStarted~minute } syslog important "Restarting logs and run_backseat_on_surface mission." behavior Guidance:Execute { run in sequence set command = "restart logs" } } 2024-11-05T19:11:05.236Z,1730833865.236 [CommandExec](IMPORTANT): Running ./Missions/Maintenance/run_backseat_on_surface.tl 2024-11-05T19:11:05.346Z,1730833865.346 [Default] Stopped 2024-11-05T19:11:05.346Z,1730833865.346 [Default](DEBUG): Aggregate::uninitialize Default 2024-11-05T19:11:05.346Z,1730833865.346 [Default:B.GoToSurface] Stopped 2024-11-05T19:11:05.346Z,1730833865.346 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-11-05T19:11:05.346Z,1730833865.346 [Default:CheckIn] Stopped 2024-11-05T19:11:05.346Z,1730833865.346 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-11-05T19:11:05.346Z,1730833865.346 [Default:CheckIn:C.Wait] Stopped 2024-11-05T19:11:05.346Z,1730833865.346 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-11-05T19:11:05.355Z,1730833865.355 [MissionManager](IMPORTANT): Started mission run_backseat_on_surface 2024-11-05T19:11:05.355Z,1730833865.355 [run_backseat_on_surface] Running Loop=1 2024-11-05T19:11:05.355Z,1730833865.355 [run_backseat_on_surface](DEBUG): Aggregate::initialize run_backseat_on_surface 2024-11-05T19:11:05.355Z,1730833865.355 [run_backseat_on_surface:BackseatDriver] Running Loop=1 2024-11-05T19:11:05.355Z,1730833865.355 [run_backseat_on_surface:BackseatDriver](DEBUG): Aggregate::initialize run_backseat_on_surface:BackseatDriver 2024-11-05T19:11:05.355Z,1730833865.355 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver] Running Loop=1 2024-11-05T19:11:05.356Z,1730833865.356 [run_backseat_on_surface:PowerOnly] Running Loop=1 2024-11-05T19:11:05.356Z,1730833865.356 [run_backseat_on_surface:PowerOnly](DEBUG): Aggregate::initialize run_backseat_on_surface:PowerOnly 2024-11-05T19:11:05.356Z,1730833865.356 [run_backseat_on_surface:PowerOnly:A] Running Loop=1 2024-11-05T19:11:05.356Z,1730833865.356 [run_backseat_on_surface:PowerOnly:B] Running Loop=1 2024-11-05T19:11:05.356Z,1730833865.356 [run_backseat_on_surface:PowerOnly:C] Running Loop=1 2024-11-05T19:11:05.356Z,1730833865.356 [run_backseat_on_surface:PowerOnly:D] Running Loop=1 2024-11-05T19:11:05.356Z,1730833865.356 [run_backseat_on_surface:PowerOnly:E.Wait] Running Loop=1 2024-11-05T19:11:05.356Z,1730833865.356 [run_backseat_on_surface:PowerOnly:E.Wait](DEBUG): Initialize Wait Component. 2024-11-05T19:11:05.357Z,1730833865.357 [run_backseat_on_surface:D.GoToSurface] Running Loop=1 2024-11-05T19:11:05.357Z,1730833865.357 [run_backseat_on_surface:D.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-11-05T19:11:05.357Z,1730833865.357 [run_backseat_on_surface:D.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-11-05T19:11:05.357Z,1730833865.357 [run_backseat_on_surface:D.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-11-05T19:11:05.357Z,1730833865.357 [run_backseat_on_surface:D.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-11-05T19:11:05.358Z,1730833865.358 [run_backseat_on_surface:D.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-11-05T19:11:05.358Z,1730833865.358 [run_backseat_on_surface:D.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2024-11-05T19:11:05.358Z,1730833865.358 [run_backseat_on_surface:D.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-11-05T19:11:05.367Z,1730833865.367 [run_backseat_on_surface:B] Running Loop=1 2024-11-05T19:11:05.368Z,1730833865.368 [run_backseat_on_surface:PowerOnly] Running Loop=1 2024-11-05T19:11:05.368Z,1730833865.368 [run_backseat_on_surface:PowerOnly:D] Stopped 2024-11-05T19:11:05.368Z,1730833865.368 [run_backseat_on_surface:PowerOnly:C] Stopped 2024-11-05T19:11:05.368Z,1730833865.368 [run_backseat_on_surface:PowerOnly:B] Stopped 2024-11-05T19:11:05.368Z,1730833865.368 [run_backseat_on_surface:PowerOnly:A] Stopped 2024-11-05T19:11:05.368Z,1730833865.368 [run_backseat_on_surface:B] Stopped 2024-11-05T19:11:05.369Z,1730833865.369 [run_backseat_on_surface:BackseatDriver] Running Loop=1 2024-11-05T19:11:05.369Z,1730833865.369 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver](INFO): Initializing backseat 2024-11-05T19:11:05.423Z,1730833865.423 [BackseatComponent](INFO): Powering up 2024-11-05T19:11:05.424Z,1730833865.424 [BackseatComponent](INFO): Subscribing to LCM channels. 2024-11-05T19:11:05.731Z,1730833865.731 [run_backseat_on_surface:CheckIn] Running Loop=1 2024-11-05T19:11:05.731Z,1730833865.731 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::initialize run_backseat_on_surface:CheckIn 2024-11-05T19:11:05.731Z,1730833865.731 [run_backseat_on_surface:CheckIn:Read_GPS] Running Loop=1 2024-11-05T19:11:06.125Z,1730833866.125 [run_backseat_on_surface:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2024-11-05T19:11:24.010Z,1730833884.010 [BackseatComponent](INFO): Created universal data reader for depth with code: 6 2024-11-05T19:11:24.010Z,1730833884.010 [BackseatComponent](INFO): Requesting data from depth (6). Requested size is: 1 2024-11-05T19:11:24.014Z,1730833884.014 [BackseatComponent](INFO): Created universal data reader for latitude with code: 23 2024-11-05T19:11:24.015Z,1730833884.015 [BackseatComponent](INFO): Requesting data from latitude (23). Requested size is: 2 2024-11-05T19:11:24.017Z,1730833884.017 [BackseatComponent](INFO): Created universal data reader for longitude with code: 26 2024-11-05T19:11:24.018Z,1730833884.018 [BackseatComponent](INFO): Requesting data from longitude (26). Requested size is: 3 2024-11-05T19:11:24.021Z,1730833884.021 [BackseatComponent](INFO): Created universal data reader for platform_orientation with code: 52 2024-11-05T19:11:24.021Z,1730833884.021 [BackseatComponent](INFO): Requesting data from platform_orientation (52). Requested size is: 4 2024-11-05T19:11:24.024Z,1730833884.024 [BackseatComponent](INFO): Created universal data reader for platform_pitch_angle with code: 54 2024-11-05T19:11:24.025Z,1730833884.025 [BackseatComponent](INFO): Requesting data from platform_pitch_angle (54). Requested size is: 5 2024-11-05T19:11:24.028Z,1730833884.028 [BackseatComponent](INFO): Created universal data reader for platform_roll_angle with code: 59 2024-11-05T19:11:24.028Z,1730833884.028 [BackseatComponent](INFO): Requesting data from platform_roll_angle (59). Requested size is: 6 2024-11-05T19:11:24.031Z,1730833884.031 [BackseatComponent](INFO): Created universal data reader for platform_x_velocity_wrt_sea_water with code: 70 2024-11-05T19:11:24.031Z,1730833884.031 [BackseatComponent](INFO): Requesting data from platform_x_velocity_wrt_sea_water (70). Requested size is: 7 2024-11-05T19:13:41.276Z,1730834021.276 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16 2024-11-05T19:13:41.276Z,1730834021.276 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-11-05T19:13:41.277Z,1730834021.277 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 16 2024-11-05T19:13:41.277Z,1730834021.277 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-11-05T19:13:41.278Z,1730834021.278 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 16 2024-11-05T19:13:41.278Z,1730834021.278 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-11-05T19:13:41.291Z,1730834021.291 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-11-05T19:13:41.291Z,1730834021.291 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-11-05T19:13:41.292Z,1730834021.292 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-11-05T19:13:41.687Z,1730834021.687 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-11-05T19:13:41.687Z,1730834021.687 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16 2024-11-05T19:13:41.688Z,1730834021.688 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-11-05T19:13:41.688Z,1730834021.688 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 16 2024-11-05T19:13:41.688Z,1730834021.688 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-11-05T19:13:41.688Z,1730834021.688 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 16 2024-11-05T19:13:42.063Z,1730834022.063 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-11-05T19:14:34.759Z,1730834074.759 [CommandExec](IMPORTANT): got command report touch BackseatComponent.handled_message 2024-11-05T19:14:35.056Z,1730834075.056 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:35.443Z,1730834075.443 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:35.848Z,1730834075.848 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:36.249Z,1730834076.249 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:36.648Z,1730834076.648 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:37.048Z,1730834077.048 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:37.459Z,1730834077.459 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:37.875Z,1730834077.875 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:38.260Z,1730834078.260 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:38.661Z,1730834078.661 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:39.036Z,1730834079.036 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:39.485Z,1730834079.485 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:39.863Z,1730834079.863 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:40.274Z,1730834080.274 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:40.652Z,1730834080.652 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:41.064Z,1730834081.064 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:41.469Z,1730834081.469 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:41.880Z,1730834081.880 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:42.300Z,1730834082.300 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:42.714Z,1730834082.714 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:43.088Z,1730834083.088 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:43.500Z,1730834083.500 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:43.888Z,1730834083.888 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:44.296Z,1730834084.296 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:44.708Z,1730834084.708 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:45.115Z,1730834085.115 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:45.536Z,1730834085.536 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:45.943Z,1730834085.943 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:46.328Z,1730834086.328 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:46.732Z,1730834086.732 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:47.116Z,1730834087.116 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:47.525Z,1730834087.525 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:47.932Z,1730834087.932 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:48.352Z,1730834088.352 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:48.772Z,1730834088.772 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:49.176Z,1730834089.176 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:49.549Z,1730834089.549 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:49.965Z,1730834089.965 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:50.364Z,1730834090.364 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:50.761Z,1730834090.761 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:51.165Z,1730834091.165 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:51.580Z,1730834091.580 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:51.997Z,1730834091.997 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:52.402Z,1730834092.402 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:52.780Z,1730834092.780 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:53.188Z,1730834093.188 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:53.604Z,1730834093.604 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:53.988Z,1730834093.988 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:54.424Z,1730834094.424 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:54.808Z,1730834094.808 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:55.220Z,1730834095.220 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:55.619Z,1730834095.619 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:56.014Z,1730834096.014 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:56.418Z,1730834096.418 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:56.827Z,1730834096.827 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:57.252Z,1730834097.252 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:57.660Z,1730834097.660 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:58.068Z,1730834098.068 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:58.444Z,1730834098.444 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:58.848Z,1730834098.848 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:59.236Z,1730834099.236 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:14:59.652Z,1730834099.652 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:00.057Z,1730834100.057 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:00.472Z,1730834100.472 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:00.888Z,1730834100.888 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:01.296Z,1730834101.296 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:01.668Z,1730834101.668 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:02.084Z,1730834102.084 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:02.489Z,1730834102.489 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:02.872Z,1730834102.872 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:03.288Z,1730834103.288 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:03.714Z,1730834103.714 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:04.114Z,1730834104.114 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:04.492Z,1730834104.492 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:04.900Z,1730834104.900 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:05.313Z,1730834105.313 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:05.732Z,1730834105.732 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:06.141Z,1730834106.141 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:06.556Z,1730834106.556 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:06.940Z,1730834106.940 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:07.356Z,1730834107.356 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:07.753Z,1730834107.753 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:08.166Z,1730834108.166 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:08.590Z,1730834108.590 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:08.960Z,1730834108.960 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:09.368Z,1730834109.368 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:09.780Z,1730834109.780 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:10.185Z,1730834110.185 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:10.564Z,1730834110.564 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:10.964Z,1730834110.964 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:11.364Z,1730834111.364 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:11.768Z,1730834111.768 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:12.192Z,1730834112.192 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:12.600Z,1730834112.600 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:13.009Z,1730834113.009 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:13.384Z,1730834113.384 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:13.796Z,1730834113.796 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:14.212Z,1730834114.212 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:14.625Z,1730834114.625 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:15.036Z,1730834115.036 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:15.414Z,1730834115.414 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:15.796Z,1730834115.796 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:16.240Z,1730834116.240 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:16.651Z,1730834116.651 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:17.032Z,1730834117.032 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:17.437Z,1730834117.437 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:17.820Z,1730834117.820 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:18.263Z,1730834118.263 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:18.652Z,1730834118.652 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:19.056Z,1730834119.056 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:19.436Z,1730834119.436 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:19.840Z,1730834119.840 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:20.256Z,1730834120.256 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:20.664Z,1730834120.664 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:21.052Z,1730834121.052 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:21.494Z,1730834121.494 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:21.884Z,1730834121.884 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:22.296Z,1730834122.296 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:22.701Z,1730834122.701 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:23.076Z,1730834123.076 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:23.484Z,1730834123.484 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:23.896Z,1730834123.896 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:24.320Z,1730834124.320 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:24.732Z,1730834124.732 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:25.138Z,1730834125.138 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:25.514Z,1730834125.514 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:25.916Z,1730834125.916 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:26.308Z,1730834126.308 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:26.720Z,1730834126.720 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:27.133Z,1730834127.133 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:27.548Z,1730834127.548 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:27.960Z,1730834127.960 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:28.363Z,1730834128.363 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:28.744Z,1730834128.744 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:29.153Z,1730834129.153 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:29.536Z,1730834129.536 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:29.940Z,1730834129.940 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:30.356Z,1730834130.356 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:30.776Z,1730834130.776 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:31.182Z,1730834131.182 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:31.565Z,1730834131.565 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:31.972Z,1730834131.972 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:32.381Z,1730834132.381 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:32.790Z,1730834132.790 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:33.207Z,1730834133.207 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:33.633Z,1730834133.633 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:34.012Z,1730834134.012 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:34.406Z,1730834134.406 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:34.795Z,1730834134.795 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:35.210Z,1730834135.210 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:35.622Z,1730834135.622 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:36.030Z,1730834136.030 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:36.436Z,1730834136.436 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:36.849Z,1730834136.849 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:37.250Z,1730834137.250 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:37.656Z,1730834137.656 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:38.064Z,1730834138.064 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:38.473Z,1730834138.473 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:38.852Z,1730834138.852 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:39.291Z,1730834139.291 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:39.681Z,1730834139.681 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:40.082Z,1730834140.082 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:40.457Z,1730834140.457 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:40.866Z,1730834140.866 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:41.252Z,1730834141.252 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:41.664Z,1730834141.664 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:42.076Z,1730834142.076 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:42.489Z,1730834142.489 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:42.902Z,1730834142.902 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:43.311Z,1730834143.311 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:43.688Z,1730834143.688 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:44.096Z,1730834144.096 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:44.506Z,1730834144.506 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:44.892Z,1730834144.892 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:45.332Z,1730834145.332 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:45.721Z,1730834145.721 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:46.128Z,1730834146.128 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:46.504Z,1730834146.504 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:46.916Z,1730834146.916 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:47.324Z,1730834147.324 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:47.740Z,1730834147.740 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:48.120Z,1730834148.120 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:15:48.583Z,1730834148.583 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:16:05.881Z,1730834165.881 [run_backseat_on_surface:CheckIn:Read_GPS](INFO): Timed out from 2024-11-05T19:11:05.7Z 2024-11-05T19:16:05.881Z,1730834165.881 [run_backseat_on_surface:CheckIn:Read_GPS] Stopped 2024-11-05T19:16:05.882Z,1730834165.882 [run_backseat_on_surface:CheckIn:Read_Iridium] Running Loop=1 2024-11-05T19:16:06.286Z,1730834166.286 [run_backseat_on_surface:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-11-05T19:16:11.154Z,1730834171.154 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20241105T182515/Courier0016.lzma 2024-11-05T19:16:12.157Z,1730834172.157 [DataOverHttps](INFO): Moved sent file to Logs/20241105T182515/Courier0016.lzma.bak 2024-11-05T19:16:12.157Z,1730834172.157 [DataOverHttps](INFO): SBD MOMSN=23372291 2024-11-05T19:16:27.839Z,1730834187.839 [DataOverHttps](INFO): Sending 239 bytes from file Logs/20241105T182515/Express0017.lzma 2024-11-05T19:16:28.840Z,1730834188.840 [DataOverHttps](INFO): Moved sent file to Logs/20241105T182515/Express0017.lzma.bak 2024-11-05T19:16:28.841Z,1730834188.841 [DataOverHttps](INFO): SBD MOMSN=23372293 2024-11-05T19:16:30.534Z,1730834190.534 [run_backseat_on_surface:CheckIn:Read_Iridium] Stopped 2024-11-05T19:16:30.534Z,1730834190.534 [run_backseat_on_surface:CheckIn:C.Wait] Running Loop=1 2024-11-05T19:16:30.534Z,1730834190.534 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-11-05T19:16:42.264Z,1730834202.264 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17 2024-11-05T19:16:42.264Z,1730834202.264 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-11-05T19:16:42.265Z,1730834202.265 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 17 2024-11-05T19:16:42.265Z,1730834202.265 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-11-05T19:16:42.266Z,1730834202.266 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 17 2024-11-05T19:16:42.266Z,1730834202.266 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-11-05T19:16:42.279Z,1730834202.279 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-11-05T19:16:42.279Z,1730834202.279 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-11-05T19:16:42.280Z,1730834202.280 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-11-05T19:16:42.673Z,1730834202.673 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-11-05T19:16:42.673Z,1730834202.673 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17 2024-11-05T19:16:42.673Z,1730834202.673 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-11-05T19:16:42.673Z,1730834202.673 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 17 2024-11-05T19:16:42.674Z,1730834202.674 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-11-05T19:16:42.674Z,1730834202.674 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 17 2024-11-05T19:16:43.047Z,1730834203.047 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-11-05T19:17:23.789Z,1730834243.789 [CommandExec](IMPORTANT): got command maintain sensor NAL9602.latitude_fix 36.81544 degree 2024-11-05T19:17:23.793Z,1730834243.793 [ComponentRegistry](DEBUG): SyncComponent "Maintain_NAL9602.latitude_fix" handled in the control thread. 2024-11-05T19:17:23.794Z,1730834243.794 [CommandExec](IMPORTANT): got command maintain sensor NAL9602.longitude_fix -121.82506 degree 2024-11-05T19:17:23.821Z,1730834243.821 [ComponentRegistry](DEBUG): SyncComponent "Maintain_NAL9602.longitude_fix" handled in the control thread. 2024-11-05T19:17:23.822Z,1730834243.822 [CommandExec](IMPORTANT): got command maintain sensor NAL9602.time_fix 1730834202 second 2024-11-05T19:17:23.825Z,1730834243.825 [ComponentRegistry](DEBUG): SyncComponent "Maintain_NAL9602.time_fix" handled in the control thread. 2024-11-05T19:17:23.922Z,1730834243.922 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,NAL9602,Power24vConverter,Sonardyne_Nano,PAR_Licor,Depth_Keller,PAR_Licor,Maintain_NAL9602.latitude_fix,Maintain_NAL9602.longitude_fix,Maintain_NAL9602.time_fix,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-11-05T19:17:55.179Z,1730834275.179 [BackseatComponent](IMPORTANT): IBASE811F-02: Running bioacoustics backseat app. Logging to: 20241105T191801 2024-11-05T19:17:55.414Z,1730834275.414 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:17:55.794Z,1730834275.794 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:17:56.163Z,1730834276.163 [NAL9602](INFO): Not Powering down - fast GPS 2024-11-05T19:17:56.236Z,1730834276.236 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:17:56.622Z,1730834276.622 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:18:01.054Z,1730834281.054 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:18:06.360Z,1730834286.360 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:18:11.550Z,1730834291.550 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:18:16.398Z,1730834296.398 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:18:28.307Z,1730834308.307 [BackseatComponent](IMPORTANT): IBASE811F-02: Running bioacoustics backseat app. Logging to: 20241105T191835 2024-11-05T19:18:28.518Z,1730834308.518 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:18:28.938Z,1730834308.938 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:18:29.346Z,1730834309.346 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:18:29.730Z,1730834309.730 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:18:34.198Z,1730834314.198 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:18:39.430Z,1730834319.430 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:18:44.678Z,1730834324.678 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:18:49.938Z,1730834329.938 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:18:55.218Z,1730834335.218 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:19:00.454Z,1730834340.454 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:19:05.730Z,1730834345.730 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:19:10.946Z,1730834350.946 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:19:16.198Z,1730834356.198 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:19:21.454Z,1730834361.454 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:19:26.690Z,1730834366.690 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:19:31.558Z,1730834371.558 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:19:37.222Z,1730834377.222 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:19:42.474Z,1730834382.474 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:19:47.698Z,1730834387.698 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:19:52.575Z,1730834392.575 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:19:57.818Z,1730834397.818 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:20:03.056Z,1730834403.056 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:20:08.366Z,1730834408.366 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:20:12.330Z,1730834412.330 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver](INFO): Created data writer for _.height_above_sea_floor with code: 1968 2024-11-05T19:20:12.377Z,1730834412.377 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:20:13.569Z,1730834413.569 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:20:15.182Z,1730834415.182 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:20:16.799Z,1730834416.799 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:20:18.002Z,1730834418.002 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:20:19.234Z,1730834419.234 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:20:19.622Z,1730834419.622 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:20:21.234Z,1730834421.234 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:20:22.462Z,1730834422.462 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:20:24.102Z,1730834424.102 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:20:25.294Z,1730834425.294 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:20:26.812Z,1730834426.812 [CommandExec](IMPORTANT): got command get height_above_sea_floor 2024-11-05T19:20:26.813Z,1730834426.813 [CommandExec](FAULT): Element has no value 2024-11-05T19:20:26.934Z,1730834426.934 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:20:28.514Z,1730834428.514 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:20:29.388Z,1730834429.388 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:20:29.742Z,1730834429.742 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:20:31.350Z,1730834431.350 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:20:32.969Z,1730834432.969 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:20:34.065Z,1730834434.065 [CommandExec](IMPORTANT): got command get height_above_sea_floor 2024-11-05T19:20:34.065Z,1730834434.065 [CommandExec](FAULT): Element has no value 2024-11-05T19:20:34.178Z,1730834434.178 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:20:34.978Z,1730834434.978 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:20:35.791Z,1730834435.791 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:20:37.430Z,1730834437.430 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:20:38.658Z,1730834438.658 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:20:39.874Z,1730834439.874 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:20:40.329Z,1730834440.329 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:20:41.446Z,1730834441.446 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:20:43.079Z,1730834443.079 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:20:44.694Z,1730834444.694 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:20:45.062Z,1730834445.062 [CommandExec](IMPORTANT): got command get _.height_above_sea_floor 2024-11-05T19:20:45.083Z,1730834445.083 [CommandExec](IMPORTANT): _.height_above_sea_floor 175.740005 m 2024-11-05T19:20:45.130Z,1730834445.130 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:20:45.890Z,1730834445.890 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:20:47.502Z,1730834447.502 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:20:48.706Z,1730834448.706 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:20:50.376Z,1730834450.376 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:20:51.558Z,1730834451.558 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:20:53.221Z,1730834453.221 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:20:54.802Z,1730834454.802 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:20:55.073Z,1730834455.073 [CommandExec](IMPORTANT): got command get BioacousticsDataBridge.loadAtStartup 2024-11-05T19:20:55.074Z,1730834455.074 [CommandExec](IMPORTANT): BioacousticsDataBridge.loadAtStartup 0 bool 2024-11-05T19:20:55.575Z,1730834455.575 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:20:55.990Z,1730834455.990 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:20:57.606Z,1730834457.606 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:20:59.223Z,1730834459.223 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:21:00.422Z,1730834460.422 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:21:01.250Z,1730834461.250 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:21:06.513Z,1730834466.513 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:21:11.734Z,1730834471.734 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:21:16.644Z,1730834476.644 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:21:21.872Z,1730834481.872 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:21:27.595Z,1730834487.595 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:21:31.121Z,1730834491.121 [run_backseat_on_surface:CheckIn:C.Wait](INFO): Done Waiting. 2024-11-05T19:21:31.121Z,1730834491.121 [run_backseat_on_surface:CheckIn:C.Wait] Stopped 2024-11-05T19:21:31.121Z,1730834491.121 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-11-05T19:21:31.121Z,1730834491.121 [run_backseat_on_surface:CheckIn:D] Running Loop=1 2024-11-05T19:21:31.535Z,1730834491.535 [run_backseat_on_surface:CheckIn:D] Stopped 2024-11-05T19:21:31.535Z,1730834491.535 [run_backseat_on_surface:CheckIn:E] Running Loop=1 2024-11-05T19:21:31.921Z,1730834491.921 [run_backseat_on_surface:CheckIn:E](IMPORTANT): run_backseat_on_surface mission has been running for 10.436058 min 2024-11-05T19:21:31.921Z,1730834491.921 [run_backseat_on_surface:CheckIn:E] Stopped 2024-11-05T19:21:31.921Z,1730834491.921 [run_backseat_on_surface:CheckIn](INFO): Completed run_backseat_on_surface:CheckIn 2024-11-05T19:21:31.921Z,1730834491.921 [run_backseat_on_surface:CheckIn] Stopped 2024-11-05T19:21:31.921Z,1730834491.921 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::uninitialize run_backseat_on_surface:CheckIn 2024-11-05T19:21:31.922Z,1730834491.922 [run_backseat_on_surface:CheckIn](INFO): Running loop #2 2024-11-05T19:21:31.922Z,1730834491.922 [run_backseat_on_surface:CheckIn] Running Loop=2 2024-11-05T19:21:31.922Z,1730834491.922 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::initialize run_backseat_on_surface:CheckIn 2024-11-05T19:21:31.922Z,1730834491.922 [run_backseat_on_surface:CheckIn:Read_GPS] Running Loop=1 2024-11-05T19:21:32.326Z,1730834492.326 [run_backseat_on_surface:CheckIn:Read_GPS] Stopped 2024-11-05T19:21:32.326Z,1730834492.326 [run_backseat_on_surface:CheckIn:Read_Iridium] Running Loop=1 2024-11-05T19:21:32.348Z,1730834492.348 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:21:38.034Z,1730834498.034 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:21:39.483Z,1730834499.483 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20241105T182515/Courier0019.lzma 2024-11-05T19:21:40.485Z,1730834500.485 [DataOverHttps](INFO): Moved sent file to Logs/20241105T182515/Courier0019.lzma.bak 2024-11-05T19:21:40.485Z,1730834500.485 [DataOverHttps](INFO): SBD MOMSN=23372303 2024-11-05T19:21:42.860Z,1730834502.860 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:21:48.124Z,1730834508.124 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:21:53.398Z,1730834513.398 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:21:56.632Z,1730834516.632 [DataOverHttps](INFO): Sending 607 bytes from file Logs/20241105T182515/Express0020.lzma 2024-11-05T19:21:57.633Z,1730834517.633 [DataOverHttps](INFO): Moved sent file to Logs/20241105T182515/Express0020.lzma.bak 2024-11-05T19:21:57.633Z,1730834517.633 [DataOverHttps](INFO): SBD MOMSN=23372305 2024-11-05T19:21:58.994Z,1730834518.994 [run_backseat_on_surface:CheckIn:Read_Iridium] Stopped 2024-11-05T19:21:58.994Z,1730834518.994 [run_backseat_on_surface:CheckIn:C.Wait] Running Loop=1 2024-11-05T19:21:58.994Z,1730834518.994 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-11-05T19:21:59.034Z,1730834519.034 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:22:03.926Z,1730834523.926 [Reporter](INFO): BackseatComponent.handled_message 1 bool 2024-11-05T19:22:04.724Z,1730834524.724 [CommandExec](IMPORTANT): got command configSet BioacousticsDataBridge.loadAtStartup 1 bool persist 2024-11-05T19:22:04.725Z,1730834524.725 [CommandExec](IMPORTANT): configSet BioacousticsDataBridge.loadAtStartup requires a restart to take effect. 2024-11-05T19:22:04.729Z,1730834524.729 [CommandExec](IMPORTANT): got command restart application 2024-11-05T19:22:05.731Z,1730834525.731 [Supervisor](INFO): Stop Mission called by Supervisor::terminate 2024-11-05T19:22:05.731Z,1730834525.731 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-05T19:22:05.731Z,1730834525.731 [CommandExec](INFO): Uninitializing the command executive. 2024-11-05T19:22:05.731Z,1730834525.731 [CommandExec](INFO): Uninitializing the command scheduler. 2024-11-05T19:22:05.732Z,1730834525.732 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-11-05T19:22:05.863Z,1730834525.863 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-11-05T19:22:05.863Z,1730834525.863 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-11-05T19:22:05.863Z,1730834525.863 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-11-05T19:22:05.864Z,1730834525.864 [NavChartDb](INFO): Join timeout helper Thread ID is 483 2024-11-05T19:22:05.871Z,1730834525.871 [MissionManager](INFO): MissionManager is completed. 2024-11-05T19:22:05.871Z,1730834525.871 [MissionManager](INFO): Uninitializing Mission run_backseat_on_surface 2024-11-05T19:22:05.871Z,1730834525.871 [run_backseat_on_surface] Stopped 2024-11-05T19:22:05.871Z,1730834525.871 [run_backseat_on_surface](DEBUG): Aggregate::uninitialize run_backseat_on_surface 2024-11-05T19:22:05.871Z,1730834525.871 [run_backseat_on_surface:BackseatDriver] Stopped 2024-11-05T19:22:05.871Z,1730834525.871 [run_backseat_on_surface:BackseatDriver](DEBUG): Aggregate::uninitialize run_backseat_on_surface:BackseatDriver 2024-11-05T19:22:05.871Z,1730834525.871 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver] Stopped 2024-11-05T19:22:05.871Z,1730834525.871 [run_backseat_on_surface:PowerOnly] Stopped 2024-11-05T19:22:05.872Z,1730834525.872 [run_backseat_on_surface:PowerOnly](DEBUG): Aggregate::uninitialize run_backseat_on_surface:PowerOnly 2024-11-05T19:22:05.872Z,1730834525.872 [run_backseat_on_surface:PowerOnly:E.Wait] Stopped 2024-11-05T19:22:05.872Z,1730834525.872 [run_backseat_on_surface:PowerOnly:E.Wait](DEBUG): Uninitialize Wait Component. 2024-11-05T19:22:05.872Z,1730834525.872 [run_backseat_on_surface:D.GoToSurface] Stopped 2024-11-05T19:22:05.872Z,1730834525.872 [run_backseat_on_surface:D.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-11-05T19:22:05.872Z,1730834525.872 [run_backseat_on_surface:CheckIn] Stopped 2024-11-05T19:22:05.872Z,1730834525.872 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::uninitialize run_backseat_on_surface:CheckIn 2024-11-05T19:22:05.872Z,1730834525.872 [run_backseat_on_surface:CheckIn:C.Wait] Stopped 2024-11-05T19:22:05.872Z,1730834525.872 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-11-05T19:22:06.027Z,1730834526.027 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-05T19:22:06.027Z,1730834526.027 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-11-05T19:22:06.031Z,1730834526.031 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-11-05T19:22:06.031Z,1730834526.031 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-11-05T19:22:06.031Z,1730834526.031 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 484 2024-11-05T19:22:06.275Z,1730834526.275 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-05T19:22:06.275Z,1730834526.275 [WetLabsBB2FL](INFO): Powering down 2024-11-05T19:22:06.276Z,1730834526.276 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-11-05T19:22:06.276Z,1730834526.276 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2024-11-05T19:22:06.276Z,1730834526.276 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-11-05T19:22:06.277Z,1730834526.277 [CTD_Seabird](INFO): Join timeout helper Thread ID is 485 2024-11-05T19:22:06.279Z,1730834526.279 [MissionManager](IMPORTANT): Started mission Default 2024-11-05T19:22:06.279Z,1730834526.279 [Default] Running Loop=1 2024-11-05T19:22:06.279Z,1730834526.279 [Default](DEBUG): Aggregate::initialize Default 2024-11-05T19:22:06.279Z,1730834526.279 [Default:B.GoToSurface] Running Loop=1 2024-11-05T19:22:06.279Z,1730834526.279 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-11-05T19:22:06.279Z,1730834526.279 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-11-05T19:22:06.280Z,1730834526.280 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-11-05T19:22:06.280Z,1730834526.280 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-11-05T19:22:06.280Z,1730834526.280 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-11-05T19:22:06.281Z,1730834526.281 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2024-11-05T19:22:06.281Z,1730834526.281 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-11-05T19:22:06.281Z,1730834526.281 [Default:A.Wait] Running Loop=1 2024-11-05T19:22:06.281Z,1730834526.281 [Default:A.Wait](DEBUG): Initialize Wait Component. 2024-11-05T19:22:06.422Z,1730834526.422 [BackseatComponent](INFO): Sent LCM shutdown request. 2024-11-05T19:22:06.423Z,1730834526.423 [BackseatComponent](INFO): Shutdown requested. Waiting (18.00 sec to power down.). 2024-11-05T19:22:07.243Z,1730834527.243 [CTD_Seabird](INFO): Powering down 2024-11-05T19:22:07.259Z,1730834527.259 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-05T19:22:07.269Z,1730834527.269 [CTD_Seabird](INFO): Powering down 2024-11-05T19:22:07.283Z,1730834527.283 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-11-05T19:22:07.299Z,1730834527.299 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-11-05T19:22:07.299Z,1730834527.299 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-11-05T19:22:07.299Z,1730834527.299 [Radio_Surface](INFO): Join timeout helper Thread ID is 486 2024-11-05T19:22:07.411Z,1730834527.411 [Radio_Surface](INFO): Powering down 2024-11-05T19:22:07.412Z,1730834527.412 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-05T19:22:07.412Z,1730834527.412 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-11-05T19:22:07.420Z,1730834527.420 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-11-05T19:22:07.420Z,1730834527.420 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-11-05T19:22:07.421Z,1730834527.421 [Onboard](INFO): Join timeout helper Thread ID is 487 2024-11-05T19:22:08.120Z,1730834528.120 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2024-11-05T19:22:08.895Z,1730834528.895 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-05T19:22:08.895Z,1730834528.895 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-11-05T19:22:08.903Z,1730834528.903 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-11-05T19:22:08.903Z,1730834528.903 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-11-05T19:22:08.904Z,1730834528.904 [DataOverHttps](INFO): Join timeout helper Thread ID is 488 2024-11-05T19:22:09.123Z,1730834529.123 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-05T19:22:09.123Z,1730834529.123 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-11-05T19:22:09.140Z,1730834529.140 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2024-11-05T19:22:09.140Z,1730834529.140 [DAT ThreadHandler](INFO): Thread cancelled. 2024-11-05T19:22:09.140Z,1730834529.140 [DAT](INFO): Join timeout helper Thread ID is 489 2024-11-05T19:22:09.291Z,1730834529.291 [DAT](INFO): Powering down 2024-11-05T19:22:09.363Z,1730834529.363 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-05T19:22:09.364Z,1730834529.364 [DAT](INFO): Powering down 2024-11-05T19:22:09.364Z,1730834529.364 [DAT ThreadHandler](INFO): Thread cancelled. 2024-11-05T19:22:09.379Z,1730834529.379 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2024-11-05T19:22:09.379Z,1730834529.379 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-11-05T19:22:09.380Z,1730834529.380 [BackseatComponent](INFO): Join timeout helper Thread ID is 490 2024-11-05T19:22:09.519Z,1730834529.519 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-05T19:22:09.519Z,1730834529.519 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-11-05T19:22:09.520Z,1730834529.520 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-11-05T19:22:09.521Z,1730834529.521 [logger ThreadHandler](INFO): Thread cancelled. 2024-11-05T19:22:09.521Z,1730834529.521 [logger](INFO): Join timeout helper Thread ID is 491 2024-11-05T19:22:09.562Z,1730834529.562 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-05T19:22:09.563Z,1730834529.563 [logger ThreadHandler](INFO): Thread cancelled. 2024-11-05T19:22:09.583Z,1730834529.583 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-11-05T19:22:09.583Z,1730834529.583 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-11-05T19:22:09.584Z,1730834529.584 [CommandLine](INFO): Join timeout helper Thread ID is 492 2024-11-05T19:22:09.599Z,1730834529.599 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-05T19:22:09.599Z,1730834529.599 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-11-05T19:22:09.603Z,1730834529.603 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-11-05T19:22:09.603Z,1730834529.603 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-11-05T19:22:09.604Z,1730834529.604 [CommandExec](INFO): Join timeout helper Thread ID is 493 2024-11-05T19:22:09.605Z,1730834529.605 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-11-05T19:22:09.605Z,1730834529.605 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-11-05T19:22:09.606Z,1730834529.606 [controlThread](INFO): Join timeout helper Thread ID is 494 2024-11-05T19:22:09.863Z,1730834529.863 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-05T19:22:09.863Z,1730834529.863 [controlThread](DEBUG): Uninitializing ControlThread 2024-11-05T19:22:09.864Z,1730834529.864 [AHRS_M2](INFO): Powering down 2024-11-05T19:22:09.935Z,1730834529.935 [NAL9602](INFO): Powering down 2024-11-05T19:22:09.937Z,1730834529.937 [Sonardyne_Nano](INFO): Powering down 2024-11-05T19:22:10.056Z,1730834530.056 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-11-05T19:22:10.057Z,1730834530.057 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-11-05T19:22:10.057Z,1730834530.057 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-11-05T19:22:10.058Z,1730834530.058 [MissionManager](INFO): Uninitializing Mission Default 2024-11-05T19:22:10.058Z,1730834530.058 [Default] Stopped 2024-11-05T19:22:10.058Z,1730834530.058 [Default](DEBUG): Aggregate::uninitialize Default 2024-11-05T19:22:10.058Z,1730834530.058 [Default:A.Wait] Stopped 2024-11-05T19:22:10.058Z,1730834530.058 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2024-11-05T19:22:10.058Z,1730834530.058 [Default:B.GoToSurface] Stopped 2024-11-05T19:22:10.058Z,1730834530.058 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-11-05T19:22:10.061Z,1730834530.061 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-11-05T19:22:10.061Z,1730834530.061 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-11-05T19:22:10.062Z,1730834530.062 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-11-05T19:22:10.062Z,1730834530.062 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-11-05T19:22:10.062Z,1730834530.062 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-11-05T19:22:10.062Z,1730834530.062 [BuoyancyServo](INFO): Powering down 2024-11-05T19:22:10.075Z,1730834530.075 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-11-05T19:22:10.075Z,1730834530.075 [ElevatorServo](INFO): Powering down 2024-11-05T19:22:10.076Z,1730834530.076 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-11-05T19:22:10.076Z,1730834530.076 [MassServo](INFO): Powering down 2024-11-05T19:22:10.077Z,1730834530.077 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-11-05T19:22:10.077Z,1730834530.077 [RudderServo](INFO): Powering down 2024-11-05T19:22:10.077Z,1730834530.077 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2024-11-05T19:22:10.078Z,1730834530.078 [ThrusterHE](INFO): Powering down 2024-11-05T19:22:10.078Z,1730834530.078 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-11-05T19:22:10.079Z,1730834530.079 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-11-05T19:22:10.079Z,1730834530.079 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-11-05T19:22:10.079Z,1730834530.079 [CBIT](DEBUG): Powering off loads. 2024-11-05T19:22:10.091Z,1730834530.091 [CBIT](DEBUG): Disabling WDT. 2024-11-05T19:22:10.102Z,1730834530.102 [CBIT](DEBUG): Opening all GF detection circuits. 2024-11-05T19:22:10.104Z,1730834530.104 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-11-05T19:22:10.144Z,1730834530.144 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-11-05T19:22:10.147Z,1730834530.147 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-11-05T19:22:10.152Z,1730834530.152 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-11-05T19:22:10.159Z,1730834530.159 [DAT ThreadHandler](INFO): Thread cancelled. 2024-11-05T19:22:10.200Z,1730834530.200 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-11-05T19:22:10.292Z,1730834530.292 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-11-05T19:22:10.296Z,1730834530.296 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-11-05T19:22:10.315Z,1730834530.315 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-11-05T19:22:10.362Z,1730834530.362 [logger ThreadHandler](INFO): Thread cancelled.