2024-02-14T01:37:02.619Z,1707874622.619 [Supervisor](DEBUG): Initializing supervisor. 2024-02-14T01:37:02.624Z,1707874622.624 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-02-14T01:37:02.625Z,1707874622.625 [SyncHandler](INFO): Protected caller Thread ID is 413 2024-02-14T01:37:02.625Z,1707874622.625 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-02-14T01:37:02.626Z,1707874622.626 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-02-14T01:37:02.627Z,1707874622.627 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 415 2024-02-14T01:37:02.631Z,1707874622.631 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-02-14T01:37:02.649Z,1707874622.649 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-02-14T01:37:02.650Z,1707874622.650 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-02-14T01:37:02.650Z,1707874622.650 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 416 2024-02-14T01:37:02.654Z,1707874622.654 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-02-14T01:37:02.655Z,1707874622.655 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-02-14T01:37:02.656Z,1707874622.656 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 417 2024-02-14T01:37:02.658Z,1707874622.658 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-02-14T01:37:02.659Z,1707874622.659 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-02-14T01:37:02.659Z,1707874622.659 [logger ThreadHandler](INFO): Protected caller Thread ID is 418 2024-02-14T01:37:02.663Z,1707874622.663 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-02-14T01:37:02.663Z,1707874622.663 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-02-14T01:37:02.665Z,1707874622.665 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-02-14T01:37:03.005Z,1707874623.005 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-02-14T01:37:03.005Z,1707874623.005 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-02-14T01:37:03.088Z,1707874623.088 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-02-14T01:37:03.198Z,1707874623.198 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-02-14T01:37:03.198Z,1707874623.198 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-02-14T01:37:03.332Z,1707874623.332 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-02-14T01:37:03.332Z,1707874623.332 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-02-14T01:37:03.689Z,1707874623.689 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-02-14T01:37:03.689Z,1707874623.689 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-02-14T01:37:03.788Z,1707874623.788 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-02-14T01:37:03.788Z,1707874623.788 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-02-14T01:37:04.201Z,1707874624.201 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-02-14T01:37:04.201Z,1707874624.201 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-02-14T01:37:04.419Z,1707874624.419 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-02-14T01:37:04.420Z,1707874624.420 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-02-14T01:37:04.501Z,1707874624.501 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-02-14T01:37:04.745Z,1707874624.745 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-02-14T01:37:04.746Z,1707874624.746 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-02-14T01:37:04.973Z,1707874624.973 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-02-14T01:37:04.974Z,1707874624.974 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-02-14T01:37:05.508Z,1707874625.508 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-02-14T01:37:05.509Z,1707874625.509 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-02-14T01:37:05.711Z,1707874625.711 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-02-14T01:37:05.711Z,1707874625.711 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-02-14T01:37:06.011Z,1707874626.011 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-02-14T01:37:06.011Z,1707874626.011 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-02-14T01:37:06.852Z,1707874626.852 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-02-14T01:37:06.853Z,1707874626.853 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-02-14T01:37:07.409Z,1707874627.409 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-02-14T01:37:07.411Z,1707874627.411 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/ 2024-02-14T01:37:07.412Z,1707874627.412 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Control.cfg 2024-02-14T01:37:07.514Z,1707874627.514 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Science.cfg 2024-02-14T01:37:07.637Z,1707874627.637 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/secure.cfg 2024-02-14T01:37:07.722Z,1707874627.722 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Servo.cfg 2024-02-14T01:37:07.834Z,1707874627.834 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/BIT.cfg 2024-02-14T01:37:07.938Z,1707874627.938 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Battery.cfg 2024-02-14T01:37:08.202Z,1707874628.202 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-02-14T01:37:08.202Z,1707874628.202 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/vehicle.cfg 2024-02-14T01:37:08.320Z,1707874628.320 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/logger.cfg 2024-02-14T01:37:08.417Z,1707874628.417 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Navigation.cfg 2024-02-14T01:37:08.523Z,1707874628.523 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Sensor.cfg 2024-02-14T01:37:08.662Z,1707874628.662 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Simulator.cfg 2024-02-14T01:37:08.751Z,1707874628.751 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/root/ 2024-02-14T01:37:08.751Z,1707874628.751 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2024-02-14T01:37:08.758Z,1707874628.758 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-02-14T01:37:08.869Z,1707874628.869 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-02-14T01:37:08.869Z,1707874628.869 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-02-14T01:37:08.920Z,1707874628.920 [VerticalControl](DEBUG): Construct VerticalControl. 2024-02-14T01:37:08.980Z,1707874628.980 [VerticalControl] Loaded 2024-02-14T01:37:08.981Z,1707874628.981 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-02-14T01:37:08.984Z,1707874628.984 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-02-14T01:37:09.025Z,1707874629.025 [HorizontalControl] Loaded 2024-02-14T01:37:09.025Z,1707874629.025 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-02-14T01:37:09.028Z,1707874629.028 [SpeedControl](DEBUG): Construct SpeedControl. 2024-02-14T01:37:09.031Z,1707874629.031 [SpeedControl] Loaded 2024-02-14T01:37:09.031Z,1707874629.031 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-02-14T01:37:09.034Z,1707874629.034 [LoopControl](DEBUG): Construct LoopControl. 2024-02-14T01:37:09.034Z,1707874629.034 [LoopControl] Loaded 2024-02-14T01:37:09.034Z,1707874629.034 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-02-14T01:37:09.035Z,1707874629.035 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-02-14T01:37:09.035Z,1707874629.035 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-02-14T01:37:09.091Z,1707874629.091 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-02-14T01:37:09.091Z,1707874629.091 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-02-14T01:37:09.536Z,1707874629.536 [AHRS_M2] Loaded 2024-02-14T01:37:09.537Z,1707874629.537 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2024-02-14T01:37:09.572Z,1707874629.572 [BackseatComponent] Loaded 2024-02-14T01:37:09.573Z,1707874629.573 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2024-02-14T01:37:09.574Z,1707874629.574 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 4088A4E0 2024-02-14T01:37:09.574Z,1707874629.574 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 500 2024-02-14T01:37:09.577Z,1707874629.577 [LcmUniversalReporter] Loaded 2024-02-14T01:37:09.577Z,1707874629.577 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2024-02-14T01:37:10.395Z,1707874630.395 [BPC1] Loaded 2024-02-14T01:37:10.395Z,1707874630.395 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-02-14T01:37:10.467Z,1707874630.467 [DataOverHttps] Loaded 2024-02-14T01:37:10.468Z,1707874630.468 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-02-14T01:37:10.469Z,1707874630.469 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408BA4E0 2024-02-14T01:37:10.469Z,1707874630.469 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 501 2024-02-14T01:37:10.490Z,1707874630.490 [Depth_Keller] Loaded 2024-02-14T01:37:10.490Z,1707874630.490 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-02-14T01:37:10.495Z,1707874630.495 [DropWeight] Loaded 2024-02-14T01:37:10.495Z,1707874630.495 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2024-02-14T01:37:10.558Z,1707874630.558 [NAL9602] Loaded 2024-02-14T01:37:10.559Z,1707874630.559 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-02-14T01:37:10.588Z,1707874630.588 [Onboard] Loaded 2024-02-14T01:37:10.589Z,1707874630.589 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-02-14T01:37:10.589Z,1707874630.589 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408EA4E0 2024-02-14T01:37:10.590Z,1707874630.590 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 502 2024-02-14T01:37:10.602Z,1707874630.602 [Power24vConverter] Loaded 2024-02-14T01:37:10.602Z,1707874630.602 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-02-14T01:37:10.615Z,1707874630.615 [Radio_Surface] Loaded 2024-02-14T01:37:10.616Z,1707874630.616 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-02-14T01:37:10.617Z,1707874630.617 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4091A4E0 2024-02-14T01:37:10.617Z,1707874630.617 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 503 2024-02-14T01:37:10.631Z,1707874630.631 [Sonardyne_Nano] Loaded 2024-02-14T01:37:10.631Z,1707874630.631 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2024-02-14T01:37:10.723Z,1707874630.723 [DAT] Loaded 2024-02-14T01:37:10.723Z,1707874630.723 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2024-02-14T01:37:10.724Z,1707874630.724 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 4094A4E0 2024-02-14T01:37:10.725Z,1707874630.725 [DAT ThreadHandler](INFO): Protected caller Thread ID is 504 2024-02-14T01:37:10.747Z,1707874630.747 [Waterlinked] Loaded 2024-02-14T01:37:10.748Z,1707874630.748 [ComponentRegistry](DEBUG): SyncComponent "Waterlinked" handled in the control thread. 2024-02-14T01:37:10.748Z,1707874630.748 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-02-14T01:37:10.749Z,1707874630.749 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-02-14T01:37:10.759Z,1707874630.759 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-02-14T01:37:10.760Z,1707874630.760 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-02-14T01:37:10.786Z,1707874630.786 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-02-14T01:37:10.786Z,1707874630.786 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-02-14T01:37:10.924Z,1707874630.924 [SBIT](DEBUG): Construct Startup Built In Test. 2024-02-14T01:37:10.933Z,1707874630.933 [SBIT] Loaded 2024-02-14T01:37:10.933Z,1707874630.933 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-02-14T01:37:10.936Z,1707874630.936 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-02-14T01:37:10.949Z,1707874630.949 [IBIT] Loaded 2024-02-14T01:37:10.949Z,1707874630.949 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-02-14T01:37:10.955Z,1707874630.955 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-02-14T01:37:11.060Z,1707874631.060 [CBIT] Loaded 2024-02-14T01:37:11.061Z,1707874631.061 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-02-14T01:37:11.061Z,1707874631.061 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-02-14T01:37:11.061Z,1707874631.061 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-02-14T01:37:11.390Z,1707874631.390 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-02-14T01:37:11.390Z,1707874631.390 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-02-14T01:37:11.439Z,1707874631.439 [DepthRateCalculator] Loaded 2024-02-14T01:37:11.440Z,1707874631.440 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-02-14T01:37:11.445Z,1707874631.445 [PitchRateCalculator] Loaded 2024-02-14T01:37:11.445Z,1707874631.445 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-02-14T01:37:11.455Z,1707874631.455 [SpeedCalculator] Loaded 2024-02-14T01:37:11.456Z,1707874631.456 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-02-14T01:37:11.460Z,1707874631.460 [YawRateCalculator] Loaded 2024-02-14T01:37:11.460Z,1707874631.460 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-02-14T01:37:11.479Z,1707874631.479 [ElevatorOffsetCalculator] Loaded 2024-02-14T01:37:11.479Z,1707874631.479 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-02-14T01:37:11.480Z,1707874631.480 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-02-14T01:37:11.480Z,1707874631.480 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-02-14T01:37:11.629Z,1707874631.629 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-02-14T01:37:11.630Z,1707874631.630 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-02-14T01:37:11.741Z,1707874631.741 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-02-14T01:37:11.741Z,1707874631.741 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-02-14T01:37:11.785Z,1707874631.785 [DeadReckonUsingSpeedCalculator] Loaded 2024-02-14T01:37:11.785Z,1707874631.785 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2024-02-14T01:37:11.828Z,1707874631.828 [DeadReckonWithRespectToSeafloor] Loaded 2024-02-14T01:37:11.828Z,1707874631.828 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread. 2024-02-14T01:37:11.841Z,1707874631.841 [NavChart] Loaded 2024-02-14T01:37:11.842Z,1707874631.842 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-02-14T01:37:11.847Z,1707874631.847 [UniversalFixResidualReporter] Loaded 2024-02-14T01:37:11.848Z,1707874631.848 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-02-14T01:37:11.848Z,1707874631.848 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-02-14T01:37:11.849Z,1707874631.849 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-02-14T01:37:11.992Z,1707874631.992 [BuoyancyServo] Loaded 2024-02-14T01:37:11.992Z,1707874631.992 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-02-14T01:37:12.013Z,1707874632.013 [ElevatorServo] Loaded 2024-02-14T01:37:12.013Z,1707874632.013 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-02-14T01:37:12.033Z,1707874632.033 [MassServo] Loaded 2024-02-14T01:37:12.033Z,1707874632.033 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-02-14T01:37:12.052Z,1707874632.052 [RudderServo] Loaded 2024-02-14T01:37:12.053Z,1707874632.053 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-02-14T01:37:12.068Z,1707874632.068 [ThrusterHE] Loaded 2024-02-14T01:37:12.068Z,1707874632.068 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2024-02-14T01:37:12.068Z,1707874632.068 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-02-14T01:37:12.069Z,1707874632.069 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-02-14T01:37:12.242Z,1707874632.242 [CTD_Seabird] Loaded 2024-02-14T01:37:12.242Z,1707874632.242 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2024-02-14T01:37:12.243Z,1707874632.243 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40BB14E0 2024-02-14T01:37:12.244Z,1707874632.244 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 505 2024-02-14T01:37:12.277Z,1707874632.277 [ESPComponent] Loaded 2024-02-14T01:37:12.277Z,1707874632.277 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2024-02-14T01:37:12.298Z,1707874632.298 [PAR_Licor] Loaded 2024-02-14T01:37:12.298Z,1707874632.298 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-02-14T01:37:12.339Z,1707874632.339 [WetLabsBB2FL] Loaded 2024-02-14T01:37:12.339Z,1707874632.339 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2024-02-14T01:37:12.340Z,1707874632.340 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40BE14E0 2024-02-14T01:37:12.341Z,1707874632.341 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 506 2024-02-14T01:37:12.341Z,1707874632.341 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-02-14T01:37:12.348Z,1707874632.348 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-02-14T01:37:12.351Z,1707874632.351 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-02-14T01:37:12.362Z,1707874632.362 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-02-14T01:37:12.363Z,1707874632.363 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C114E0 2024-02-14T01:37:12.363Z,1707874632.363 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 507 2024-02-14T01:37:12.368Z,1707874632.368 [Supervisor](INFO): Main Thread ID is 9961 2024-02-14T01:37:12.368Z,1707874632.368 [Supervisor](DEBUG): Running supervisor. 2024-02-14T01:37:12.368Z,1707874632.368 [CommandExec ThreadHandler](INFO): Handler Thread ID is 508 2024-02-14T01:37:12.369Z,1707874632.369 [CommandExec](INFO): Initializing the command executive. 2024-02-14T01:37:12.370Z,1707874632.370 [CommandLine ThreadHandler](INFO): Handler Thread ID is 509 2024-02-14T01:37:12.373Z,1707874632.373 [controlThread ThreadHandler](INFO): Handler Thread ID is 510 2024-02-14T01:37:12.373Z,1707874632.373 [controlThread](DEBUG): Initializing ControlThread 2024-02-14T01:37:12.374Z,1707874632.374 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-02-14T01:37:12.376Z,1707874632.376 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-02-14T01:37:12.376Z,1707874632.376 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-02-14T01:37:12.377Z,1707874632.377 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-02-14T01:37:12.381Z,1707874632.381 [SBIT](INFO): Initialize SBIT Component. 2024-02-14T01:37:12.381Z,1707874632.381 [SBIT](IMPORTANT): git: 2024-02-14 2024-02-14T01:37:12.382Z,1707874632.382 [SBIT](INFO): git hash: 8fc4e848ca047b5de9ae8a7c02f55958c6301ab2 2024-02-14T01:37:12.382Z,1707874632.382 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-02-14T01:37:12.383Z,1707874632.383 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #639 PREEMPT Wed Mar 12 12:53:33 PDT 2014 Kernel Reported: #1 PREEMPT Tue Nov 28 15:04:22 PST 2023 2024-02-14T01:37:12.384Z,1707874632.384 [SBIT](INFO): Beginning SBIT in 88.000000 seconds. 2024-02-14T01:37:12.385Z,1707874632.385 [IBIT](INFO): Initialize IBIT Component. 2024-02-14T01:37:12.386Z,1707874632.386 [CBIT](DEBUG): Initialize CBIT Component. 2024-02-14T01:37:12.387Z,1707874632.387 [logger ThreadHandler](INFO): Handler Thread ID is 511 2024-02-14T01:37:12.399Z,1707874632.399 [CBIT](DEBUG): Initialized mux pins. 2024-02-14T01:37:12.399Z,1707874632.399 [CBIT](DEBUG): Initializing the watchdog timer. 2024-02-14T01:37:12.407Z,1707874632.407 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 512 2024-02-14T01:37:12.419Z,1707874632.419 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 513 2024-02-14T01:37:12.421Z,1707874632.421 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-02-14T01:37:12.423Z,1707874632.423 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-02-14T01:37:12.423Z,1707874632.423 [CBIT](DEBUG): Initializing heartbeat. 2024-02-14T01:37:12.431Z,1707874632.431 [Onboard ThreadHandler](INFO): Handler Thread ID is 514 2024-02-14T01:37:12.449Z,1707874632.449 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 515 2024-02-14T01:37:12.472Z,1707874632.472 [DAT ThreadHandler](INFO): Handler Thread ID is 516 2024-02-14T01:37:12.472Z,1707874632.472 [DAT](INFO): Powering up 2024-02-14T01:37:12.473Z,1707874632.473 [DAT](DEBUG): Initializing DAT. 2024-02-14T01:37:12.476Z,1707874632.476 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 518 2024-02-14T01:37:12.477Z,1707874632.477 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-02-14T01:37:12.480Z,1707874632.480 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 520 2024-02-14T01:37:12.483Z,1707874632.483 [WetLabsBB2FL](INFO): Powering up 2024-02-14T01:37:12.485Z,1707874632.485 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 522 2024-02-14T01:37:12.488Z,1707874632.488 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2HA05M.000 2024-02-14T01:37:12.488Z,1707874632.488 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2HA05M.000 2024-02-14T01:37:12.488Z,1707874632.488 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3HA20M.000 2024-02-14T01:37:12.488Z,1707874632.488 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3HA20M.000 2024-02-14T01:37:12.488Z,1707874632.488 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000 2024-02-14T01:37:12.489Z,1707874632.489 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4HA51M.000 2024-02-14T01:37:12.489Z,1707874632.489 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000 2024-02-14T01:37:12.489Z,1707874632.489 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4HA51M.000 2024-02-14T01:37:12.489Z,1707874632.489 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA53M.000 2024-02-14T01:37:12.489Z,1707874632.489 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5HA53M.000 2024-02-14T01:37:12.489Z,1707874632.489 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA55M.000 2024-02-14T01:37:12.489Z,1707874632.489 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5HA55M.000 2024-02-14T01:37:12.495Z,1707874632.495 [CBIT](DEBUG): Deactivating GF circuits. 2024-02-14T01:37:12.496Z,1707874632.496 [CBIT](DEBUG): Deactivating emergency mode. 2024-02-14T01:37:12.535Z,1707874632.535 [CBIT](DEBUG): Backplane powered. 2024-02-14T01:37:12.535Z,1707874632.535 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-02-14T01:37:12.536Z,1707874632.536 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-02-14T01:37:12.536Z,1707874632.536 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-02-14T01:37:12.536Z,1707874632.536 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-02-14T01:37:12.537Z,1707874632.537 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-02-14T01:37:12.538Z,1707874632.538 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-02-14T01:37:12.539Z,1707874632.539 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-02-14T01:37:12.539Z,1707874632.539 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-02-14T01:37:12.544Z,1707874632.544 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2024-02-14T01:37:12.544Z,1707874632.544 [MissionManager](IMPORTANT): Loading Compiled TethysL script from file Missions/Startup.tx 2024-02-14T01:37:12.565Z,1707874632.565 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-02-14T01:37:12.609Z,1707874632.609 [MissionManager](DEBUG): 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-02-14T01:37:12.610Z,1707874632.610 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2024-02-14T01:37:12.610Z,1707874632.610 [MissionManager](IMPORTANT): Loading Compiled TethysL script from file Missions/Default.tx 2024-02-14T01:37:12.686Z,1707874632.686 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2024-02-14T01:37:12.712Z,1707874632.712 [Default:A.Wait](DEBUG): Construct Wait. 2024-02-14T01:37:12.714Z,1707874632.714 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2024-02-14T01:37:12.742Z,1707874632.742 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-02-14T01:37:12.761Z,1707874632.761 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-02-14T01:37:12.779Z,1707874632.779 [Default:E.Execute](DEBUG): Construct Execute. 2024-02-14T01:37:12.782Z,1707874632.782 [MissionManager](DEBUG): 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-02-14T01:37:12.803Z,1707874632.803 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Sonardyne_Nano,Waterlinked,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-02-14T01:37:12.809Z,1707874632.809 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-02-14T01:37:12.855Z,1707874632.855 [Radio_Surface](INFO): Powering up 2024-02-14T01:37:12.880Z,1707874632.880 [Depth_Keller](ERROR): Pressure or depth reading out of range: -1.140412 decibar, -1.132002 m 2024-02-14T01:37:12.885Z,1707874632.885 [Power24vConverter](INFO): Powering up. 2024-02-14T01:37:12.885Z,1707874632.885 [Sonardyne_Nano](INFO): Initializing. 2024-02-14T01:37:12.917Z,1707874632.917 [DepthRateCalculator](ERROR): Depth measurement is not active 2024-02-14T01:37:12.969Z,1707874632.969 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-02-14T01:37:12.976Z,1707874632.976 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-02-14T01:37:12.977Z,1707874632.977 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-02-14T01:37:12.984Z,1707874632.984 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-02-14T01:37:12.984Z,1707874632.984 [MassServo](DEBUG): Initializing EZServoServo. 2024-02-14T01:37:12.991Z,1707874632.991 [MassServo](DEBUG): Initializing MassServo. 2024-02-14T01:37:12.992Z,1707874632.992 [RudderServo](DEBUG): Initializing EZServoServo. 2024-02-14T01:37:12.999Z,1707874632.999 [RudderServo](DEBUG): Initializing RudderServo. 2024-02-14T01:37:12.000Z,1707874633.000 [ThrusterHE](DEBUG): Initializing EZServoServo. 2024-02-14T01:37:13.007Z,1707874633.007 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2024-02-14T01:37:14.591Z,1707874634.591 [WetLabsBB2FL](INFO): Powering down 2024-02-14T01:37:14.833Z,1707874634.833 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2024-02-14T01:37:16.120Z,1707874636.120 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2311 2024-02-14T01:37:16.487Z,1707874636.487 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging 2024-02-14T01:37:18.700Z,1707874638.700 [ThrusterHE](ERROR): Zero Speed Commanded. 2024-02-14T01:37:40.792Z,1707874660.792 [NAL9602](INFO): Powering up NAL9602 2024-02-14T01:37:51.739Z,1707874671.739 [NAL9602](INFO): NAL9602 initialized 2024-02-14T01:38:09.236Z,1707874689.236 [CommandExec](IMPORTANT): got command strobe off 2024-02-14T01:38:09.236Z,1707874689.236 [CommandExec](IMPORTANT): Deactivating strobe 2024-02-14T01:38:12.476Z,1707874692.476 [DAT](FAULT): failed to initialize, no bytes available on serial interface 2024-02-14T01:38:12.476Z,1707874692.476 [DAT] Communications Fault, FailCount= 1 2024-02-14T01:38:12.476Z,1707874692.476 [DAT](ERROR): Communications Fault 2024-02-14T01:38:12.864Z,1707874692.864 [CBIT](ERROR): Communications Fault in component: DAT 2024-02-14T01:38:12.879Z,1707874692.879 [DAT](INFO): Powering down 2024-02-14T01:38:13.978Z,1707874693.978 [CBIT](INFO): Clearing failed state for component DAT 2024-02-14T01:38:13.978Z,1707874693.978 [DAT] No Fault, FailCount= 1 2024-02-14T01:38:15.924Z,1707874695.924 [DAT](INFO): Powering up 2024-02-14T01:38:15.925Z,1707874695.925 [DAT](DEBUG): Initializing DAT. 2024-02-14T01:38:21.220Z,1707874701.220 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-02-14T01:38:36.248Z,1707874716.248 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-02-14T01:38:36.347Z,1707874716.347 [Waterlinked](INFO): Powering down 2024-02-14T01:38:40.193Z,1707874720.193 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-02-14T01:38:41.035Z,1707874721.035 [SBIT](IMPORTANT): Beginning Startup BIT 2024-02-14T01:38:41.043Z,1707874721.043 [CBIT](IMPORTANT): Beginning ground fault scan 2024-02-14T01:38:52.156Z,1707874732.156 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.001013 CHAN A1 (24V): 0.000839 CHAN A2 (12V): 0.000059 CHAN A3 (5V): -0.000947 CHAN B0 (3.3V): -0.000449 CHAN B1 (3.15aV): -0.000128 CHAN B2 (3.15bV): 0.000523 CHAN B3 (GND): -0.000235 OPEN: 0.006522 Full Scale: +/- 1 mA 2024-02-14T01:38:58.776Z,1707874738.776 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-02-14T01:39:16.171Z,1707874756.171 [DAT](FAULT): failed to initialize, no bytes available on serial interface 2024-02-14T01:39:16.171Z,1707874756.171 [DAT] Communications Fault, FailCount= 2 2024-02-14T01:39:16.171Z,1707874756.171 [DAT](ERROR): Communications Fault 2024-02-14T01:39:16.176Z,1707874756.176 [CBIT](ERROR): Communications Fault in component: DAT 2024-02-14T01:39:16.575Z,1707874756.575 [DAT](INFO): Powering down 2024-02-14T01:39:17.360Z,1707874757.360 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-02-14T01:39:17.819Z,1707874757.819 [CBIT](INFO): Clearing failed state for component DAT 2024-02-14T01:39:17.819Z,1707874757.819 [DAT] No Fault, FailCount= 2 2024-02-14T01:39:19.623Z,1707874759.623 [DAT](INFO): Powering up 2024-02-14T01:39:19.623Z,1707874759.623 [DAT](DEBUG): Initializing DAT. 2024-02-14T01:39:33.172Z,1707874773.172 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-02-14T01:39:35.216Z,1707874775.216 [SBIT](IMPORTANT): SBIT PASSED 2024-02-14T01:39:35.216Z,1707874775.216 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2024-02-14T01:39:35.217Z,1707874775.217 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=10 count; 2024-02-14T01:39:35.217Z,1707874775.217 [SBIT](IMPORTANT): Express linearApproximation CTD_Seabird.bin_median_sea_water_salinity 0.050000 practical_salinity_unit; 2024-02-14T01:39:35.217Z,1707874775.217 [SBIT](IMPORTANT): Express linearApproximation _.planktivore_LM_AvgRois 50.000000 count_per_second; 2024-02-14T01:39:35.217Z,1707874775.217 [SBIT](IMPORTANT): Express linearApproximation height_above_sea_floor 5.000000 meter; 2024-02-14T01:39:35.217Z,1707874775.217 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=261.788552 cubic_centimeter; 2024-02-14T01:39:35.217Z,1707874775.217 [SBIT](IMPORTANT): VerticalControl.massDefault=17.131162 millimeter; 2024-02-14T01:39:35.540Z,1707874775.540 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-02-14T01:39:35.595Z,1707874775.595 [MissionManager](IMPORTANT): Started mission Startup 2024-02-14T01:39:35.596Z,1707874775.596 [Startup] Running Loop=1 2024-02-14T01:39:35.596Z,1707874775.596 [Startup](DEBUG): Aggregate::initialize Startup 2024-02-14T01:39:35.596Z,1707874775.596 [Startup:A.GoToSurface] Running Loop=1 2024-02-14T01:39:35.596Z,1707874775.596 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-02-14T01:39:35.596Z,1707874775.596 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-02-14T01:39:35.597Z,1707874775.597 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-02-14T01:39:35.597Z,1707874775.597 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-02-14T01:39:35.598Z,1707874775.598 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-02-14T01:39:35.598Z,1707874775.598 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-02-14T01:39:35.608Z,1707874775.608 [Startup:StartupSatComms] Running Loop=1 2024-02-14T01:39:35.608Z,1707874775.608 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2024-02-14T01:39:35.608Z,1707874775.608 [Startup:StartupSatComms:A] Running Loop=1 2024-02-14T01:39:35.987Z,1707874775.987 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2024-02-14T01:39:54.124Z,1707874794.124 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-02-14T01:39:55.357Z,1707874795.357 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004797 2024-02-14T01:40:11.904Z,1707874811.904 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2024-02-14T01:40:12.748Z,1707874812.748 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2024-02-14T01:40:12.748Z,1707874812.748 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-02-14T01:40:12.749Z,1707874812.749 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1 2024-02-14T01:40:12.749Z,1707874812.749 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-02-14T01:40:12.751Z,1707874812.751 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-02-14T01:40:12.751Z,1707874812.751 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-02-14T01:40:12.762Z,1707874812.762 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-02-14T01:40:12.762Z,1707874812.762 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-02-14T01:40:12.763Z,1707874812.763 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-02-14T01:40:13.137Z,1707874813.137 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-02-14T01:40:13.137Z,1707874813.137 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2024-02-14T01:40:13.138Z,1707874813.138 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-02-14T01:40:13.138Z,1707874813.138 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1 2024-02-14T01:40:13.138Z,1707874813.138 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-02-14T01:40:13.139Z,1707874813.139 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-02-14T01:40:13.533Z,1707874813.533 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-02-14T01:40:19.867Z,1707874819.867 [DAT](FAULT): failed to initialize, no bytes available on serial interface 2024-02-14T01:40:19.867Z,1707874819.867 [DAT] Communications Fault, FailCount= 3 2024-02-14T01:40:19.867Z,1707874819.867 [DAT](ERROR): Communications Fault 2024-02-14T01:40:20.019Z,1707874820.019 [CBIT](ERROR): Communications Fault in component: DAT 2024-02-14T01:40:20.271Z,1707874820.271 [DAT](INFO): Powering down 2024-02-14T01:40:21.259Z,1707874821.259 [CBIT](INFO): Clearing failed state for component DAT 2024-02-14T01:40:21.259Z,1707874821.259 [DAT] No Fault, FailCount= 3 2024-02-14T01:40:23.319Z,1707874823.319 [DAT](INFO): Powering up 2024-02-14T01:40:23.319Z,1707874823.319 [DAT](DEBUG): Initializing DAT. 2024-02-14T01:40:35.755Z,1707874835.755 [Startup:StartupSatComms:A](INFO): Timed out from 2024-02-14T01:39:35.6Z 2024-02-14T01:40:35.755Z,1707874835.755 [Startup:StartupSatComms:A] Stopped 2024-02-14T01:40:35.755Z,1707874835.755 [Startup:StartupSatComms:B] Running Loop=1 2024-02-14T01:40:36.164Z,1707874836.164 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-02-14T01:40:42.991Z,1707874842.991 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240214T011414/Courier0010.lzma 2024-02-14T01:40:43.993Z,1707874843.993 [DataOverHttps](INFO): Moved sent file to Logs/20240214T011414/Courier0010.lzma.bak 2024-02-14T01:40:43.993Z,1707874843.993 [DataOverHttps](INFO): SBD MOMSN=19277591 2024-02-14T01:41:01.337Z,1707874861.337 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20240214T013702/Courier0000.lzma 2024-02-14T01:41:01.749Z,1707874861.749 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-02-14T01:41:02.329Z,1707874862.329 [DataOverHttps](INFO): Moved sent file to Logs/20240214T013702/Courier0000.lzma.bak 2024-02-14T01:41:02.329Z,1707874862.329 [DataOverHttps](INFO): SBD MOMSN=19277593 2024-02-14T01:41:13.866Z,1707874873.866 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-02-14T01:41:18.106Z,1707874878.106 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20240214T011414/Express0011.lzma 2024-02-14T01:41:19.109Z,1707874879.109 [DataOverHttps](INFO): Moved sent file to Logs/20240214T011414/Express0011.lzma.bak 2024-02-14T01:41:19.109Z,1707874879.109 [DataOverHttps](INFO): SBD MOMSN=19277596 2024-02-14T01:41:23.351Z,1707874883.351 [DAT](FAULT): failed to initialize, no bytes available on serial interface 2024-02-14T01:41:23.351Z,1707874883.351 [DAT] Communications Fault, FailCount= 4 2024-02-14T01:41:23.351Z,1707874883.351 [DAT](ERROR): Communications Fault 2024-02-14T01:41:23.516Z,1707874883.516 [CBIT](ERROR): Communications Fault in component: DAT 2024-02-14T01:41:23.755Z,1707874883.755 [DAT](INFO): Powering down 2024-02-14T01:41:24.748Z,1707874884.748 [CBIT](INFO): Clearing failed state for component DAT 2024-02-14T01:41:24.748Z,1707874884.748 [DAT] No Fault, FailCount= 4 2024-02-14T01:41:26.803Z,1707874886.803 [DAT](INFO): Powering up 2024-02-14T01:41:26.803Z,1707874886.803 [DAT](DEBUG): Initializing DAT. 2024-02-14T01:41:34.716Z,1707874894.716 [DataOverHttps](INFO): Sending 1069 bytes from file Logs/20240214T013702/Express0001.lzma 2024-02-14T01:41:35.717Z,1707874895.717 [DataOverHttps](INFO): Moved sent file to Logs/20240214T013702/Express0001.lzma.bak 2024-02-14T01:41:35.717Z,1707874895.717 [DataOverHttps](INFO): SBD MOMSN=19277600 2024-02-14T01:41:36.002Z,1707874896.002 [Startup:StartupSatComms:B](INFO): Timed out from 2024-02-14T01:40:35.8Z 2024-02-14T01:41:36.002Z,1707874896.002 [Startup:StartupSatComms:B] Stopped 2024-02-14T01:41:36.003Z,1707874896.003 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2024-02-14T01:41:36.003Z,1707874896.003 [Startup:StartupSatComms] Stopped 2024-02-14T01:41:36.004Z,1707874896.004 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2024-02-14T01:41:36.004Z,1707874896.004 [Startup](INFO): Completed Startup 2024-02-14T01:41:36.004Z,1707874896.004 [MissionManager](INFO): Startup is completed. 2024-02-14T01:41:36.005Z,1707874896.005 [MissionManager](INFO): Uninitializing Mission Startup 2024-02-14T01:41:36.005Z,1707874896.005 [Startup] Stopped 2024-02-14T01:41:36.005Z,1707874896.005 [Startup](DEBUG): Aggregate::uninitialize Startup 2024-02-14T01:41:36.005Z,1707874896.005 [Startup:A.GoToSurface] Stopped 2024-02-14T01:41:36.005Z,1707874896.005 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-02-14T01:41:36.418Z,1707874896.418 [MissionManager](IMPORTANT): Started mission Default 2024-02-14T01:41:36.419Z,1707874896.419 [Default] Running Loop=1 2024-02-14T01:41:36.419Z,1707874896.419 [Default](DEBUG): Aggregate::initialize Default 2024-02-14T01:41:36.419Z,1707874896.419 [Default:B.GoToSurface] Running Loop=1 2024-02-14T01:41:36.419Z,1707874896.419 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-02-14T01:41:36.420Z,1707874896.420 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-02-14T01:41:36.420Z,1707874896.420 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-02-14T01:41:36.420Z,1707874896.420 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-02-14T01:41:36.421Z,1707874896.421 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-02-14T01:41:36.421Z,1707874896.421 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-02-14T01:41:36.421Z,1707874896.421 [Default:A.Wait] Running Loop=1 2024-02-14T01:41:36.421Z,1707874896.421 [Default:A.Wait](DEBUG): Initialize Wait Component. 2024-02-14T01:41:49.738Z,1707874909.738 [Default:A.Wait](INFO): Done Waiting. 2024-02-14T01:41:49.738Z,1707874909.738 [Default:A.Wait] Stopped 2024-02-14T01:41:49.738Z,1707874909.738 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2024-02-14T01:41:50.163Z,1707874910.163 [Default:CheckIn] Running Loop=1 2024-02-14T01:41:50.163Z,1707874910.163 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-02-14T01:41:50.163Z,1707874910.163 [Default:CheckIn:Read_GPS] Running Loop=1 2024-02-14T01:41:50.567Z,1707874910.567 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2024-02-14T01:42:26.843Z,1707874946.843 [DAT](FAULT): failed to initialize, no bytes available on serial interface 2024-02-14T01:42:26.843Z,1707874946.843 [DAT] Communications Fault, FailCount= 5 2024-02-14T01:42:26.843Z,1707874946.843 [DAT](ERROR): Communications Fault 2024-02-14T01:42:26.948Z,1707874946.948 [CBIT](ERROR): Communications Fault in component: DAT 2024-02-14T01:42:27.247Z,1707874947.247 [DAT](INFO): Powering down 2024-02-14T01:42:28.184Z,1707874948.184 [CBIT](INFO): Clearing failed state for component DAT 2024-02-14T01:42:28.184Z,1707874948.184 [DAT] No Fault, FailCount= 5 2024-02-14T01:42:30.299Z,1707874950.299 [DAT](INFO): Powering up 2024-02-14T01:42:30.299Z,1707874950.299 [DAT](DEBUG): Initializing DAT. 2024-02-14T01:42:35.838Z,1707874955.838 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-02-14T01:42:41.901Z,1707874961.901 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-02-14T01:42:55.176Z,1707874975.176 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-02-14T01:42:57.995Z,1707874977.995 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-02-14T01:43:13.790Z,1707874993.790 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2024-02-14T01:43:13.790Z,1707874993.790 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-02-14T01:43:13.791Z,1707874993.791 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2 2024-02-14T01:43:13.791Z,1707874993.791 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-02-14T01:43:13.793Z,1707874993.793 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-02-14T01:43:13.793Z,1707874993.793 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-02-14T01:43:13.840Z,1707874993.840 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-02-14T01:43:13.840Z,1707874993.840 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-02-14T01:43:13.840Z,1707874993.840 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-02-14T01:43:14.200Z,1707874994.200 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-02-14T01:43:14.200Z,1707874994.200 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2024-02-14T01:43:14.200Z,1707874994.200 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-02-14T01:43:14.200Z,1707874994.200 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2 2024-02-14T01:43:14.201Z,1707874994.201 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-02-14T01:43:14.201Z,1707874994.201 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-02-14T01:43:14.576Z,1707874994.576 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-02-14T01:43:15.772Z,1707874995.772 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-02-14T01:43:30.543Z,1707875010.543 [DAT](FAULT): failed to initialize, no bytes available on serial interface 2024-02-14T01:43:30.543Z,1707875010.543 [DAT] Communications Fault, FailCount= 6 2024-02-14T01:43:30.543Z,1707875010.543 [DAT](ERROR): Communications Fault 2024-02-14T01:43:30.767Z,1707875010.767 [CBIT](ERROR): Communications Fault in component: DAT 2024-02-14T01:43:30.947Z,1707875010.947 [DAT](INFO): Powering down 2024-02-14T01:43:31.932Z,1707875011.932 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-02-14T01:43:32.011Z,1707875012.011 [CBIT](INFO): Clearing failed state for component DAT 2024-02-14T01:43:32.012Z,1707875012.012 [DAT] No Fault, FailCount= 6 2024-02-14T01:43:33.995Z,1707875013.995 [DAT](INFO): Powering up 2024-02-14T01:43:33.995Z,1707875013.995 [DAT](DEBUG): Initializing DAT. 2024-02-14T01:43:44.507Z,1707875024.507 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-02-14T01:43:48.496Z,1707875028.496 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-02-14T01:44:05.466Z,1707875045.466 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-02-14T01:44:22.839Z,1707875062.839 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-02-14T01:44:27.339Z,1707875067.339 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-02-14T01:44:33.999Z,1707875073.999 [DAT](FAULT): failed to initialize, no bytes available on serial interface 2024-02-14T01:44:33.999Z,1707875073.999 [DAT] Communications Fault, FailCount= 7 2024-02-14T01:44:33.999Z,1707875073.999 [DAT](ERROR): Communications Fault 2024-02-14T01:44:34.191Z,1707875074.191 [CBIT](ERROR): Communications Fault in component: DAT 2024-02-14T01:44:34.403Z,1707875074.403 [DAT](INFO): Powering down 2024-02-14T01:44:35.411Z,1707875075.411 [CBIT](INFO): Clearing failed state for component DAT 2024-02-14T01:44:35.412Z,1707875075.412 [DAT] No Fault, FailCount= 7 2024-02-14T01:44:37.457Z,1707875077.457 [DAT](INFO): Powering up 2024-02-14T01:44:37.457Z,1707875077.457 [DAT](DEBUG): Initializing DAT. 2024-02-14T01:44:38.592Z,1707875078.592 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-02-14T01:44:54.810Z,1707875094.810 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-02-14T01:44:55.171Z,1707875095.171 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-02-14T01:45:03.649Z,1707875103.649 [BPC1](INFO): Calculating totals. Valid battery stick count: 52. Valid reserve battery stick count: 6. 2024-02-14T01:45:03.652Z,1707875103.652 [BPC1](INFO): Received data from all battery sticks. 2024-02-14T01:45:37.463Z,1707875137.463 [DAT](FAULT): failed to initialize, no bytes available on serial interface 2024-02-14T01:45:37.463Z,1707875137.463 [DAT] Communications Fault, FailCount= 8 2024-02-14T01:45:37.463Z,1707875137.463 [DAT](ERROR): Communications Fault 2024-02-14T01:45:37.629Z,1707875137.629 [CBIT](ERROR): Communications Fault in component: DAT 2024-02-14T01:45:37.630Z,1707875137.630 [CBIT](FAULT): Communications Fault in component: DAT 2024-02-14T01:45:37.871Z,1707875137.871 [DAT](INFO): Powering down 2024-02-14T01:46:14.795Z,1707875174.795 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2024-02-14T01:46:14.795Z,1707875174.795 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-02-14T01:46:14.796Z,1707875174.796 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3 2024-02-14T01:46:14.796Z,1707875174.796 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-02-14T01:46:14.797Z,1707875174.797 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 3 2024-02-14T01:46:14.797Z,1707875174.797 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-02-14T01:46:14.812Z,1707875174.812 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-02-14T01:46:14.812Z,1707875174.812 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-02-14T01:46:14.812Z,1707875174.812 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-02-14T01:46:15.170Z,1707875175.170 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-02-14T01:46:15.170Z,1707875175.170 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2024-02-14T01:46:15.170Z,1707875175.170 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-02-14T01:46:15.170Z,1707875175.170 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3 2024-02-14T01:46:15.171Z,1707875175.171 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-02-14T01:46:15.171Z,1707875175.171 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 3 2024-02-14T01:46:15.574Z,1707875175.574 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-02-14T01:46:50.315Z,1707875210.315 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-02-14T01:41:50.2Z 2024-02-14T01:46:50.315Z,1707875210.315 [Default:CheckIn:Read_GPS] Stopped 2024-02-14T01:46:50.315Z,1707875210.315 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-02-14T01:46:50.719Z,1707875210.719 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-02-14T01:46:57.642Z,1707875217.642 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20240214T013702/Courier0004.lzma 2024-02-14T01:46:58.645Z,1707875218.645 [DataOverHttps](INFO): Moved sent file to Logs/20240214T013702/Courier0004.lzma.bak 2024-02-14T01:46:58.645Z,1707875218.645 [DataOverHttps](INFO): SBD MOMSN=19277625 2024-02-14T01:47:14.043Z,1707875234.043 [DataOverHttps](INFO): Sending 300 bytes from file Logs/20240214T013702/Express0005.lzma 2024-02-14T01:47:15.045Z,1707875235.045 [DataOverHttps](INFO): Moved sent file to Logs/20240214T013702/Express0005.lzma.bak 2024-02-14T01:47:15.045Z,1707875235.045 [DataOverHttps](INFO): SBD MOMSN=19277627 2024-02-14T01:47:16.194Z,1707875236.194 [Default:CheckIn:Read_Iridium] Stopped 2024-02-14T01:47:16.195Z,1707875236.195 [Default:CheckIn:C.Wait] Running Loop=1 2024-02-14T01:47:16.195Z,1707875236.195 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-02-14T01:47:51.351Z,1707875271.351 [CommandExec](IMPORTANT): got command failComponent 2024-02-14T01:47:51.352Z,1707875271.352 [CommandExec](IMPORTANT): Failed components: 2024-02-14T01:47:51.353Z,1707875271.353 [CommandExec](IMPORTANT): DAT: Communications Fault 2024-02-14T01:47:54.141Z,1707875274.141 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-02-14T01:47:54.141Z,1707875274.141 [NAL9602] Data Fault, FailCount= 1 2024-02-14T01:47:54.141Z,1707875274.141 [NAL9602](ERROR): Data Fault 2024-02-14T01:47:54.165Z,1707875274.165 [CBIT](ERROR): Data Fault in component: NAL9602 2024-02-14T01:47:54.548Z,1707875274.548 [NAL9602](INFO): Powering down 2024-02-14T01:47:55.388Z,1707875275.388 [CBIT](INFO): Clearing failed state for component NAL9602 2024-02-14T01:47:55.388Z,1707875275.388 [NAL9602] No Fault, FailCount= 1 2024-02-14T01:48:24.844Z,1707875304.844 [NAL9602](INFO): Powering up NAL9602 2024-02-14T01:48:35.756Z,1707875315.756 [NAL9602](INFO): NAL9602 initialized 2024-02-14T01:49:15.756Z,1707875355.756 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2024-02-14T01:49:15.756Z,1707875355.756 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-02-14T01:49:15.757Z,1707875355.757 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4 2024-02-14T01:49:15.757Z,1707875355.757 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-02-14T01:49:15.758Z,1707875355.758 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 4 2024-02-14T01:49:15.758Z,1707875355.758 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-02-14T01:49:15.770Z,1707875355.770 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-02-14T01:49:15.770Z,1707875355.770 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-02-14T01:49:15.770Z,1707875355.770 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-02-14T01:49:16.180Z,1707875356.180 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-02-14T01:49:16.180Z,1707875356.180 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2024-02-14T01:49:16.181Z,1707875356.181 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-02-14T01:49:16.181Z,1707875356.181 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4 2024-02-14T01:49:16.182Z,1707875356.182 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-02-14T01:49:16.182Z,1707875356.182 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 4 2024-02-14T01:49:16.565Z,1707875356.565 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-02-14T01:49:17.783Z,1707875357.783 [Power24vConverter](INFO): Powering down. 2024-02-14T01:50:37.821Z,1707875437.821 [CBIT](INFO): Clearing failed state for component DAT 2024-02-14T01:50:37.821Z,1707875437.821 [DAT] No Fault, FailCount= 8 2024-02-14T01:50:38.119Z,1707875438.119 [DAT](INFO): Powering up 2024-02-14T01:50:38.119Z,1707875438.119 [DAT](DEBUG): Initializing DAT. 2024-02-14T01:50:38.187Z,1707875438.187 [Power24vConverter](INFO): Powering up. 2024-02-14T01:50:48.812Z,1707875448.812 [CommandExec](IMPORTANT): got command get Sonardyne_Nano.chargePercent 2024-02-14T01:50:48.813Z,1707875448.813 [CommandExec](IMPORTANT): Sonardyne_Nano.chargePercent 82.000000 % 2024-02-14T01:50:50.231Z,1707875450.231 [DAT](INFO): DAT read: 2024-02-14T01:50:50.233Z,1707875450.233 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2024-02-14T01:50:51.744Z,1707875451.744 [DAT](INFO): DAT read: MF Frequency Band 2024-02-14T01:50:51.745Z,1707875451.745 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2024-02-14T01:50:51.745Z,1707875451.745 [DAT](INFO): DAT read: Feb 14 2024 01:50:46 2024-02-14T01:50:52.752Z,1707875452.752 [DAT](INFO): DAT read: Features enabled [Bearing] 2024-02-14T01:50:52.753Z,1707875452.753 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 2024-02-14T01:50:52.753Z,1707875452.753 [DAT](INFO): commRate: 800 2024-02-14T01:50:54.819Z,1707875454.819 [DAT](INFO): entering command mode 2024-02-14T01:50:55.019Z,1707875455.019 [DAT](INFO): DAT read: 2024-02-14T01:50:55.020Z,1707875455.020 [DAT](INFO): DAT read: user:1> 2024-02-14T01:50:55.020Z,1707875455.020 [DAT](INFO): setting verbose to 3 2024-02-14T01:50:55.272Z,1707875455.272 [DAT](INFO): DAT read: user:1> 2024-02-14T01:50:55.273Z,1707875455.273 [DAT](INFO): DAT read: Verbose | 3 2024-02-14T01:50:55.273Z,1707875455.273 [DAT](INFO): set verbose to 3 2024-02-14T01:50:55.273Z,1707875455.273 [DAT](INFO): setting DatVerbose to 27440 2024-02-14T01:50:55.523Z,1707875455.523 [DAT](INFO): DAT read: user:2> 2024-02-14T01:50:55.524Z,1707875455.524 [DAT](INFO): DAT read: DatVerbose | 27440 2024-02-14T01:50:55.525Z,1707875455.525 [DAT](INFO): set DatVerbose to 27440 2024-02-14T01:50:55.525Z,1707875455.525 [DAT](INFO): setting transmit power to 8 2024-02-14T01:50:55.776Z,1707875455.776 [DAT](INFO): DAT read: user:3> 2024-02-14T01:50:55.777Z,1707875455.777 [DAT](INFO): DAT read: TxPower | 8 (Max) 2024-02-14T01:50:55.777Z,1707875455.777 [DAT](INFO): set transmit power to 8 2024-02-14T01:50:55.777Z,1707875455.777 [DAT](INFO): setting local address to 1 2024-02-14T01:50:56.027Z,1707875456.027 [DAT](INFO): DAT read: user:4> 2024-02-14T01:50:56.028Z,1707875456.028 [DAT](INFO): DAT read: LocalAddr | 1 2024-02-14T01:50:56.029Z,1707875456.029 [DAT](INFO): set local address to 1 2024-02-14T01:50:56.030Z,1707875456.030 [DAT](INFO): Setting time to: 1:50:56 And date to:2/14/2024 2024-02-14T01:50:56.280Z,1707875456.280 [DAT](INFO): DAT read: user:5> 2024-02-14T01:50:56.281Z,1707875456.281 [DAT](INFO): DAT read: Wed Feb 14, 2024 01:50:56 2024-02-14T01:50:56.281Z,1707875456.281 [DAT](INFO): Local DAT time set to Wed Feb 14, 2024 01:50:56 2024-02-14T01:52:16.757Z,1707875536.757 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2024-02-14T01:52:16.757Z,1707875536.757 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-02-14T01:52:16.758Z,1707875536.758 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 5 2024-02-14T01:52:16.758Z,1707875536.758 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-02-14T01:52:16.761Z,1707875536.761 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 5 2024-02-14T01:52:16.761Z,1707875536.761 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-02-14T01:52:16.762Z,1707875536.762 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-02-14T01:52:16.762Z,1707875536.762 [Default:CheckIn:C.Wait] Stopped 2024-02-14T01:52:16.762Z,1707875536.762 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-02-14T01:52:16.762Z,1707875536.762 [Default:CheckIn:D] Running Loop=1 2024-02-14T01:52:16.771Z,1707875536.771 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-02-14T01:52:16.772Z,1707875536.772 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-02-14T01:52:16.772Z,1707875536.772 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-02-14T01:52:17.157Z,1707875537.157 [Default:CheckIn:D] Stopped 2024-02-14T01:52:17.157Z,1707875537.157 [Default:CheckIn:E] Running Loop=1 2024-02-14T01:52:17.186Z,1707875537.186 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-02-14T01:52:17.186Z,1707875537.186 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2024-02-14T01:52:17.187Z,1707875537.187 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-02-14T01:52:17.187Z,1707875537.187 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 5 2024-02-14T01:52:17.188Z,1707875537.188 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-02-14T01:52:17.188Z,1707875537.188 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 5 2024-02-14T01:52:17.564Z,1707875537.564 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-02-14T01:52:17.565Z,1707875537.565 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.678969 min 2024-02-14T01:52:17.566Z,1707875537.566 [Default:CheckIn:E] Stopped 2024-02-14T01:52:17.566Z,1707875537.566 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-02-14T01:52:17.566Z,1707875537.566 [Default:CheckIn] Stopped 2024-02-14T01:52:17.566Z,1707875537.566 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-02-14T01:52:17.566Z,1707875537.566 [Default:CheckIn](INFO): Running loop #2 2024-02-14T01:52:17.566Z,1707875537.566 [Default:CheckIn] Running Loop=2 2024-02-14T01:52:17.566Z,1707875537.566 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-02-14T01:52:17.566Z,1707875537.566 [Default:CheckIn:Read_GPS] Running Loop=1 2024-02-14T01:53:56.328Z,1707875636.328 [DAT](INFO): DAT read: user:6>Lowpower 2024-02-14T01:53:56.328Z,1707875636.328 [DAT](DEBUG): Re-entering command mode due to deviceResponse_: user:6>Lowpower 2024-02-14T01:55:17.751Z,1707875717.751 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2024-02-14T01:55:17.751Z,1707875717.751 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-02-14T01:55:17.753Z,1707875717.753 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 6 2024-02-14T01:55:17.753Z,1707875717.753 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-02-14T01:55:17.754Z,1707875717.754 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 6 2024-02-14T01:55:17.754Z,1707875717.754 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-02-14T01:55:17.765Z,1707875717.765 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-02-14T01:55:17.765Z,1707875717.765 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-02-14T01:55:17.766Z,1707875717.766 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-02-14T01:55:18.179Z,1707875718.179 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-02-14T01:55:18.179Z,1707875718.179 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2024-02-14T01:55:18.180Z,1707875718.180 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-02-14T01:55:18.180Z,1707875718.180 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 6 2024-02-14T01:55:18.180Z,1707875718.180 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-02-14T01:55:18.181Z,1707875718.181 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 6 2024-02-14T01:55:18.572Z,1707875718.572 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-02-14T01:57:17.739Z,1707875837.739 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-02-14T01:52:17.6Z 2024-02-14T01:57:17.739Z,1707875837.739 [Default:CheckIn:Read_GPS] Stopped 2024-02-14T01:57:17.739Z,1707875837.739 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-02-14T01:57:25.271Z,1707875845.271 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240214T013702/Courier0007.lzma 2024-02-14T01:57:26.273Z,1707875846.273 [DataOverHttps](INFO): Moved sent file to Logs/20240214T013702/Courier0007.lzma.bak 2024-02-14T01:57:26.273Z,1707875846.273 [DataOverHttps](INFO): SBD MOMSN=19277678 2024-02-14T01:57:41.819Z,1707875861.819 [DataOverHttps](INFO): Sending 297 bytes from file Logs/20240214T013702/Express0008.lzma 2024-02-14T01:57:42.821Z,1707875862.821 [DataOverHttps](INFO): Moved sent file to Logs/20240214T013702/Express0008.lzma.bak 2024-02-14T01:57:42.821Z,1707875862.821 [DataOverHttps](INFO): SBD MOMSN=19277682 2024-02-14T01:57:44.014Z,1707875864.014 [Default:CheckIn:Read_Iridium] Stopped 2024-02-14T01:57:44.015Z,1707875864.015 [Default:CheckIn:C.Wait] Running Loop=1 2024-02-14T01:57:44.015Z,1707875864.015 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-02-14T01:58:18.751Z,1707875898.751 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7 2024-02-14T01:58:18.751Z,1707875898.751 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-02-14T01:58:18.752Z,1707875898.752 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 7 2024-02-14T01:58:18.753Z,1707875898.753 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-02-14T01:58:18.754Z,1707875898.754 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 7 2024-02-14T01:58:18.754Z,1707875898.754 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-02-14T01:58:18.773Z,1707875898.773 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-02-14T01:58:18.773Z,1707875898.773 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-02-14T01:58:18.773Z,1707875898.773 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-02-14T01:58:19.185Z,1707875899.185 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-02-14T01:58:19.185Z,1707875899.185 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7 2024-02-14T01:58:19.186Z,1707875899.186 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-02-14T01:58:19.186Z,1707875899.186 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 7 2024-02-14T01:58:19.186Z,1707875899.186 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-02-14T01:58:19.186Z,1707875899.186 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 7 2024-02-14T01:58:19.560Z,1707875899.560 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-02-14T01:58:37.312Z,1707875917.312 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-02-14T01:58:37.312Z,1707875917.312 [NAL9602] Data Fault, FailCount= 2 2024-02-14T01:58:37.312Z,1707875917.312 [NAL9602](ERROR): Data Fault 2024-02-14T01:58:37.358Z,1707875917.358 [CBIT](ERROR): Data Fault in component: NAL9602 2024-02-14T01:58:37.717Z,1707875917.717 [NAL9602](INFO): Powering down 2024-02-14T01:58:38.585Z,1707875918.585 [CBIT](INFO): Clearing failed state for component NAL9602 2024-02-14T01:58:38.585Z,1707875918.585 [NAL9602] No Fault, FailCount= 2 2024-02-14T01:59:08.017Z,1707875948.017 [NAL9602](INFO): Powering up NAL9602 2024-02-14T01:59:18.920Z,1707875958.920 [NAL9602](INFO): NAL9602 initialized 2024-02-14T02:01:19.746Z,1707876079.746 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8 2024-02-14T02:01:19.746Z,1707876079.746 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-02-14T02:01:19.752Z,1707876079.752 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 8 2024-02-14T02:01:19.752Z,1707876079.752 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-02-14T02:01:19.754Z,1707876079.754 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 8 2024-02-14T02:01:19.754Z,1707876079.754 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-02-14T02:01:19.772Z,1707876079.772 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-02-14T02:01:19.773Z,1707876079.773 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-02-14T02:01:19.773Z,1707876079.773 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-02-14T02:01:20.177Z,1707876080.177 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-02-14T02:01:20.177Z,1707876080.177 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8 2024-02-14T02:01:20.178Z,1707876080.178 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-02-14T02:01:20.178Z,1707876080.178 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 8 2024-02-14T02:01:20.178Z,1707876080.178 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-02-14T02:01:20.178Z,1707876080.178 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 8 2024-02-14T02:01:20.542Z,1707876080.542 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-02-14T02:02:44.570Z,1707876164.570 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-02-14T02:02:44.570Z,1707876164.570 [Default:CheckIn:C.Wait] Stopped 2024-02-14T02:02:44.570Z,1707876164.570 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-02-14T02:02:44.570Z,1707876164.570 [Default:CheckIn:D] Running Loop=1 2024-02-14T02:02:44.981Z,1707876164.981 [Default:CheckIn:D] Stopped 2024-02-14T02:02:44.981Z,1707876164.981 [Default:CheckIn:E] Running Loop=1 2024-02-14T02:02:45.375Z,1707876165.375 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.142710 min 2024-02-14T02:02:45.376Z,1707876165.376 [Default:CheckIn:E] Stopped 2024-02-14T02:02:45.376Z,1707876165.376 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-02-14T02:02:45.376Z,1707876165.376 [Default:CheckIn] Stopped 2024-02-14T02:02:45.376Z,1707876165.376 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-02-14T02:02:45.376Z,1707876165.376 [Default:CheckIn](INFO): Running loop #3 2024-02-14T02:02:45.376Z,1707876165.376 [Default:CheckIn] Running Loop=3 2024-02-14T02:02:45.376Z,1707876165.376 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-02-14T02:02:45.376Z,1707876165.376 [Default:CheckIn:Read_GPS] Running Loop=1 2024-02-14T02:04:20.772Z,1707876260.772 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9 2024-02-14T02:04:20.772Z,1707876260.772 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-02-14T02:04:20.773Z,1707876260.773 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 9 2024-02-14T02:04:20.773Z,1707876260.773 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-02-14T02:04:20.779Z,1707876260.779 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 9 2024-02-14T02:04:20.779Z,1707876260.779 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-02-14T02:04:20.826Z,1707876260.826 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-02-14T02:04:20.826Z,1707876260.826 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-02-14T02:04:20.826Z,1707876260.826 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-02-14T02:04:21.180Z,1707876261.180 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-02-14T02:04:21.180Z,1707876261.180 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9 2024-02-14T02:04:21.180Z,1707876261.180 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-02-14T02:04:21.180Z,1707876261.180 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 9 2024-02-14T02:04:21.181Z,1707876261.181 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-02-14T02:04:21.181Z,1707876261.181 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 9 2024-02-14T02:04:21.544Z,1707876261.544 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-02-14T02:07:21.731Z,1707876441.731 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10 2024-02-14T02:07:21.731Z,1707876441.731 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-02-14T02:07:21.733Z,1707876441.733 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 10 2024-02-14T02:07:21.733Z,1707876441.733 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-02-14T02:07:21.734Z,1707876441.734 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 10 2024-02-14T02:07:21.734Z,1707876441.734 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-02-14T02:07:21.745Z,1707876441.745 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-02-14T02:07:21.745Z,1707876441.745 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-02-14T02:07:21.745Z,1707876441.745 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-02-14T02:07:22.158Z,1707876442.158 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-02-14T02:07:22.158Z,1707876442.158 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10 2024-02-14T02:07:22.158Z,1707876442.158 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-02-14T02:07:22.158Z,1707876442.158 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 10 2024-02-14T02:07:22.159Z,1707876442.159 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-02-14T02:07:22.159Z,1707876442.159 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 10 2024-02-14T02:07:22.534Z,1707876442.534 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-02-14T02:07:45.603Z,1707876465.603 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-02-14T02:02:45.4Z 2024-02-14T02:07:45.603Z,1707876465.603 [Default:CheckIn:Read_GPS] Stopped 2024-02-14T02:07:45.603Z,1707876465.603 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-02-14T02:07:52.718Z,1707876472.718 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240214T013702/Courier0010.lzma 2024-02-14T02:07:53.721Z,1707876473.721 [DataOverHttps](INFO): Moved sent file to Logs/20240214T013702/Courier0010.lzma.bak 2024-02-14T02:07:53.721Z,1707876473.721 [DataOverHttps](INFO): SBD MOMSN=19277695 2024-02-14T02:08:09.243Z,1707876489.243 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20240214T013702/Express0011.lzma 2024-02-14T02:08:10.245Z,1707876490.245 [DataOverHttps](INFO): Moved sent file to Logs/20240214T013702/Express0011.lzma.bak 2024-02-14T02:08:10.245Z,1707876490.245 [DataOverHttps](INFO): SBD MOMSN=19277699 2024-02-14T02:08:11.422Z,1707876491.422 [Default:CheckIn:Read_Iridium] Stopped 2024-02-14T02:08:11.435Z,1707876491.435 [Default:CheckIn:C.Wait] Running Loop=1 2024-02-14T02:08:11.435Z,1707876491.435 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-02-14T02:08:23.844Z,1707876503.844 [CommandExec](IMPORTANT): got command quit 2024-02-14T02:08:24.847Z,1707876504.847 [Supervisor](INFO): Stop Mission called by Supervisor::terminate 2024-02-14T02:08:24.854Z,1707876504.854 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-02-14T02:08:24.854Z,1707876504.854 [CommandExec](INFO): Uninitializing the command executive. 2024-02-14T02:08:24.854Z,1707876504.854 [CommandExec](INFO): Uninitializing the command scheduler. 2024-02-14T02:08:24.855Z,1707876504.855 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-02-14T02:08:24.995Z,1707876504.995 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-02-14T02:08:24.995Z,1707876504.995 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-02-14T02:08:24.995Z,1707876504.995 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-02-14T02:08:24.996Z,1707876504.996 [NavChartDb](INFO): Join timeout helper Thread ID is 570 2024-02-14T02:08:25.039Z,1707876505.039 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-02-14T02:08:25.039Z,1707876505.039 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-02-14T02:08:25.055Z,1707876505.055 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-02-14T02:08:25.055Z,1707876505.055 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-02-14T02:08:25.055Z,1707876505.055 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 571 2024-02-14T02:08:25.223Z,1707876505.223 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-02-14T02:08:25.223Z,1707876505.223 [WetLabsBB2FL](INFO): Powering down 2024-02-14T02:08:25.224Z,1707876505.224 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-02-14T02:08:25.227Z,1707876505.227 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2024-02-14T02:08:25.227Z,1707876505.227 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-02-14T02:08:25.227Z,1707876505.227 [CTD_Seabird](INFO): Join timeout helper Thread ID is 572 2024-02-14T02:08:25.299Z,1707876505.299 [CTD_Seabird](INFO): Powering down 2024-02-14T02:08:25.311Z,1707876505.311 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2024-02-14T02:08:25.311Z,1707876505.311 [CTD_Seabird](INFO): Powering down 2024-02-14T02:08:25.324Z,1707876505.324 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-02-14T02:08:25.339Z,1707876505.339 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2024-02-14T02:08:25.339Z,1707876505.339 [DAT ThreadHandler](INFO): Thread cancelled. 2024-02-14T02:08:25.339Z,1707876505.339 [DAT](INFO): Join timeout helper Thread ID is 573 2024-02-14T02:08:25.340Z,1707876505.340 [DAT](INFO): Powering down 2024-02-14T02:08:25.414Z,1707876505.414 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2024-02-14T02:08:25.414Z,1707876505.414 [DAT](INFO): Powering down 2024-02-14T02:08:25.415Z,1707876505.415 [DAT ThreadHandler](INFO): Thread cancelled. 2024-02-14T02:08:25.427Z,1707876505.427 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-02-14T02:08:25.427Z,1707876505.427 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-02-14T02:08:25.427Z,1707876505.427 [Radio_Surface](INFO): Join timeout helper Thread ID is 574 2024-02-14T02:08:25.495Z,1707876505.495 [Radio_Surface](INFO): Powering down 2024-02-14T02:08:25.496Z,1707876505.496 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-02-14T02:08:25.496Z,1707876505.496 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-02-14T02:08:25.498Z,1707876505.498 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-02-14T02:08:25.498Z,1707876505.498 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-02-14T02:08:25.498Z,1707876505.498 [Onboard](INFO): Join timeout helper Thread ID is 575 2024-02-14T02:08:25.547Z,1707876505.547 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2024-02-14T02:08:28.999Z,1707876508.999 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-02-14T02:08:28.999Z,1707876508.999 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-02-14T02:08:29.025Z,1707876509.025 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-02-14T02:08:29.025Z,1707876509.025 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-02-14T02:08:29.026Z,1707876509.026 [DataOverHttps](INFO): Join timeout helper Thread ID is 576 2024-02-14T02:08:29.563Z,1707876509.563 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-02-14T02:08:29.563Z,1707876509.563 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-02-14T02:08:29.569Z,1707876509.569 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2024-02-14T02:08:29.569Z,1707876509.569 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-02-14T02:08:29.569Z,1707876509.569 [BackseatComponent](INFO): Join timeout helper Thread ID is 577 2024-02-14T02:08:29.707Z,1707876509.707 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2024-02-14T02:08:29.707Z,1707876509.707 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-02-14T02:08:29.716Z,1707876509.716 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-02-14T02:08:29.716Z,1707876509.716 [logger ThreadHandler](INFO): Thread cancelled. 2024-02-14T02:08:29.716Z,1707876509.716 [logger](INFO): Join timeout helper Thread ID is 578 2024-02-14T02:08:29.739Z,1707876509.739 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-02-14T02:08:29.739Z,1707876509.739 [logger ThreadHandler](INFO): Thread cancelled. 2024-02-14T02:08:29.755Z,1707876509.755 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-02-14T02:08:29.756Z,1707876509.756 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-02-14T02:08:29.756Z,1707876509.756 [CommandLine](INFO): Join timeout helper Thread ID is 579 2024-02-14T02:08:29.775Z,1707876509.775 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-02-14T02:08:29.776Z,1707876509.776 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-02-14T02:08:29.795Z,1707876509.795 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-02-14T02:08:29.796Z,1707876509.796 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-02-14T02:08:29.796Z,1707876509.796 [CommandExec](INFO): Join timeout helper Thread ID is 580 2024-02-14T02:08:29.797Z,1707876509.797 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-02-14T02:08:29.797Z,1707876509.797 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-02-14T02:08:29.798Z,1707876509.798 [controlThread](INFO): Join timeout helper Thread ID is 581 2024-02-14T02:08:29.963Z,1707876509.963 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-02-14T02:08:29.963Z,1707876509.963 [controlThread](DEBUG): Uninitializing ControlThread 2024-02-14T02:08:29.964Z,1707876509.964 [AHRS_M2](INFO): Powering down 2024-02-14T02:08:30.036Z,1707876510.036 [NAL9602](INFO): Powering down 2024-02-14T02:08:30.037Z,1707876510.037 [Sonardyne_Nano](INFO): Powering down 2024-02-14T02:08:30.155Z,1707876510.155 [Waterlinked](INFO): Powering down 2024-02-14T02:08:30.158Z,1707876510.158 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-02-14T02:08:30.158Z,1707876510.158 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-02-14T02:08:30.159Z,1707876510.159 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-02-14T02:08:30.160Z,1707876510.160 [MissionManager](INFO): Uninitializing Mission Default 2024-02-14T02:08:30.160Z,1707876510.160 [Default] Stopped 2024-02-14T02:08:30.160Z,1707876510.160 [Default](DEBUG): Aggregate::uninitialize Default 2024-02-14T02:08:30.160Z,1707876510.160 [Default:B.GoToSurface] Stopped 2024-02-14T02:08:30.160Z,1707876510.160 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-02-14T02:08:30.160Z,1707876510.160 [Default:CheckIn] Stopped 2024-02-14T02:08:30.160Z,1707876510.160 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-02-14T02:08:30.160Z,1707876510.160 [Default:CheckIn:C.Wait] Stopped 2024-02-14T02:08:30.161Z,1707876510.161 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-02-14T02:08:30.164Z,1707876510.164 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-02-14T02:08:30.164Z,1707876510.164 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-02-14T02:08:30.164Z,1707876510.164 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-02-14T02:08:30.164Z,1707876510.164 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-02-14T02:08:30.165Z,1707876510.165 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-02-14T02:08:30.165Z,1707876510.165 [BuoyancyServo](INFO): Powering down 2024-02-14T02:08:30.179Z,1707876510.179 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-02-14T02:08:30.179Z,1707876510.179 [ElevatorServo](INFO): Powering down 2024-02-14T02:08:30.180Z,1707876510.180 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-02-14T02:08:30.180Z,1707876510.180 [MassServo](INFO): Powering down 2024-02-14T02:08:30.181Z,1707876510.181 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-02-14T02:08:30.181Z,1707876510.181 [RudderServo](INFO): Powering down 2024-02-14T02:08:30.182Z,1707876510.182 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2024-02-14T02:08:30.182Z,1707876510.182 [ThrusterHE](INFO): Powering down 2024-02-14T02:08:30.183Z,1707876510.183 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-02-14T02:08:30.183Z,1707876510.183 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-02-14T02:08:30.183Z,1707876510.183 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-02-14T02:08:30.183Z,1707876510.183 [CBIT](DEBUG): Powering off loads. 2024-02-14T02:08:30.195Z,1707876510.195 [CBIT](DEBUG): Disabling WDT. 2024-02-14T02:08:30.207Z,1707876510.207 [CBIT](DEBUG): Opening all GF detection circuits. 2024-02-14T02:08:30.208Z,1707876510.208 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-02-14T02:08:30.236Z,1707876510.236 [DAT ThreadHandler](INFO): Thread cancelled. 2024-02-14T02:08:30.241Z,1707876510.241 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-02-14T02:08:30.243Z,1707876510.243 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-02-14T02:08:30.248Z,1707876510.248 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-02-14T02:08:30.297Z,1707876510.297 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-02-14T02:08:30.382Z,1707876510.382 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-02-14T02:08:30.388Z,1707876510.388 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-02-14T02:08:30.396Z,1707876510.396 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-02-14T02:08:30.444Z,1707876510.444 [logger ThreadHandler](INFO): Thread cancelled.